-- Logs begin at Sun 2025-05-18 22:39:57 EDT, end at Thu 2025-05-22 02:24:43 EDT. -- May 22 02:23:12 pi-volumio volumio[1003]: info: CorePlayQueue::getQueue May 22 02:23:12 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:23:12 pi-volumio volumio[1003]: info: [1747894992662] ControllerPandora::ExpireOldTracks::reaper May 22 02:23:12 pi-volumio volumio[1003]: info: [1747894992662] [Pandora] ExpireOldTracks::reaper: No victims found: Expiring zero tracks. Don't worry -- Jason will return. May 22 02:23:15 pi-volumio volumio[1003]: info: [jellyfin-poller] Polled http://192.168.1.34:8096: offline May 22 02:23:18 pi-volumio volumiologrotate[640]: ls: cannot access '/var/log/samba/log.wb-PI': No such file or directory May 22 02:23:18 pi-volumio volumiologrotate[640]: ls: cannot access 'VOLUMIO': No such file or directory May 22 02:23:28 pi-volumio volumio[1003]: info: [jellyfin-poller] Polled http://192.168.1.61:8096: offline May 22 02:23:45 pi-volumio volumio[1003]: info: [jellyfin-poller] Polled http://192.168.1.34:8096: offline May 22 02:24:01 pi-volumio volumio[1003]: info: [jellyfin-poller] Polled http://192.168.1.61:8096: offline May 22 02:24:09 pi-volumio nmbd[743]: [2025/05/22 02:24:09.250999, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 22 02:24:09 pi-volumio nmbd[743]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.119 for name WORKGROUP<1d>. May 22 02:24:09 pi-volumio nmbd[743]: This response was from IP 192.168.1.33, reporting an IP address of 192.168.1.33. May 22 02:24:10 pi-volumio qobuz-connect[1585]: 20250522 02:24:10.953 [1585.22242] INFO SampleApp: API endpoint invoked: get-connect-info May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.195 [1585.22242] INFO SampleApp: API endpoint invoked: connect-to-qconnect May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.196 [1585.1585] INFO EndpointManager: [0x1582140]: Updating API endpoint May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.196 [1585.1585] INFO EndpointManager: [0x1582140]: Updating QConnect endpoint May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.196 [1585.1585] INFO ActiveStateManager: [0x1581158]: Setting new active state: active May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.196 [1585.1585] INFO PlaybackSessionManager: [0x1582530]: Starting playback session maintenance May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.196 [1585.1585] INFO HttpDownloader: [0x1582720]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.196 [1585.1585] INFO CloudClient: [0x1582da0]: Connecting to the cloud May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.196 [1585.1585] INFO SampleApp: Renderer is now active May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.313 [1585.1585] INFO CloudClient: [0x1582da0]: Connection established May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.313 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Authenticate message May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.314 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Subscribe message May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.314 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending JoinSession message May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.314 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending VolumeChanged message May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.314 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending VolumeMuted message May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.314 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending MaxAudioQualityChanged message May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.314 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetActive message: active May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetState message: May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playing state: Stopped May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playback position: 0 May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Queue version: 1.1 May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Current track: TID: 4294967295, QID: -1, Context UUID: May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Next track: TID: 4294967295, QID: -1, Context UUID: May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO MediaEngine: [0x15827c8]: Stopping playback, clearing tracks May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO MediaEngine: [0x15827c8]: Stopping playback, keeping tracks May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO MediaEngine: [0x15827c8]: Seeking to time offset: 0ms May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetLoopMode message: Off May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO PlaybackControlsManager: [0x1582ba0]: Setting new loop mode: Off May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO MediaEngine: [0x15827c8]: Setting current track: NONE May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetShuffleMode message: disabled May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO PlaybackControlsManager: [0x1582ba0]: Setting new shuffle mode: disabled May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.335 [1585.1585] INFO MediaEngine: [0x15827c8]: Setting next track: NONE May 22 02:24:11 pi-volumio qobuz-connect[1585]: 20250522 02:24:11.553 [1585.1585] INFO PlaybackSessionManager: [0x1582530]: Playback session has been refreshed May 22 02:24:15 pi-volumio volumio[1003]: info: [jellyfin-poller] Polled http://192.168.1.34:8096: offline May 22 02:24:18 pi-volumio volumiologrotate[640]: ls: cannot access '/var/log/samba/log.wb-PI': No such file or directory May 22 02:24:18 pi-volumio volumiologrotate[640]: ls: cannot access 'VOLUMIO': No such file or directory May 22 02:24:22 pi-volumio qobuz-connect[1585]: 20250522 02:24:22.742 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetVolume message, volume: 68 May 22 02:24:22 pi-volumio qobuz-connect[1585]: 20250522 02:24:22.742 [1585.1585] INFO VolumeManager: [0x1582c30]: Setting new playback volume: 68 May 22 02:24:22 pi-volumio qobuz-connect[1585]: 20250522 02:24:22.892 [1585.1585] INFO SampleApp: Playback volume changed: 68 May 22 02:24:22 pi-volumio qobuz-connect[1585]: 20250522 02:24:22.892 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Volume changed: 68 May 22 02:24:22 pi-volumio qobuz-connect[1585]: 20250522 02:24:22.893 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending VolumeChanged message May 22 02:24:22 pi-volumio qobuz-connect[1585]: 20250522 02:24:22.893 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:22 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:22 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:24:23 pi-volumio qobuz-connect[1585]: 20250522 02:24:23.814 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetVolume message, volume: 15 May 22 02:24:23 pi-volumio qobuz-connect[1585]: 20250522 02:24:23.814 [1585.1585] INFO VolumeManager: [0x1582c30]: Setting new playback volume: 15 May 22 02:24:23 pi-volumio qobuz-connect[1585]: 20250522 02:24:23.965 [1585.1585] INFO SampleApp: Playback volume changed: 15 May 22 02:24:23 pi-volumio qobuz-connect[1585]: 20250522 02:24:23.965 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Volume changed: 15 May 22 02:24:23 pi-volumio qobuz-connect[1585]: 20250522 02:24:23.965 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending VolumeChanged message May 22 02:24:23 pi-volumio qobuz-connect[1585]: 20250522 02:24:23.965 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:23 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:23 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetState message: May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playing state: Playing May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playback position: 0 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Queue version: 2.1 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Current track: TID: 335016900, QID: 0, Context UUID: 0c63af72-1709-4d98-8829-6a4ab5564b09 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Next track: TID: 335016901, QID: 1, Context UUID: 0c63af72-1709-4d98-8829-6a4ab5564b09 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO MediaEngine: [0x15827c8]: Stopping playback, clearing tracks May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO MediaEngine: [0x15827c8]: Initiating playback May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO RendererActionAvailabilityManager: [0x1582e58]: Renderer action 'Next' is available May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO MediaEngine: [0x15827c8]: Setting current track: 335016900, initial offset: 0ms May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Clearing all streams May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO AudioStreamManager: [0x15828b0]: New stream: 1 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.997 [1585.1585] INFO HttpDownloader: [0x15bc248]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=9cb04de91968570cbbc7ed37914ca1dd&request_ts=1747895067&track_id=335016900 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.998 [1585.1585] INFO HttpDownloader: [0x1585090]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=335016900 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.998 [1585.1585] INFO HttpDownloader: [0x1588e38]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=109847bcf7275d56cd7b2bf6bac7d480&request_ts=1747895067&track_id=335016900 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.998 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 1]: Running audio stream May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.998 [1585.1585] INFO MediaEngine: [0x15827c8]: Setting next track: 335016901 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.998 [1585.1585] INFO AudioStreamManager: [0x15828b0]: New stream: 2 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.998 [1585.1585] INFO HttpDownloader: [0x15891f8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=7da1c80aaaa261051987c4442186ccb2&request_ts=1747895067&track_id=335016901 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.998 [1585.1585] INFO HttpDownloader: [0x158d998]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=335016901 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.998 [1585.1585] INFO HttpDownloader: [0x165e928]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=efe31a253c0763474060ab69958a15ea&request_ts=1747895067&track_id=335016901 May 22 02:24:27 pi-volumio qobuz-connect[1585]: 20250522 02:24:27.999 [1585.1585] INFO MediaEngine: [0x15827c8]: Waiting for current stream to start before starting audio renderer May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.123 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016900&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898668&hmac=CaPoRY4OLcsEXRhhiyffCiZjpAQ May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.130 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016901&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898668&hmac=b_MFdFZ7yAgYacAe1b2r41mIHIM May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.200 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 2]: Metadata became available: May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.200 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Title: Money for Nothing May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.200 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Artist: Dire Straits May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.200 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album: Brothers in Arms May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.200 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.207 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 1]: Metadata became available: May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.207 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Title: So Far Away May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.207 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Artist: Dire Straits May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.207 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album: Brothers in Arms May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.207 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.313 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 2]: stream information have been fetched May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 1]: stream information have been fetched May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO UrlAudioSource: [0x1588c68]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016900&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898668&hmac=CaPoRY4OLcsEXRhhiyffCiZjpAQ May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO ContentFetcher: [0x1663e38]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016900&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898668&hmac=CaPoRY4OLcsEXRhhiyffCiZjpAQ, offset: 0 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO AudioRenderer: [0x15829e8]: Starting audio renderer, initial playback state: Playing May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO SampleApp: [Stream 1]: New audio stream (starting from 0ms) May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO SampleApp: [Stream 1]: Stream metadata became available: May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO SampleApp: Title: So Far Away May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO SampleApp: Artist: Dire Straits May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO SampleApp: Album: Brothers in Arms May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.326 [1585.1585] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:24:28 pi-volumio volumio[1003]: info: QobuzConnect: setActiveState() May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:24:28 pi-volumio volumio[1003]: info: QobuzConnect: Set Qobuz connect default volume to 22 May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.331 [1585.1585] INFO VolumeManager: [0x1582c30]: Setting new playback volume: 22 May 22 02:24:28 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:24:28 pi-volumio volumio[1003]: info: QobuzConnect: Stopping currently active service May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioStop May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::stop May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService undefined May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService undefined May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CorePlayQueue::getTrack 0 May 22 02:24:28 pi-volumio volumio[1003]: verbose: STATE SERVICE {"status":"stop","service":"qobuzconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"qobuz","codec":"","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false} May 22 02:24:28 pi-volumio volumio[1003]: verbose: CURRENT POSITION 0 May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::syncState stateService stop May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::syncState currentStatus stop May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: No code May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect May 22 02:24:28 pi-volumio volumio[1003]: info: QobuzConnect: setActiveState() completed, send playback confirmation May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.377 [1585.1585] INFO SampleApp: Initiating playback, initial state: Playing May 22 02:24:28 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:28 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:28 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 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 volumioDsp has buffer size 65536 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 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 volumioDsp has buffer size 65536 May 22 02:24:28 pi-volumio volumio[1003]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.ibM45VHb2fWoASdv1NTpKITSE2d2.f98ac801a7f36922807ceb86614bcfa3.state.status' May 22 02:24:28 pi-volumio volumio[1003]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 22 02:24:28 pi-volumio volumio[1003]: info: FusionDsp - ---- read samplerate from file: 44100 May 22 02:24:28 pi-volumio volumio[1003]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.416 [1585.1585] INFO SampleApp: Playback state changed: Playing May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.416 [1585.1585] INFO StreamingEventReporter: [0x1583320]: Reporting streaming started event May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.416 [1585.1585] INFO HttpDownloader: [0x1583378]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.417 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Need to send state update May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.417 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending StateUpdated message May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.417 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.417 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending FileAudioQualityChanged message May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.417 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.417 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending DeviceAudioQualityChanged message May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.417 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.436 [1585.1585] INFO VolumeManager: [0x1582c30]: Setting new playback volume: 22 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.437 [1585.1585] INFO VolumeManager: [0x1582c30]: Setting new mute state: 0 May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.449 [1585.1585] INFO UrlAudioSource: [0x1588c68]: Content info extracted May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.449 [1585.1585] INFO UrlAudioSource: [0x1588c68]: Size: 33789046 May 22 02:24:28 pi-volumio volumio[1003]: info: [LastFM] Current track has sufficient metadata: title (So Far Away) and artist (Dire Straits) passed on explicitly May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.455 [1585.12454] INFO AudioDecoder: [0x17f1068]: Stream info: May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.455 [1585.12454] INFO AudioDecoder: [0x17f1068]: Total samples: 13765080 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.455 [1585.12454] INFO AudioDecoder: [0x17f1068]: Sample rate: 44100 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.455 [1585.12454] INFO AudioDecoder: [0x17f1068]: Channel count: 2 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.455 [1585.12454] INFO AudioDecoder: [0x17f1068]: Bits per sample: 16 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.456 [1585.12454] INFO AudioDecoder: [0x17f1068]: Duration: 312133 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.456 [1585.1585] INFO UrlAudioSource: [0x1588c68]: Audio properties have changed May 22 02:24:28 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:28 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.482 [1585.1585] INFO SampleApp: Playback volume changed: 22 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.482 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Volume changed: 22 May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.482 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending VolumeChanged message May 22 02:24:28 pi-volumio qobuz-connect[1585]: 20250522 02:24:28.482 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:28 pi-volumio volumio[1003]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: QobuzConnect: Volume received from daemon: 22 May 22 02:24:28 pi-volumio volumio[1003]: info: VolumeController::SetAlsaVolume22 May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:28 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:28 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:28 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:28 pi-volumio volumio[1003]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"So Far Away","mbid":"0854f0dc-fde5-4272-9ab7-a7be136f4449","url":"https://www.last.fm/music/Dire+Straits/_/So+Far+Away","duration":"305000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"464158","playcount":"2268026","artist":{"name":"Dire Straits","mbid":"614e3804-7d34-41ba-857f-811bad7c2b7a","url":"https://www.last.fm/music/Dire+Straits"},"album":{"@":{"position":"1"},"artist":"Dire Straits","title":"Brothers in Arms","mbid":"b1332da9-5751-466f-ad4a-3a2b1eb8ed48","url":"https://www.last.fm/music/Dire+Straits/Brothers+in+Arms","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/b29d29ec4cbe9aab7e75a3db1eb1a49c.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/b29d29ec4cbe9aab7e75a3db1eb1a49c.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/b29d29ec4cbe9aab7e75a3db1eb1a49c.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/b29d29ec4cbe9aab7e75a3db1eb1a49c.png","@":{"size":"extralarge"}}]},"userplaycount":"8","userloved":"0","toptags":{"tag":[{"name":"classic rock","url":"https://www.last.fm/tag/classic+rock"},{"name":"rock","url":"https://www.last.fm/tag/rock"},{"name":"80s","url":"https://www.last.fm/tag/80s"},{"name":"dire straits","url":"https://www.last.fm/tag/dire+straits"},{"name":"guitar","url":"https://www.last.fm/tag/guitar"}]},"wiki":{"published":"25 Jan 2010, 18:38","summary":"\"So Far Away\" is a 1985 rock song by Dire Straits. It appears on the album Brothers in Arms. It became the band's fourth top 20 hit on the Billboard charts, peaking at #19. According to the So Far Away Songfacts, the line, \"I'm tired of making out on the telephone, 'cause you're so far away from me\" hails back to a common element of the 1980s: the phone-sex line. Read more on Last.fm.","content":"\"So Far Away\" is a 1985 rock song by Dire Straits. It appears on the album Brothers in Arms. It became the band's fourth top 20 hit on the Billboard charts, peaking at #19. According to the So Far Away Songfacts, the line, \"I'm tired of making out on the telephone, 'cause you're so far away from me\" hails back to a common element of the 1980s: the phone-sex line. Read more on Last.fm. User-contributed text is available under the Creative Commons By-SA License; additional terms may apply."}}} May 22 02:24:29 pi-volumio qobuz-connect[1585]: 20250522 02:24:29.716 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetState message: May 22 02:24:29 pi-volumio qobuz-connect[1585]: 20250522 02:24:29.716 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playing state: May 22 02:24:29 pi-volumio qobuz-connect[1585]: 20250522 02:24:29.716 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playback position: May 22 02:24:29 pi-volumio qobuz-connect[1585]: 20250522 02:24:29.716 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Queue version: 2.2 May 22 02:24:29 pi-volumio qobuz-connect[1585]: 20250522 02:24:29.716 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Current track: May 22 02:24:29 pi-volumio qobuz-connect[1585]: 20250522 02:24:29.716 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Next track: TID: 335016901, QID: 1, Context UUID: 0c63af72-1709-4d98-8829-6a4ab5564b09 May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetState message: May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playing state: Paused May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playback position: May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Queue version: May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Current track: May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Next track: May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO MediaEngine: [0x15827c8]: Pausing playback May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO AudioRenderer: [0x15829e8]: Pausing audio renderer May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.863 [1585.1585] INFO SampleApp: Pausing playback May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.864 [1585.1585] INFO SampleApp: Playback state changed: Paused May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.864 [1585.1585] INFO StreamingEventReporter: [0x1583320]: Reporting streaming ended event May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.864 [1585.1585] INFO HttpDownloader: [0x1583378]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.864 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Need to send state update May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.864 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending StateUpdated message May 22 02:24:33 pi-volumio qobuz-connect[1585]: 20250522 02:24:33.864 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:33 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:33 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:33 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:33 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:33 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:33 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:33 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:33 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:33 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:33 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:34 pi-volumio volumio[1003]: info: [jellyfin-poller] Polled http://192.168.1.61:8096: offline May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetState message: May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playing state: Playing May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playback position: 0 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Queue version: 3.1 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Current track: TID: 335016901, QID: 1, Context UUID: c09130cf-8afb-41bc-959f-19de0caa0bc2 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Next track: TID: 335016902, QID: 2, Context UUID: c09130cf-8afb-41bc-959f-19de0caa0bc2 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO MediaEngine: [0x15827c8]: Stopping playback, clearing tracks May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO MediaEngine: [0x15827c8]: Initiating playback May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO AudioRenderer: [0x15829e8]: Stopping audio renderer May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO SampleApp: Stopping playback May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Clearing all streams May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 1]: Disposing of audio stream May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.385 [1585.1585] INFO ContentFetcher: [0x1663e38]: Canceling download May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.389 [1585.1585] INFO SampleApp: Playback state changed: Stopped May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.389 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Need to send state update May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.389 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending StateUpdated message May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO SampleApp: [Stream 1]: Audio stream has been disposed of May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO MediaEngine: [0x15827c8]: Setting current track: 335016901, initial offset: 0ms May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Clearing all streams May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO AudioStreamManager: [0x15828b0]: New stream: 3 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO HttpDownloader: [0x15890d8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=bbbcaf122fa4403f8a347c1788f22550&request_ts=1747895080&track_id=335016901 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO HttpDownloader: [0x17fb340]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=335016901 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO HttpDownloader: [0x17f7978]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=31c4883b11a4ae98dce1b90e2a76a4b8&request_ts=1747895080&track_id=335016901 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 3]: Running audio stream May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.390 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.391 [1585.1585] INFO MediaEngine: [0x15827c8]: Setting next track: 335016902 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.391 [1585.1585] INFO AudioStreamManager: [0x15828b0]: New stream: 4 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.391 [1585.1585] INFO HttpDownloader: [0x15b6e80]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=1478f357e2a4488645e2d1fa04bc228f&request_ts=1747895080&track_id=335016902 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.391 [1585.1585] INFO HttpDownloader: [0x17f2b20]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=335016902 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.391 [1585.1585] INFO HttpDownloader: [0x16fb6f0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=00729fb48d13b24c8d7579964d100aab&request_ts=1747895080&track_id=335016902 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.392 [1585.1585] INFO MediaEngine: [0x15827c8]: Waiting for current stream to start before starting audio renderer May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:40 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:40 pi-volumio volumio[1003]: info: camilladsp spawned new process with pid 12487, instance 1, run: true May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.487 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 3]: Metadata became available: May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.487 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Title: Money for Nothing May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.487 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Artist: Dire Straits May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.487 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album: Brothers in Arms May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.487 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.541 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016902&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898680&hmac=387pJhQmDTbs_dN-B9_GmvTwMmk May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.543 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016901&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898680&hmac=lsOuomwtJrrfzSWbSsDqi4r0R9U May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.616 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 4]: Metadata became available: May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.616 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Title: Walk of Life May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.616 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Artist: Dire Straits May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.616 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album: Brothers in Arms May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.616 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.685 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 4]: stream information have been fetched May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.718 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 3]: stream information have been fetched May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.718 [1585.1585] INFO UrlAudioSource: [0x17f0a90]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016901&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898680&hmac=lsOuomwtJrrfzSWbSsDqi4r0R9U May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.718 [1585.1585] INFO ContentFetcher: [0x16fb7b0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016901&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898680&hmac=lsOuomwtJrrfzSWbSsDqi4r0R9U, offset: 0 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.718 [1585.1585] INFO AudioRenderer: [0x15829e8]: Starting audio renderer, initial playback state: Playing May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.719 [1585.1585] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms) May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.719 [1585.1585] INFO SampleApp: [Stream 3]: Stream metadata became available: May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.719 [1585.1585] INFO SampleApp: Title: Money for Nothing May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.719 [1585.1585] INFO SampleApp: Artist: Dire Straits May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.719 [1585.1585] INFO SampleApp: Album: Brothers in Arms May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.719 [1585.1585] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: QobuzConnect: alread currrent service, send playback confirmation May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.720 [1585.1585] INFO SampleApp: Initiating playback, initial state: Playing May 22 02:24:40 pi-volumio qobuz-connect[1585]: 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 volumioDsp has buffer size 65536 May 22 02:24:40 pi-volumio qobuz-connect[1585]: 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 volumioDsp has buffer size 65536 May 22 02:24:40 pi-volumio volumio[1003]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 22 02:24:40 pi-volumio volumio[1003]: info: FusionDsp - ---- read samplerate from file: 44100 May 22 02:24:40 pi-volumio volumio[1003]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 22 02:24:40 pi-volumio volumio[1003]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 22 02:24:40 pi-volumio volumio[1003]: info: FusionDsp - ---- read samplerate from file: 44100 May 22 02:24:40 pi-volumio volumio[1003]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.757 [1585.1585] INFO SampleApp: Playback state changed: Playing May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.757 [1585.1585] INFO StreamingEventReporter: [0x1583320]: Reporting streaming started event May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.757 [1585.1585] INFO HttpDownloader: [0x1583378]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.757 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Need to send state update May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.757 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending StateUpdated message May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.768 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.768 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending FileAudioQualityChanged message May 22 02:24:40 pi-volumio qobuz-connect[1585]: 20250522 02:24:40.768 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:40 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:40 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:40 pi-volumio volumio[1003]: info: [LastFM] Current track has sufficient metadata: title (Money for Nothing) and artist (Dire Straits) passed on explicitly May 22 02:24:40 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:40 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:40 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:40 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:40 pi-volumio volumio[1003]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 22 02:24:40 pi-volumio volumio[1003]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 22 02:24:40 pi-volumio volumio[1003]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Money for Nothing","mbid":"e6c7f0d6-2b44-435c-b321-2fb6bff9a555","url":"https://www.last.fm/music/Dire+Straits/_/Money+for+Nothing","duration":"506000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"1038712","playcount":"7046978","artist":{"name":"Dire Straits","mbid":"614e3804-7d34-41ba-857f-811bad7c2b7a","url":"https://www.last.fm/music/Dire+Straits"},"album":{"@":{"position":"2"},"artist":"Dire Straits","title":"Brothers in Arms","mbid":"b1332da9-5751-466f-ad4a-3a2b1eb8ed48","url":"https://www.last.fm/music/Dire+Straits/Brothers+in+Arms","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/b29d29ec4cbe9aab7e75a3db1eb1a49c.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/b29d29ec4cbe9aab7e75a3db1eb1a49c.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/b29d29ec4cbe9aab7e75a3db1eb1a49c.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/b29d29ec4cbe9aab7e75a3db1eb1a49c.png","@":{"size":"extralarge"}}]},"userplaycount":"13","userloved":"0","toptags":{"tag":[{"name":"rock","url":"https://www.last.fm/tag/rock"},{"name":"classic rock","url":"https://www.last.fm/tag/classic+rock"},{"name":"80s","url":"https://www.last.fm/tag/80s"},{"name":"dire straits","url":"https://www.last.fm/tag/dire+straits"},{"name":"guitar","url":"https://www.last.fm/tag/guitar"}]},"wiki":{"published":"03 Sep 2008, 15:34","summary":"\"Money for Nothing\" is a song by British group Dire Straits, which first appeared on their 1985 album Brothers in Arms and subsequently became an international hit when released as a single. It peaked at number one for three weeks in the U.S., becoming their most successful single. In the band's native UK, the song peaked at number 4. According to the Money For Nothing Songfacts, this song is about rock star excess and the easy life it brings compared with real work. Read more on Last.fm.","content":"\"Money for Nothing\" is a song by British group Dire Straits, which first appeared on their 1985 album Brothers in Arms and subsequently became an international hit when released as a single. It peaked at number one for three weeks in the U.S., becoming their most successful single. In the band's native UK, the song peaked at number 4. According to the Money For Nothing Songfacts, this song is about rock star excess and the easy life it brings compared with real work. Mark Knopfler wrote it after overhearing delivery men in a New York department store complain about their jobs while watching MTV. He wrote the song in the store sitting at a kitchen display they had set up. Many of the lyrics were things they actually said. The song was notable for its controversial lyrics, groundbreaking music video and a cameo appearance by Sting singing the song's iconic falsetto introduction and backing chorus, a borrowing of the cable network's slogan \"I want my MTV\".This chorus mirrors The Police intro to \"don't stand so close to me\". The video was also the first to be aired on MTV Europe when the network started on August 1, 1987. Read more on Last.fm. User-contributed text is available under the Creative Commons By-SA License; additional terms may apply."}}} May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.553 [1585.1585] INFO UrlAudioSource: [0x17f0a90]: Content info extracted May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.553 [1585.1585] INFO UrlAudioSource: [0x17f0a90]: Size: 53397499 May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.554 [1585.12498] INFO AudioDecoder: [0x18926c8]: Stream info: May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.554 [1585.12498] INFO AudioDecoder: [0x18926c8]: Total samples: 22332240 May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.554 [1585.12498] INFO AudioDecoder: [0x18926c8]: Sample rate: 44100 May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.554 [1585.12498] INFO AudioDecoder: [0x18926c8]: Channel count: 2 May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.554 [1585.12498] INFO AudioDecoder: [0x18926c8]: Bits per sample: 16 May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.554 [1585.12498] INFO AudioDecoder: [0x18926c8]: Duration: 506400 May 22 02:24:41 pi-volumio qobuz-connect[1585]: 20250522 02:24:41.554 [1585.1585] INFO UrlAudioSource: [0x17f0a90]: Audio properties have changed May 22 02:24:42 pi-volumio qobuz-connect[1585]: 20250522 02:24:42.062 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetState message: May 22 02:24:42 pi-volumio qobuz-connect[1585]: 20250522 02:24:42.062 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playing state: May 22 02:24:42 pi-volumio qobuz-connect[1585]: 20250522 02:24:42.062 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playback position: May 22 02:24:42 pi-volumio qobuz-connect[1585]: 20250522 02:24:42.062 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Queue version: 3.2 May 22 02:24:42 pi-volumio qobuz-connect[1585]: 20250522 02:24:42.062 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Current track: May 22 02:24:42 pi-volumio qobuz-connect[1585]: 20250522 02:24:42.062 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Next track: TID: 335016902, QID: 2, Context UUID: c09130cf-8afb-41bc-959f-19de0caa0bc2 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Received SetState message: May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playing state: Playing May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Playback position: 0 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Queue version: 4.1 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Current track: TID: 335016908, QID: 8, Context UUID: 63e87d50-8e5d-4f81-9e39-5641948b2205 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Next track: TID: 335016909, QID: 9, Context UUID: 63e87d50-8e5d-4f81-9e39-5641948b2205 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO MediaEngine: [0x15827c8]: Stopping playback, clearing tracks May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO MediaEngine: [0x15827c8]: Initiating playback May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO AudioRenderer: [0x15829e8]: Stopping audio renderer May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO SampleApp: Stopping playback May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Clearing all streams May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 3]: Disposing of audio stream May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.050 [1585.1585] INFO ContentFetcher: [0x16fb7b0]: Canceling download May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO SampleApp: Playback state changed: Stopped May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO StreamingEventReporter: [0x1583320]: Reporting streaming ended event May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO HttpDownloader: [0x1583378]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Need to send state update May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending StateUpdated message May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO SampleApp: [Stream 3]: Audio stream has been disposed of May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO MediaEngine: [0x15827c8]: Setting current track: 335016908, initial offset: 0ms May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Clearing all streams May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.054 [1585.1585] INFO AudioStreamManager: [0x15828b0]: New stream: 5 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO HttpDownloader: [0x15bd440]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=2bae78f7a5a3c3f15212be7e6a659e0b&request_ts=1747895083&track_id=335016908 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO HttpDownloader: [0x1587338]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=335016908 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO HttpDownloader: [0x17e4010]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=7516137c84c9fc7156e09c3d64fb40c2&request_ts=1747895083&track_id=335016908 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 5]: Running audio stream May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO MediaEngine: [0x15827c8]: Setting next track: 335016909 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO AudioStreamManager: [0x15828b0]: New stream: 6 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO HttpDownloader: [0x1585090]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=403df79b5084822b43b2da9cf1922d45&request_ts=1747895083&track_id=335016909 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO HttpDownloader: [0x17efbe8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=335016909 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.055 [1585.1585] INFO HttpDownloader: [0x15be248]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=845fcc767f0d0e14110c7ca232ea341a&request_ts=1747895083&track_id=335016909 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.057 [1585.1585] INFO MediaEngine: [0x15827c8]: Waiting for current stream to start before starting audio renderer May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:43 pi-volumio volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.221 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 6]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016909&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898683&hmac=tpyL_XT8jK1bsYkNHwQiVTMCiUo May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.235 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 5]: stream information have been fetched May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.242 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 6]: stream information have been fetched May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.285 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 6]: Metadata became available: May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.285 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Title: Ride Across the River (San Antonio Live In 85) May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.285 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Artist: Dire Straits May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.285 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album: Brothers in Arms (San Antonio Live In 85) May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.285 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.340 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 5]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016908&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898683&hmac=Sd7twBzLp6sFxEEaqM-pb9Lo4qw May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.340 [1585.1585] INFO UrlAudioSource: [0x17a3080]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016908&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898683&hmac=Sd7twBzLp6sFxEEaqM-pb9Lo4qw May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.340 [1585.1585] INFO ContentFetcher: [0x1891100]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4571743&eid=335016908&fmt=6&profile=raw&app_id=174516466&cid=2766869&etsp=1747898683&hmac=Sd7twBzLp6sFxEEaqM-pb9Lo4qw, offset: 0 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.340 [1585.1585] INFO AudioRenderer: [0x15829e8]: Starting audio renderer, initial playback state: Playing May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.340 [1585.1585] INFO SampleApp: [Stream 5]: New audio stream (starting from 0ms) May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: QobuzConnect: alread currrent service, send playback confirmation May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.341 [1585.1585] INFO SampleApp: Initiating playback, initial state: Playing May 22 02:24:43 pi-volumio qobuz-connect[1585]: 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 volumioDsp has buffer size 65536 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 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 volumioDsp has buffer size 65536 May 22 02:24:43 pi-volumio volumio[1003]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 22 02:24:43 pi-volumio volumio[1003]: info: FusionDsp - ---- read samplerate from file: 44100 May 22 02:24:43 pi-volumio volumio[1003]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.348 [1585.1585] INFO SampleApp: Playback state changed: Playing May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.348 [1585.1585] INFO StreamingEventReporter: [0x1583320]: Reporting streaming started event May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.348 [1585.1585] INFO HttpDownloader: [0x1583378]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.348 [1585.1585] INFO ProtocolHandler: [0x1582f08]: Need to send state update May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.348 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending StateUpdated message May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.348 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.349 [1585.1585] INFO QConnectMessageSender: [0x15c2a78]: Sending FileAudioQualityChanged message May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.349 [1585.1585] INFO QwspMessageSender: [0x168d010]: Sending Payload message May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::servicePushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreStateMachine::pushState May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioPushState May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output update for this device May 22 02:24:43 pi-volumio volumio[1003]: info: MRS: Pushing multiroomSync output May 22 02:24:43 pi-volumio volumio[1003]: info: CoreCommandRouter::volumioGetState May 22 02:24:43 pi-volumio volumio[1003]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! May 22 02:24:43 pi-volumio volumio[1003]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 02:24:43 pi-volumio volumio[1003]: TypeError: Cannot read property 'indexOf' of undefined May 22 02:24:43 pi-volumio volumio[1003]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) May 22 02:24:43 pi-volumio volumio[1003]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) May 22 02:24:43 pi-volumio volumio[1003]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) May 22 02:24:43 pi-volumio volumio[1003]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 22 02:24:43 pi-volumio volumio[1003]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) May 22 02:24:43 pi-volumio volumio[1003]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) May 22 02:24:43 pi-volumio volumio[1003]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 22 02:24:43 pi-volumio volumio[1003]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 22 02:24:43 pi-volumio volumio[1003]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) May 22 02:24:43 pi-volumio volumio[1003]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 22 02:24:43 pi-volumio volumio[1003]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) May 22 02:24:43 pi-volumio volumio[1003]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) May 22 02:24:43 pi-volumio volumio[1003]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) May 22 02:24:43 pi-volumio volumio[1003]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 22 02:24:43 pi-volumio volumio[1003]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 22 02:24:43 pi-volumio volumio[1003]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) May 22 02:24:43 pi-volumio volumio[1003]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO AudioStreamManager: [0x15828b0]: [Stream 5]: Metadata became available: May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Title: Brothers in Arms May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Artist: Dire Straits May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album: Brothers in Arms May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO AudioStreamManager: [0x15828b0]: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO SampleApp: [Stream 5]: Stream metadata became available: May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO SampleApp: Title: Brothers in Arms May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO SampleApp: Artist: Dire Straits May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO SampleApp: Album: Brothers in Arms May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.405 [1585.1585] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/yc/7j/dacdjbe2k7jyc_600.jpg May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.422 [1585.1585] INFO UrlAudioSource: [0x17a3080]: Content info extracted May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.422 [1585.1585] INFO UrlAudioSource: [0x17a3080]: Size: 39610305 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.426 [1585.12508] INFO AudioDecoder: [0x1865e88]: Stream info: May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.426 [1585.12508] INFO AudioDecoder: [0x1865e88]: Total samples: 18495540 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.426 [1585.12508] INFO AudioDecoder: [0x1865e88]: Sample rate: 44100 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.426 [1585.12508] INFO AudioDecoder: [0x1865e88]: Channel count: 2 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.426 [1585.12508] INFO AudioDecoder: [0x1865e88]: Bits per sample: 16 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.426 [1585.12508] INFO AudioDecoder: [0x1865e88]: Duration: 419400 May 22 02:24:43 pi-volumio qobuz-connect[1585]: 20250522 02:24:43.427 [1585.1585] INFO UrlAudioSource: [0x17a3080]: Audio properties have changed May 22 02:24:43 pi-volumio sudo[12511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 02:23 May 22 02:24:43 pi-volumio sudo[12511]: 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"