-- Logs begin at Thu 2019-02-14 08:12:00 -02, end at Fri 2025-06-06 08:04:21 -03. -- Jun 06 08:03:45 volumio qobuz-connect[2436]: 20250606 08:03:45.323 [2436.2467] INFO SampleApp: API endpoint invoked: get-connect-info Jun 06 08:03:46 volumio qobuz-connect[2436]: 20250606 08:03:46.624 [2436.2467] INFO SampleApp: API endpoint invoked: connect-to-qconnect Jun 06 08:03:46 volumio qobuz-connect[2436]: 20250606 08:03:46.625 [2436.2436] INFO EndpointManager: [0x1bcdbc0]: Updating API endpoint Jun 06 08:03:46 volumio qobuz-connect[2436]: 20250606 08:03:46.625 [2436.2436] INFO EndpointManager: [0x1bcdbc0]: Updating QConnect endpoint Jun 06 08:03:46 volumio qobuz-connect[2436]: 20250606 08:03:46.625 [2436.2436] INFO ActiveStateManager: [0x1bccbd8]: Setting new active state: active Jun 06 08:03:46 volumio qobuz-connect[2436]: 20250606 08:03:46.625 [2436.2436] INFO PlaybackSessionManager: [0x1bcdfb0]: Starting playback session maintenance Jun 06 08:03:46 volumio qobuz-connect[2436]: 20250606 08:03:46.626 [2436.2436] INFO HttpDownloader: [0x1bce1a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start Jun 06 08:03:46 volumio qobuz-connect[2436]: 20250606 08:03:46.626 [2436.2436] INFO CloudClient: [0x1bce820]: Connecting to the cloud Jun 06 08:03:46 volumio qobuz-connect[2436]: 20250606 08:03:46.629 [2436.2436] INFO SampleApp: Renderer is now active Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.340 [2436.2436] INFO CloudClient: [0x1bce820]: Connection established Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.340 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Authenticate message Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.340 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Subscribe message Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.340 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending JoinSession message Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.341 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending VolumeChanged message Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.341 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending VolumeMuted message Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.341 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending MaxAudioQualityChanged message Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.342 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.395 [2436.2436] INFO PlaybackSessionManager: [0x1bcdfb0]: Playback session has been refreshed Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.493 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Received SetActive message: active Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.493 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Received SetState message: Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.493 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Playing state: Paused Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.493 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Playback position: 94000 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.493 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Queue version: 20.2 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.493 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Current track: TID: 4395444, QID: 1, Context UUID: 77ff817f-7a6b-417f-9daa-3c7171c69eb8 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Next track: TID: 4395445, QID: 2, Context UUID: 77ff817f-7a6b-417f-9daa-3c7171c69eb8 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO MediaEngine: [0x1bce248]: Stopping playback, clearing tracks Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO MediaEngine: [0x1bce248]: Initiating playback Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO RendererActionAvailabilityManager: [0x1bce8d8]: Renderer action 'Next' is available Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Received SetLoopMode message: Off Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO PlaybackControlsManager: [0x1bce620]: Setting new loop mode: Off Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO MediaEngine: [0x1bce248]: Setting current track: 4395444, initial offset: 94000ms Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Clearing all streams Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.494 [2436.2436] INFO AudioStreamManager: [0x1bce330]: New stream: 1 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.495 [2436.2436] INFO HttpDownloader: [0x1bd19d8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=c83350fabf8894cb6039e4563ace1220&request_ts=1749207827&track_id=4395444 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.495 [2436.2436] INFO HttpDownloader: [0x1bda328]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=4395444 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.495 [2436.2436] INFO HttpDownloader: [0x1bda418]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=a689f9e46012c4c9704d24eb7c45b1b6&request_ts=1749207827&track_id=4395444 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.495 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 1]: Running audio stream Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.496 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Received SetShuffleMode message: disabled Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.496 [2436.2436] INFO PlaybackControlsManager: [0x1bce620]: Setting new shuffle mode: disabled Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.499 [2436.2436] INFO MediaEngine: [0x1bce248]: Setting next track: 4395445 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.499 [2436.2436] INFO AudioStreamManager: [0x1bce330]: New stream: 2 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.499 [2436.2436] INFO HttpDownloader: [0x1cae328]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=ffa733149bf9b1175a21bfb99029e454&request_ts=1749207827&track_id=4395445 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.500 [2436.2436] INFO HttpDownloader: [0x1cae658]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=4395445 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.500 [2436.2436] INFO HttpDownloader: [0x1cb0718]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=cdf882ae5e3037ae4eb43d6feb728420&request_ts=1749207827&track_id=4395445 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.503 [2436.2436] INFO MediaEngine: [0x1bce248]: Waiting for current stream to start before starting audio renderer Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.766 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4884528&eid=4395444&fmt=6&profile=raw&app_id=174516466&cid=2800179&etsp=1749211427&hmac=QtSA5RL3psNVwSNT_TzfzNaePeQ Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.817 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4884528&eid=4395445&fmt=6&profile=raw&app_id=174516466&cid=2800179&etsp=1749211427&hmac=Ua27jbfaNz4stK6HQ6o8mGozhko Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.823 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 1]: Metadata became available: Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.824 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Title: Find My Baby Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.824 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Artist: Moby Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.824 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Album: Play Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.824 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Album art URL: https://static.qobuz.com/images/covers/59/71/0724347387159_600.jpg Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.837 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 2]: Metadata became available: Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.837 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Title: Porcelain Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.837 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Artist: Moby Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.838 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Album: Play Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.838 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Album art URL: https://static.qobuz.com/images/covers/59/71/0724347387159_600.jpg Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.857 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 1]: stream information have been fetched Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.857 [2436.2436] INFO UrlAudioSource: [0x1ca9890]: Starting URL audio source, initial position: 94000ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4884528&eid=4395444&fmt=6&profile=raw&app_id=174516466&cid=2800179&etsp=1749211427&hmac=QtSA5RL3psNVwSNT_TzfzNaePeQ Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.858 [2436.2436] INFO ContentFetcher: [0x1cae8b8]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4884528&eid=4395444&fmt=6&profile=raw&app_id=174516466&cid=2800179&etsp=1749211427&hmac=QtSA5RL3psNVwSNT_TzfzNaePeQ, offset: 0 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.859 [2436.2436] INFO AudioRenderer: [0x1bce468]: Starting audio renderer, initial playback state: Paused Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.859 [2436.2436] INFO SampleApp: [Stream 1]: New audio stream (starting from 94000ms) Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.859 [2436.2436] INFO SampleApp: [Stream 1]: Stream metadata became available: Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.860 [2436.2436] INFO SampleApp: Title: Find My Baby Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.860 [2436.2436] INFO SampleApp: Artist: Moby Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.860 [2436.2436] INFO SampleApp: Album: Play Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.860 [2436.2436] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/59/71/0724347387159_600.jpg Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:47 volumio volumio[862]: info: CorePlayQueue::getTrack 0 Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:47 volumio volumio[862]: info: CorePlayQueue::getTrack 0 Jun 06 08:03:47 volumio volumio[862]: info: QobuzConnect: setActiveState() Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:47 volumio volumio[862]: info: CorePlayQueue::getTrack 0 Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.881 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 2]: stream information have been fetched Jun 06 08:03:47 volumio qobuz-connect[2436]: 20250606 08:03:47.882 [2436.2436] INFO VolumeManager: [0x1bce6b0]: Setting new playback volume: 46 Jun 06 08:03:47 volumio volumio[862]: info: QobuzConnect: Set Qobuz connect default volume to 46 Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:47 volumio volumio[862]: info: CorePlayQueue::getTrack 0 Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:47 volumio volumio[862]: info: CorePlayQueue::getTrack 0 Jun 06 08:03:47 volumio volumio[862]: info: QobuzConnect: Stopping currently active service Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::volumioStop Jun 06 08:03:47 volumio volumio[862]: info: CoreStateMachine::stop Jun 06 08:03:47 volumio volumio[862]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 06 08:03:47 volumio volumio[862]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::servicePushState Jun 06 08:03:47 volumio volumio[862]: info: CoreStateMachine::pushState Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::volumioPushState Jun 06 08:03:47 volumio volumio[862]: info: MRS: Pushing multiroomSync output update for this device Jun 06 08:03:47 volumio volumio[862]: info: MRS: Pushing multiroomSync output Jun 06 08:03:47 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:47 volumio volumio[862]: info: CorePlayQueue::getTrack 0 Jun 06 08:03:47 volumio volumio[862]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect Jun 06 08:03:47 volumio volumio[862]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Jun 06 08:03:47 volumio volumio[862]: info: QobuzConnect: setActiveState() completed, send playback confirmation Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.087 [2436.2436] INFO SampleApp: Playback volume changed: 46 Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.087 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Volume changed: 46 Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.087 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending VolumeChanged message Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.088 [2436.2436] INFO SampleApp: Initiating playback, initial state: Paused Jun 06 08:03:48 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:48 volumio qobuz-connect[2436]: 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 Jun 06 08:03:48 volumio qobuz-connect[2436]: 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 Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.237 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.238 [2436.2436] INFO SampleApp: Playback state changed: Paused Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.239 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Need to send state update Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.239 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending StateUpdated message Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.239 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.239 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending FileAudioQualityChanged message Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.240 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.241 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending DeviceAudioQualityChanged message Jun 06 08:03:48 volumio qobuz-connect[2436]: 20250606 08:03:48.241 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:03:48 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:48 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.347 [2436.2436] INFO UrlAudioSource: [0x1ca9890]: Content info extracted Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.348 [2436.2436] INFO UrlAudioSource: [0x1ca9890]: Size: 26692533 Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.355 [2436.6614] INFO AudioDecoder: [0x1e44cd8]: Stream info: Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.355 [2436.6614] INFO AudioDecoder: [0x1e44cd8]: Total samples: 10580472 Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.355 [2436.6614] INFO AudioDecoder: [0x1e44cd8]: Sample rate: 44100 Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.355 [2436.6614] INFO AudioDecoder: [0x1e44cd8]: Channel count: 2 Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.356 [2436.6614] INFO AudioDecoder: [0x1e44cd8]: Bits per sample: 16 Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.356 [2436.6614] INFO AudioDecoder: [0x1e44cd8]: Duration: 239920 Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.356 [2436.2436] INFO UrlAudioSource: [0x1ca9890]: Audio properties have changed Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.356 [2436.2436] INFO UrlAudioSource: [0x1ca9890]: Seeking input stream to byte offset: 9608671 Jun 06 08:03:49 volumio qobuz-connect[2436]: 20250606 08:03:49.356 [2436.2436] INFO ContentFetcher: [0x1cae8b8]: Adjusting download offset to: 9608671 Jun 06 08:03:51 volumio qobuz-connect[2436]: 20250606 08:03:51.471 [2436.2436] INFO UrlAudioSource: [0x1ca9890]: Seeking input stream to byte offset: 9599448 Jun 06 08:03:51 volumio qobuz-connect[2436]: 20250606 08:03:51.471 [2436.2436] INFO ContentFetcher: [0x1cae8b8]: Adjusting download offset to: 9599448 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.500 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Received SetState message: Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.500 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Playing state: Playing Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.501 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Playback position: 0 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.501 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Queue version: 21.1 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.501 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Current track: TID: 117936281, QID: 0, Context UUID: 271fbb20-ce8b-4d44-a26a-886e22788591 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.501 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Next track: TID: 117936282, QID: 1, Context UUID: 271fbb20-ce8b-4d44-a26a-886e22788591 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.501 [2436.2436] INFO MediaEngine: [0x1bce248]: Stopping playback, clearing tracks Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.501 [2436.2436] INFO MediaEngine: [0x1bce248]: Initiating playback Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.501 [2436.2436] INFO AudioRenderer: [0x1bce468]: Stopping audio renderer Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.501 [2436.2436] INFO SampleApp: Stopping playback Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.503 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Clearing all streams Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.503 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 1]: Disposing of audio stream Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.503 [2436.2436] INFO ContentFetcher: [0x1cae8b8]: Canceling download Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.519 [2436.2436] INFO SampleApp: Playback state changed: Stopped Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.519 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Need to send state update Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.520 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending StateUpdated message Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.520 [2436.2436] INFO SampleApp: [Stream 1]: Audio stream has been disposed of Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.520 [2436.2436] INFO MediaEngine: [0x1bce248]: Setting current track: 117936281, initial offset: 0ms Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.520 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Clearing all streams Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.520 [2436.2436] INFO AudioStreamManager: [0x1bce330]: New stream: 3 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.521 [2436.2436] INFO HttpDownloader: [0x1bda080]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=429ef901501c98c4bff615469d893257&request_ts=1749207858&track_id=117936281 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.521 [2436.2436] INFO HttpDownloader: [0x1bd2bf8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=117936281 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.521 [2436.2436] INFO HttpDownloader: [0x1dceb68]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=1b564a8a7276072e18884efa46e3ecfc&request_ts=1749207858&track_id=117936281 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.522 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 3]: Running audio stream Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.522 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.527 [2436.2436] INFO MediaEngine: [0x1bce248]: Setting next track: 117936282 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.527 [2436.2436] INFO AudioStreamManager: [0x1bce330]: New stream: 4 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.527 [2436.2436] INFO HttpDownloader: [0x1d306d0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=8f3a22f2348ec3181bac2c97142d36d3&request_ts=1749207858&track_id=117936282 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.528 [2436.2436] INFO HttpDownloader: [0x1e34c68]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=117936282 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.528 [2436.2436] INFO HttpDownloader: [0x1bc42b8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=3b0bbbb27e0095f2b758b3e2eba67fb8&request_ts=1749207858&track_id=117936282 Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.532 [2436.2436] INFO MediaEngine: [0x1bce248]: Waiting for current stream to start before starting audio renderer Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.792 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4884528&eid=117936281&fmt=27&profile=raw&app_id=174516466&cid=2800179&etsp=1749211458&hmac=XRXgWXsGXHRmgRnuiKVUVMMub1s Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.816 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4884528&eid=117936282&fmt=27&profile=raw&app_id=174516466&cid=2800179&etsp=1749211458&hmac=poBNd8WrH4tJ-cn5Hb7RoYpQ7I8 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.845 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 4]: Metadata became available: Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.845 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Title: Black Napkins Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.845 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Artist: Frank Zappa Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.845 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Album: Zoot Allures Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.845 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Album art URL: https://static.qobuz.com/images/covers/6a/uo/oudcxm9hyuo6a_600.jpg Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.865 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 3]: stream information have been fetched Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.865 [2436.2436] INFO UrlAudioSource: [0x1dac848]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4884528&eid=117936281&fmt=27&profile=raw&app_id=174516466&cid=2800179&etsp=1749211458&hmac=XRXgWXsGXHRmgRnuiKVUVMMub1s Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.865 [2436.2436] INFO ContentFetcher: [0x1bd94f8]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4884528&eid=117936281&fmt=27&profile=raw&app_id=174516466&cid=2800179&etsp=1749211458&hmac=XRXgWXsGXHRmgRnuiKVUVMMub1s, offset: 0 Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.867 [2436.2436] INFO AudioRenderer: [0x1bce468]: Starting audio renderer, initial playback state: Playing Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.867 [2436.2436] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms) Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:18 volumio volumio[862]: info: QobuzConnect: setActiveState() Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:18 volumio qobuz-connect[2436]: 20250606 08:04:18.873 [2436.2436] INFO VolumeManager: [0x1bce6b0]: Setting new playback volume: 46 Jun 06 08:04:18 volumio volumio[862]: info: QobuzConnect: Set Qobuz connect default volume to 46 Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:18 volumio volumio[862]: info: QobuzConnect: Stopping currently active service Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::volumioStop Jun 06 08:04:18 volumio volumio[862]: info: CoreStateMachine::stop Jun 06 08:04:18 volumio volumio[862]: info: CoreStateMachine::serviceStop Jun 06 08:04:18 volumio volumio[862]: info: Received STOP, but no service to execute it Jun 06 08:04:18 volumio volumio[862]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::servicePushState Jun 06 08:04:18 volumio volumio[862]: info: CoreStateMachine::pushState Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::volumioPushState Jun 06 08:04:18 volumio volumio[862]: info: MRS: Pushing multiroomSync output update for this device Jun 06 08:04:18 volumio volumio[862]: info: MRS: Pushing multiroomSync output Jun 06 08:04:18 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:18 volumio volumio[862]: info: CorePlayQueue::getTrack 0 Jun 06 08:04:18 volumio volumio[862]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect Jun 06 08:04:18 volumio volumio[862]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Jun 06 08:04:18 volumio volumio[862]: info: QobuzConnect: setActiveState() completed, send playback confirmation Jun 06 08:04:18 volumio volumio[862]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.2fUiR7QiRXgyEbmJgdrOOq4yFmu1.9ccd4fb6672625ff00da074872019019.state.status' Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.057 [2436.2436] INFO SampleApp: Initiating playback, initial state: Playing Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.059 [2436.2436] WARNING SampleApp: Requested ALSA PCM's sample rate to be set to 192000, got 48000 instead Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.119 [2436.2436] INFO SampleApp: Playback state changed: Playing Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.120 [2436.2436] INFO StreamingEventReporter: [0x1bceda0]: Reporting streaming started event Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.120 [2436.2436] INFO HttpDownloader: [0x1bcedf8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.121 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Need to send state update Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.121 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending StateUpdated message Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.121 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.124 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending FileAudioQualityChanged message Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.125 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.125 [2436.2436] INFO QConnectMessageSender: [0x1c0e388]: Sending DeviceAudioQualityChanged message Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::servicePushState Jun 06 08:04:19 volumio volumio[862]: info: CoreStateMachine::pushState Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.127 [2436.2436] INFO QwspMessageSender: [0x1cd88f0]: Sending Payload message Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.128 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 3]: Metadata became available: Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.128 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Title: Wind Up Workin' In A Gas Station Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.128 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Artist: Frank Zappa Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.128 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Album: Zoot Allures Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.128 [2436.2436] INFO AudioStreamManager: [0x1bce330]: Album art URL: https://static.qobuz.com/images/covers/6a/uo/oudcxm9hyuo6a_600.jpg Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.128 [2436.2436] INFO AudioStreamManager: [0x1bce330]: [Stream 4]: stream information have been fetched Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.129 [2436.2436] INFO SampleApp: [Stream 3]: Stream metadata became available: Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.129 [2436.2436] INFO SampleApp: Title: Wind Up Workin' In A Gas Station Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.129 [2436.2436] INFO SampleApp: Artist: Frank Zappa Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.129 [2436.2436] INFO SampleApp: Album: Zoot Allures Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.129 [2436.2436] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/6a/uo/oudcxm9hyuo6a_600.jpg Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioPushState Jun 06 08:04:19 volumio volumio[862]: info: MRS: Pushing multiroomSync output update for this device Jun 06 08:04:19 volumio volumio[862]: info: MRS: Pushing multiroomSync output Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.163 [2436.2436] INFO VolumeManager: [0x1bce6b0]: Setting new playback volume: 46 Jun 06 08:04:19 volumio qobuz-connect[2436]: 20250606 08:04:19.165 [2436.2436] INFO VolumeManager: [0x1bce6b0]: Setting new mute state: 0 Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::servicePushState Jun 06 08:04:19 volumio volumio[862]: info: CoreStateMachine::pushState Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioPushState Jun 06 08:04:19 volumio volumio[862]: info: MRS: Pushing multiroomSync output update for this device Jun 06 08:04:19 volumio volumio[862]: info: MRS: Pushing multiroomSync output Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::servicePushState Jun 06 08:04:19 volumio volumio[862]: info: CoreStateMachine::pushState Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioPushState Jun 06 08:04:19 volumio volumio[862]: info: MRS: Pushing multiroomSync output update for this device Jun 06 08:04:19 volumio volumio[862]: info: MRS: Pushing multiroomSync output Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::servicePushState Jun 06 08:04:19 volumio volumio[862]: info: CoreStateMachine::pushState Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioPushState Jun 06 08:04:19 volumio volumio[862]: info: MRS: Pushing multiroomSync output update for this device Jun 06 08:04:19 volumio volumio[862]: info: MRS: Pushing multiroomSync output Jun 06 08:04:19 volumio volumio[862]: info: CoreCommandRouter::volumioGetState Jun 06 08:04:19 volumio volumio[862]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Jun 06 08:04:19 volumio volumio[862]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 06 08:04:19 volumio volumio[862]: TypeError: Cannot read property 'indexOf' of undefined Jun 06 08:04:19 volumio volumio[862]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Jun 06 08:04:19 volumio volumio[862]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Jun 06 08:04:19 volumio volumio[862]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Jun 06 08:04:19 volumio volumio[862]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 06 08:04:19 volumio volumio[862]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Jun 06 08:04:19 volumio volumio[862]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Jun 06 08:04:19 volumio volumio[862]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 06 08:04:19 volumio volumio[862]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 06 08:04:19 volumio volumio[862]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Jun 06 08:04:19 volumio volumio[862]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 06 08:04:19 volumio volumio[862]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Jun 06 08:04:19 volumio volumio[862]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Jun 06 08:04:19 volumio volumio[862]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Jun 06 08:04:19 volumio volumio[862]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 06 08:04:19 volumio volumio[862]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 06 08:04:19 volumio volumio[862]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Jun 06 08:04:19 volumio volumio[862]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.068 [2436.2436] INFO UrlAudioSource: [0x1dac848]: Content info extracted Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.069 [2436.2436] INFO UrlAudioSource: [0x1dac848]: Size: 133492767 Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.078 [2436.6710] INFO AudioDecoder: [0x1e14630]: Stream info: Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.078 [2436.6710] INFO AudioDecoder: [0x1e14630]: Total samples: 28655544 Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.078 [2436.6710] INFO AudioDecoder: [0x1e14630]: Sample rate: 192000 Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.078 [2436.6710] INFO AudioDecoder: [0x1e14630]: Channel count: 2 Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.078 [2436.6710] INFO AudioDecoder: [0x1e14630]: Bits per sample: 24 Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.078 [2436.6710] INFO AudioDecoder: [0x1e14630]: Duration: 149247 Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.084 [2436.2436] INFO UrlAudioSource: [0x1dac848]: Audio properties have changed Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.623 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Received SetState message: Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.623 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Playing state: Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.623 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Playback position: Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.623 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Queue version: 21.2 Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.623 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Current track: Jun 06 08:04:20 volumio qobuz-connect[2436]: 20250606 08:04:20.623 [2436.2436] INFO ProtocolHandler: [0x1bce988]: Next track: TID: 117936282, QID: 1, Context UUID: 271fbb20-ce8b-4d44-a26a-886e22788591 Jun 06 08:04:21 volumio sudo[6712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-06 08:03 Jun 06 08:04:21 volumio sudo[6712]: 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"