-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-05-31 08:39:22 CEST. -- May 31 08:38:01 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:05 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:09 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:13 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:17 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:25 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:25.772 [1430.1784] INFO SampleApp: API endpoint invoked: get-display-info May 31 08:38:26 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:26.035 [1430.1784] INFO SampleApp: API endpoint invoked: get-connect-info May 31 08:38:26 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.715 [1430.1784] INFO SampleApp: API endpoint invoked: connect-to-qconnect May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.717 [1430.1430] INFO EndpointManager: [0xa2fd30]: Updating API endpoint May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.717 [1430.1430] INFO EndpointManager: [0xa2fd30]: Updating QConnect endpoint May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.717 [1430.1430] INFO ActiveStateManager: [0xa2ed48]: Setting new active state: active May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.717 [1430.1430] INFO PlaybackSessionManager: [0xa30120]: Starting playback session maintenance May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.717 [1430.1430] INFO HttpDownloader: [0xa30310]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.717 [1430.1430] INFO CloudClient: [0xa30990]: Connecting to the cloud May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.717 [1430.1430] INFO SampleApp: Renderer is now active May 31 08:38:29 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.982 [1430.1430] INFO CloudClient: [0xa30990]: Connection established May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.982 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Authenticate message May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.982 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Subscribe message May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.982 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending JoinSession message May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.982 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending VolumeChanged message May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.982 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending VolumeMuted message May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.983 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending MaxAudioQualityChanged message May 31 08:38:29 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:29.983 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.005 [1430.1430] INFO PlaybackSessionManager: [0xa30120]: Playback session has been refreshed May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.088 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Received SetActive message: active May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.088 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Received SetState message: May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.088 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Playing state: Playing May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.088 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Playback position: 9333 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.088 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Queue version: 1.1 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Current track: TID: 318911395, QID: 0, Context UUID: ba82e8e6-1b05-41aa-b036-7a61a934ad7e May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Next track: TID: 318911396, QID: 1, Context UUID: ba82e8e6-1b05-41aa-b036-7a61a934ad7e May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO MediaEngine: [0xa303b8]: Stopping playback, clearing tracks May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO MediaEngine: [0xa303b8]: Initiating playback May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO RendererActionAvailabilityManager: [0xa30a48]: Renderer action 'Next' is available May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Received SetLoopMode message: Off May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO PlaybackControlsManager: [0xa30790]: Setting new loop mode: Off May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO MediaEngine: [0xa303b8]: Setting current track: 318911395, initial offset: 9333ms May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Clearing all streams May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO AudioStreamManager: [0xa304a0]: New stream: 1 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO HttpDownloader: [0xa33d10]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=caf38b902255e09a1f105e43824c4029&request_ts=1748673510&track_id=318911395 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO HttpDownloader: [0xa36850]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=318911395 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO HttpDownloader: [0xa36b08]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=3170f5cab10a191601c483ffae71b84e&request_ts=1748673510&track_id=318911395 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 1]: Running audio stream May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Received SetShuffleMode message: disabled May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO PlaybackControlsManager: [0xa30790]: Setting new shuffle mode: disabled May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO MediaEngine: [0xa303b8]: Setting next track: 318911396 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO AudioStreamManager: [0xa304a0]: New stream: 2 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO HttpDownloader: [0xa36df0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=d2226cca6fc0872436c01bd7986565fd&request_ts=1748673510&track_id=318911396 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.089 [1430.1430] INFO HttpDownloader: [0xa3b568]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=318911396 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.090 [1430.1430] INFO HttpDownloader: [0xa3b8b8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=28c0d30eb4c96ae2af5f50cde83b9722&request_ts=1748673510&track_id=318911396 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.091 [1430.1430] INFO MediaEngine: [0xa303b8]: Waiting for current stream to start before starting audio renderer May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.255 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 1]: Metadata became available: May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.255 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Title: Wesen May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.255 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Artist: Nils Frahm May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.255 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Album: Night May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.255 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Album art URL: https://static.qobuz.com/images/covers/ob/09/sx45a73os09ob_600.jpg May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.255 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=318911396&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1748677110&hmac=JmfqnorPygENMPRLaTcHVj-g280 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.257 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=318911395&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1748677110&hmac=2KUMMY0WdNEz64Hu3F5ziHMvqzM May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 1]: stream information have been fetched May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO UrlAudioSource: [0xbd5880]: Starting URL audio source, initial position: 9333ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=318911395&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1748677110&hmac=2KUMMY0WdNEz64Hu3F5ziHMvqzM May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO ContentFetcher: [0xb0bcf0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=318911395&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1748677110&hmac=2KUMMY0WdNEz64Hu3F5ziHMvqzM, offset: 0 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO AudioRenderer: [0xa305d8]: Starting audio renderer, initial playback state: Playing May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO SampleApp: [Stream 1]: New audio stream (starting from 9333ms) May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO SampleApp: [Stream 1]: Stream metadata became available: May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO SampleApp: Title: Wesen May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO SampleApp: Artist: Nils Frahm May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.270 [1430.1430] INFO SampleApp: Album: Night May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.271 [1430.1430] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/ob/09/sx45a73os09ob_600.jpg May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CorePlayQueue::getTrack 0 May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CorePlayQueue::getTrack 0 May 31 08:38:30 volumio-sovrum volumio[974]: info: QobuzConnect: setActiveState() May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CorePlayQueue::getTrack 0 May 31 08:38:30 volumio-sovrum volumio[974]: info: QobuzConnect: Set Qobuz connect default volume to 30 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.279 [1430.1430] INFO VolumeManager: [0xa30820]: Setting new playback volume: 30 May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CorePlayQueue::getTrack 0 May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CorePlayQueue::getTrack 0 May 31 08:38:30 volumio-sovrum volumio[974]: info: QobuzConnect: Stopping currently active service May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioStop May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreStateMachine::stop May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.294 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 2]: stream information have been fetched May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CorePlayQueue::getTrack 0 May 31 08:38:30 volumio-sovrum volumio[974]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect May 31 08:38:30 volumio-sovrum volumio[974]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.304 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 2]: Metadata became available: May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.304 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Title: Monuments Again May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.304 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Artist: Nils Frahm May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.304 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Album: Night May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.304 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Album art URL: https://static.qobuz.com/images/covers/ob/09/sx45a73os09ob_600.jpg May 31 08:38:30 volumio-sovrum volumio[974]: info: QobuzConnect: setActiveState() completed, send playback confirmation May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.325 [1430.1430] INFO SampleApp: Initiating playback, initial state: Playing May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 65536, but target_pcm volumioOutput has buffer size 32768 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 65536, but target_pcm volumioOutput has buffer size 32768 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.444 [1430.1430] INFO SampleApp: Playback state changed: Playing May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.445 [1430.1430] INFO StreamingEventReporter: [0xa30f10]: Reporting streaming started event May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.445 [1430.1430] INFO HttpDownloader: [0xa30f68]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.445 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Need to send state update May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.445 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending StateUpdated message May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.445 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.446 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending FileAudioQualityChanged message May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.446 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.446 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending DeviceAudioQualityChanged message May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.447 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.447 [1430.1430] INFO SampleApp: Playback volume changed: 30 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.447 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Volume changed: 30 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.447 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending VolumeChanged message May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.447 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.465 [1430.1430] INFO VolumeManager: [0xa30820]: Setting new playback volume: 30 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.466 [1430.1430] INFO VolumeManager: [0xa30820]: Setting new mute state: 0 May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: QobuzConnect: Volume received from daemon: 30 May 31 08:38:30 volumio-sovrum volumio[974]: info: VolumeController::SetAlsaVolume30 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.548 [1430.1430] INFO UrlAudioSource: [0xbd5880]: Content info extracted May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.548 [1430.1430] INFO UrlAudioSource: [0xbd5880]: Size: 82185316 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.548 [1430.1790] INFO AudioDecoder: [0xc0fee0]: Stream info: May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.548 [1430.1790] INFO AudioDecoder: [0xc0fee0]: Total samples: 31347540 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.548 [1430.1790] INFO AudioDecoder: [0xc0fee0]: Sample rate: 96000 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.548 [1430.1790] INFO AudioDecoder: [0xc0fee0]: Channel count: 2 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.549 [1430.1790] INFO AudioDecoder: [0xc0fee0]: Bits per sample: 24 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.549 [1430.1790] INFO AudioDecoder: [0xc0fee0]: Duration: 326536 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.549 [1430.1430] INFO UrlAudioSource: [0xbd5880]: Audio properties have changed May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.549 [1430.1430] INFO UrlAudioSource: [0xbd5880]: Seeking input stream to byte offset: 2025730 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.549 [1430.1430] INFO ContentFetcher: [0xb0bcf0]: Adjusting download offset to: 2025730 May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:30 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:30 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:30 volumio-sovrum volumio[974]: info: [LastFM] Current track has sufficient metadata: title (Wesen) and artist (Nils Frahm) passed on explicitly May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.737 [1430.1430] INFO UrlAudioSource: [0xbd5880]: Seeking input stream to byte offset: 2003863 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.737 [1430.1430] INFO ContentFetcher: [0xb0bcf0]: Adjusting download offset to: 2003863 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.900 [1430.1430] INFO UrlAudioSource: [0xbd5880]: Seeking input stream to byte offset: 1995605 May 31 08:38:30 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:30.900 [1430.1430] INFO ContentFetcher: [0xb0bcf0]: Adjusting download offset to: 1995605 May 31 08:38:30 volumio-sovrum volumio[974]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Wesen","url":"https://www.last.fm/music/Nils+Frahm/_/Wesen","duration":"326000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"3412","playcount":"6525","artist":{"name":"Nils Frahm","mbid":"d03a54bc-6e07-4c04-a8d4-7fbf2bd07a01","url":"https://www.last.fm/music/Nils+Frahm"},"album":{"artist":"Nils Frahm","title":"Night","url":"https://www.last.fm/music/Nils+Frahm/Night","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/bfb67fe2cd640c14a01646869e945aa0.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/bfb67fe2cd640c14a01646869e945aa0.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/bfb67fe2cd640c14a01646869e945aa0.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/bfb67fe2cd640c14a01646869e945aa0.png","@":{"size":"extralarge"}}]},"userplaycount":"0","userloved":"0","toptags":""}} May 31 08:38:33 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:34 volumio-sovrum volumiologrotate[601]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory May 31 08:38:34 volumio-sovrum volumiologrotate[601]: ls: cannot access 'SOVRUM': No such file or directory May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:38 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:38.552 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Received SetVolume message, volume: 60 May 31 08:38:38 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:38.552 [1430.1430] INFO VolumeManager: [0xa30820]: Setting new playback volume: 60 May 31 08:38:38 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:38.702 [1430.1430] INFO SampleApp: Playback volume changed: 60 May 31 08:38:38 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:38.702 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Volume changed: 60 May 31 08:38:38 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:38.702 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending VolumeChanged message May 31 08:38:38 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:38.703 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:38 volumio-sovrum volumio[974]: info: QobuzConnect: Volume received from daemon: 60 May 31 08:38:38 volumio-sovrum volumio[974]: info: VolumeController::SetAlsaVolume60 May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:38 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:38 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:38 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:38.753 [1430.1430] INFO VolumeManager: [0xa30820]: Setting new playback volume: 60 May 31 08:38:38 volumio-sovrum volumio[974]: info: May 31 08:38:38 volumio-sovrum volumio[974]: ---------------------------- MPD announces state update: mixer May 31 08:38:38 volumio-sovrum volumio[974]: info: ControllerMpd::getState May 31 08:38:38 volumio-sovrum volumio[974]: verbose: ControllerMpd::sendMpdCommand status May 31 08:38:38 volumio-sovrum volumio[974]: info: sendMpdCommand status took 3 milliseconds May 31 08:38:38 volumio-sovrum volumio[974]: verbose: ControllerMpd::parseState May 31 08:38:38 volumio-sovrum volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 08:38:38 volumio-sovrum volumio[974]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 08:38:38 volumio-sovrum volumio[974]: verbose: ControllerMpd::parseTrackInfo May 31 08:38:38 volumio-sovrum volumio[974]: info: ControllerMpd::pushState May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:38 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:38 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:38 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:38 volumio-sovrum volumio[974]: info: CorePlayQueue::getTrack 0 May 31 08:38:38 volumio-sovrum volumio[974]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd May 31 08:38:38 volumio-sovrum volumio[974]: info: ------------------------------ 37ms May 31 08:38:40 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:40.444 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Need to send state update May 31 08:38:40 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:40.444 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending StateUpdated message May 31 08:38:40 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:40.445 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:38:40 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:40 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:38:40 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:40 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:38:40 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:40 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:40 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:40 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:41 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:38:50 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:50.444 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Need to send state update May 31 08:38:50 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:50.444 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending StateUpdated message May 31 08:38:50 volumio-sovrum qobuz-connect[1430]: 20250531 08:38:50.445 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:38:50 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:50 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:38:50 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:38:50 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:38:50 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:38:50 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:38:50 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:38:50 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:38:52 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 31 08:39:00 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:00.444 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Need to send state update May 31 08:39:00 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:00.444 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending StateUpdated message May 31 08:39:00 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:00.445 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:39:00 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:00 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:00 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:00 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:39:00 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:00 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:00 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:00 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:01 volumio-sovrum volumio[974]: verbose: New Socket.io Connection to 192.168.68.129 from 192.168.68.113 UA: Mozilla/5.0 (Linux; Android 7.0; SM-T815 Build/NRD90M; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/119.0.6045.193 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetVisibleSources May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 31 08:39:02 volumio-sovrum volumio[974]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 31 08:39:02 volumio-sovrum volumio[974]: info: Received Get System Info May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 08:39:02 volumio-sovrum volumio[974]: info: Discovery: Getting this device information May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:02 volumio-sovrum volumio[974]: info: Listing playlists May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetQueue May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreStateMachine::getQueue May 31 08:39:02 volumio-sovrum volumio[974]: info: CorePlayQueue::getQueue May 31 08:39:02 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 31 08:39:10 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:10.444 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Need to send state update May 31 08:39:10 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:10.444 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending StateUpdated message May 31 08:39:10 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:10.445 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:39:10 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:10 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:10 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:10 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:39:10 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:10 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:10 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:10 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:20 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:20.444 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Need to send state update May 31 08:39:20 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:20.444 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending StateUpdated message May 31 08:39:20 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:20.445 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:39:20 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:20 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:20 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:20 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:39:20 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:20 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:20 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:20 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.578 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Received SetState message: May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.578 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Playing state: Playing May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.578 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Playback position: 0 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.578 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Queue version: 2.1 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.578 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Current track: TID: 104029801, QID: 0, Context UUID: 0d8469a2-7cb2-4b75-a722-3f451b087e8c May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.579 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Next track: TID: 104029802, QID: 1, Context UUID: 0d8469a2-7cb2-4b75-a722-3f451b087e8c May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.579 [1430.1430] INFO MediaEngine: [0xa303b8]: Stopping playback, clearing tracks May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.579 [1430.1430] INFO MediaEngine: [0xa303b8]: Initiating playback May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.579 [1430.1430] INFO AudioRenderer: [0xa305d8]: Stopping audio renderer May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.579 [1430.1430] INFO SampleApp: Stopping playback May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.585 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Clearing all streams May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.586 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 1]: Disposing of audio stream May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.586 [1430.1430] INFO ContentFetcher: [0xb0bcf0]: Canceling download May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.593 [1430.1430] INFO SampleApp: Playback state changed: Stopped May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.593 [1430.1430] INFO StreamingEventReporter: [0xa30f10]: Reporting streaming ended event May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.593 [1430.1430] INFO HttpDownloader: [0xa30f68]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.593 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Need to send state update May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.593 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending StateUpdated message May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.593 [1430.1430] INFO SampleApp: [Stream 1]: Audio stream has been disposed of May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.594 [1430.1430] INFO MediaEngine: [0xa303b8]: Setting current track: 104029801, initial offset: 0ms May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.594 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Clearing all streams May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.594 [1430.1430] INFO AudioStreamManager: [0xa304a0]: New stream: 3 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.594 [1430.1430] INFO HttpDownloader: [0xbd4b98]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=ec092242e604113ab08fc01a5de51551&request_ts=1748673561&track_id=104029801 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.594 [1430.1430] INFO HttpDownloader: [0xbd96c0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=104029801 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.594 [1430.1430] INFO HttpDownloader: [0xb12780]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=d1bb361eeb53fa5708cf7727dc353a4f&request_ts=1748673561&track_id=104029801 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.594 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 3]: Running audio stream May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.594 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.596 [1430.1430] INFO MediaEngine: [0xa303b8]: Setting next track: 104029802 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.596 [1430.1430] INFO AudioStreamManager: [0xa304a0]: New stream: 4 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.596 [1430.1430] INFO HttpDownloader: [0xc2b2c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=de70d88c2b15fc3c82f622205cceb995&request_ts=1748673561&track_id=104029802 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.597 [1430.1430] INFO HttpDownloader: [0xca0d78]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=104029802 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.597 [1430.1430] INFO HttpDownloader: [0xb11f50]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=90cdac40893865d464bcdc45a071b669&request_ts=1748673561&track_id=104029802 May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.598 [1430.1430] INFO MediaEngine: [0xa303b8]: Waiting for current stream to start before starting audio renderer May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.741 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=104029801&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1748677161&hmac=Y8h9ykBQ7HEgaeNS8EpaQsGEANc May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.758 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 3]: stream information have been fetched May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.759 [1430.1430] INFO UrlAudioSource: [0xbd9e00]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=104029801&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1748677161&hmac=Y8h9ykBQ7HEgaeNS8EpaQsGEANc May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.759 [1430.1430] INFO ContentFetcher: [0xc98e28]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=104029801&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1748677161&hmac=Y8h9ykBQ7HEgaeNS8EpaQsGEANc, offset: 0 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.760 [1430.1430] INFO AudioRenderer: [0xa305d8]: Starting audio renderer, initial playback state: Playing May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.760 [1430.1430] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms) May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: QobuzConnect: alread currrent service, send playback confirmation May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.763 [1430.1430] INFO SampleApp: Initiating playback, initial state: Playing May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 65536, but target_pcm volumioOutput has buffer size 32768 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 65536, but target_pcm volumioOutput has buffer size 32768 May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.767 [1430.1430] INFO SampleApp: Playback state changed: Playing May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.767 [1430.1430] INFO StreamingEventReporter: [0xa30f10]: Reporting streaming started event May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.767 [1430.1430] INFO HttpDownloader: [0xa30f68]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.767 [1430.1430] INFO ProtocolHandler: [0xa30af8]: Need to send state update May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.767 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending StateUpdated message May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.767 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.768 [1430.1430] INFO QConnectMessageSender: [0xa704e8]: Sending FileAudioQualityChanged message May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.769 [1430.1430] INFO QwspMessageSender: [0xb3aa98]: Sending Payload message May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.769 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 3]: Metadata became available: May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.769 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Title: Enters May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.769 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Artist: Nils Frahm May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.769 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Album: Tripping with Nils Frahm May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.769 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Album art URL: https://static.qobuz.com/images/covers/lc/3m/etlwoi5k23mlc_600.jpg May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.769 [1430.1430] INFO SampleApp: [Stream 3]: Stream metadata became available: May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.769 [1430.1430] INFO SampleApp: Title: Enters May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.770 [1430.1430] INFO SampleApp: Artist: Nils Frahm May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.770 [1430.1430] INFO SampleApp: Album: Tripping with Nils Frahm May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.770 [1430.1430] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/lc/3m/etlwoi5k23mlc_600.jpg May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::servicePushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreStateMachine::pushState May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioPushState May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output update for this device May 31 08:39:21 volumio-sovrum volumio[974]: info: MRS: Pushing multiroomSync output May 31 08:39:21 volumio-sovrum volumio[974]: info: CoreCommandRouter::volumioGetState May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.881 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=104029802&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1748677161&hmac=mcYh8-oUqMBhBwXA80S2Y1XQlUs May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.881 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 4]: stream information have been fetched May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.881 [1430.1430] INFO AudioStreamManager: [0xa304a0]: [Stream 4]: Metadata became available: May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.881 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Title: Sunson May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.881 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Artist: Nils Frahm May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.881 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Album: Tripping with Nils Frahm May 31 08:39:21 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:21.881 [1430.1430] INFO AudioStreamManager: [0xa304a0]: Album art URL: https://static.qobuz.com/images/covers/lc/3m/etlwoi5k23mlc_600.jpg May 31 08:39:21 volumio-sovrum volumio[974]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! May 31 08:39:21 volumio-sovrum volumio[974]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 08:39:21 volumio-sovrum volumio[974]: TypeError: Cannot read property 'indexOf' of undefined May 31 08:39:21 volumio-sovrum volumio[974]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) May 31 08:39:21 volumio-sovrum volumio[974]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) May 31 08:39:21 volumio-sovrum volumio[974]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) May 31 08:39:21 volumio-sovrum volumio[974]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 31 08:39:21 volumio-sovrum volumio[974]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) May 31 08:39:21 volumio-sovrum volumio[974]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) May 31 08:39:21 volumio-sovrum volumio[974]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 31 08:39:21 volumio-sovrum volumio[974]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 31 08:39:21 volumio-sovrum volumio[974]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) May 31 08:39:21 volumio-sovrum volumio[974]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 31 08:39:21 volumio-sovrum volumio[974]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) May 31 08:39:21 volumio-sovrum volumio[974]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) May 31 08:39:21 volumio-sovrum volumio[974]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) May 31 08:39:21 volumio-sovrum volumio[974]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 31 08:39:21 volumio-sovrum volumio[974]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 31 08:39:21 volumio-sovrum volumio[974]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) May 31 08:39:21 volumio-sovrum volumio[974]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.127 [1430.1430] INFO UrlAudioSource: [0xbd9e00]: Content info extracted May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.128 [1430.1430] INFO UrlAudioSource: [0xbd9e00]: Size: 97454923 May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.128 [1430.1922] INFO AudioDecoder: [0xbac148]: Stream info: May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.129 [1430.1922] INFO AudioDecoder: [0xbac148]: Total samples: 32275686 May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.129 [1430.1922] INFO AudioDecoder: [0xbac148]: Sample rate: 96000 May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.129 [1430.1922] INFO AudioDecoder: [0xbac148]: Channel count: 2 May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.129 [1430.1922] INFO AudioDecoder: [0xbac148]: Bits per sample: 24 May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.129 [1430.1922] INFO AudioDecoder: [0xbac148]: Duration: 336205 May 31 08:39:22 volumio-sovrum qobuz-connect[1430]: 20250531 08:39:22.129 [1430.1430] INFO UrlAudioSource: [0xbd9e00]: Audio properties have changed May 31 08:39:22 volumio-sovrum sudo[1924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-31 08:38 May 31 08:39:22 volumio-sovrum sudo[1924]: 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"