-- Logs begin at Sun 2025-06-08 18:44:33 BST, end at Sun 2025-06-08 18:52:51 BST. -- Jun 08 18:51:09 rivoff qobuz-connect[3631]: 20250608 18:51:09.412 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:51:09 rivoff qobuz-connect[3631]: 20250608 18:51:09.413 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:51:09 rivoff qobuz-connect[3631]: 20250608 18:51:09.413 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:09 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:09 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:09 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:09 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:09 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:19 rivoff qobuz-connect[3631]: 20250608 18:51:19.413 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:51:19 rivoff qobuz-connect[3631]: 20250608 18:51:19.413 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:51:19 rivoff qobuz-connect[3631]: 20250608 18:51:19.413 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:19 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:19 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:19 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:19 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:19 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:29 rivoff qobuz-connect[3631]: 20250608 18:51:29.414 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:51:29 rivoff qobuz-connect[3631]: 20250608 18:51:29.414 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:51:29 rivoff qobuz-connect[3631]: 20250608 18:51:29.414 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:29 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:29 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:29 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:29 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:29 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:31 rivoff volumio[3298]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.166 UA: Mozilla/5.0 (Linux; Android 15; Pixel 6a Build/BP1A.250505.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetVisibleSources Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 08 18:51:31 rivoff volumio[3298]: info: Received Get System Info Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:51:31 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:31 rivoff volumio[3298]: info: Listing playlists Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetQueue Jun 08 18:51:31 rivoff volumio[3298]: info: CoreStateMachine::getQueue Jun 08 18:51:31 rivoff volumio[3298]: info: CorePlayQueue::getQueue Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:51:31 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 18:51:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 08 18:51:31 rivoff volumio[3298]: verbose: New Socket.io Connection to 192.168.1.50:3000 from 192.168.1.166 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jun 08 18:51:31 rivoff volumio[3298]: info: FusionDsp - no preset used Jun 08 18:51:32 rivoff volumio[3298]: info: FusionDsp - undefined Jun 08 18:51:32 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:32 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 08 18:51:32 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 08 18:51:32 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:51:32 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:51:32 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:51:32 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:32 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:51:34 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:34 rivoff volumio[3298]: verbose: New Socket.io Connection to 192.168.1.50:3000 from 192.168.1.166 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Jun 08 18:51:34 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:34 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 08 18:51:34 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 08 18:51:34 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:34 rivoff sudo[4736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 08 18:51:34 rivoff sudo[4736]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:51:34 rivoff sudo[4736]: pam_unix(sudo:session): session closed for user root Jun 08 18:51:34 rivoff sudo[4738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 08 18:51:34 rivoff sudo[4738]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:51:34 rivoff sudo[4738]: pam_unix(sudo:session): session closed for user root Jun 08 18:51:34 rivoff volumio[3298]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.166 UA: Mozilla/5.0 (Linux; Android 15; Pixel 6a Build/BP1A.250505.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 08 18:51:35 rivoff sudo[4744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 08 18:51:35 rivoff sudo[4744]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:51:35 rivoff sudo[4744]: pam_unix(sudo:session): session closed for user root Jun 08 18:51:35 rivoff sudo[4746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 08 18:51:35 rivoff sudo[4746]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:51:35 rivoff sudo[4746]: pam_unix(sudo:session): session closed for user root Jun 08 18:51:35 rivoff volumio[3298]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.166 UA: Mozilla/5.0 (Linux; Android 15; Pixel 6a Build/BP1A.250505.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetVisibleSources Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 08 18:51:35 rivoff volumio[3298]: info: Received Get System Info Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:51:35 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:35 rivoff volumio[3298]: info: Listing playlists Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 18:51:35 rivoff volumio[3298]: info: FusionDsp - no preset used Jun 08 18:51:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 08 18:51:35 rivoff volumio[3298]: info: FusionDsp - undefined Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 08 18:51:37 rivoff volumio[3298]: info: Received Get System Info Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:51:37 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 08 18:51:37 rivoff volumio[3298]: info: Received Get System Info Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:51:37 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:37 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::volumioNext Jun 08 18:51:38 rivoff volumio[3298]: info: CoreStateMachine::next Jun 08 18:51:38 rivoff volumio[3298]: info: QobuzConnect: Received next Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.762 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending RendererAction message Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.763 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.801 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Received SetState message: Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Playing state: Playing Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Playback position: 0 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Queue version: 7.2 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Current track: TID: 323544097, QID: 1, Context UUID: 019cee4c-07f7-4548-b1f1-34686d94b7bb Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Next track: TID: 323544098, QID: 2, Context UUID: 019cee4c-07f7-4548-b1f1-34686d94b7bb Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO MediaEngine: [0xaaf00720]: Stopping playback, clearing tracks Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO MediaEngine: [0xaaf00720]: Initiating playback Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO AudioRenderer: [0xaaf00940]: Stopping audio renderer Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.802 [3631.3631] INFO SampleApp: Stopping playback Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.803 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Clearing all streams Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.803 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 1]: Disposing of audio stream Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.803 [3631.3631] INFO ContentFetcher: [0xaafe0078]: Canceling download Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.803 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 2]: Disposing of audio stream Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.804 [3631.3631] INFO ContentFetcher: [0xab0fb108]: Canceling download Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.804 [3631.3631] INFO SampleApp: Playback state changed: Stopped Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.804 [3631.3631] INFO StreamingEventReporter: [0xaaf01278]: Reporting streaming ended event Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.804 [3631.3631] INFO HttpDownloader: [0xaaf012d0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.804 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO SampleApp: [Stream 1]: Audio stream has been disposed of Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO MediaEngine: [0xaaf00720]: Setting current track: 323544097, initial offset: 0ms Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Clearing all streams Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: New stream: 3 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO HttpDownloader: [0xaafdbb50]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=b5e3ec4a46e12b485ded37c0481d25af&request_ts=1749405098&track_id=323544097 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO HttpDownloader: [0xaaf41d90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=323544097 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO HttpDownloader: [0xaaf050f8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=86095df7cf74ae97c6493a058121143c&request_ts=1749405098&track_id=323544097 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.805 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 3]: Running audio stream Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.806 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.807 [3631.3631] INFO SampleApp: [Stream 2]: Audio stream has been disposed of Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:38 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.807 [3631.3631] INFO MediaEngine: [0xaaf00720]: Setting next track: 323544098 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.807 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: New stream: 4 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.807 [3631.3631] INFO HttpDownloader: [0xab01fa08]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=5ed036b2117bb51ad6b0f618154c5bc9&request_ts=1749405098&track_id=323544098 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.808 [3631.3631] INFO HttpDownloader: [0xab0509e0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=323544098 Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.808 [3631.3631] INFO HttpDownloader: [0xab02ea38]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=3ba076ccef1e64f8469f83847e21522c&request_ts=1749405098&track_id=323544098 Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:51:38 rivoff qobuz-connect[3631]: 20250608 18:51:38.810 [3631.3631] INFO MediaEngine: [0xaaf00720]: Waiting for current stream to start before starting audio renderer Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:38 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:38 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:38 rivoff volumio[3298]: info: MCU Signalled Playback Inactive Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.458 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 3]: Metadata became available: Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.458 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Title: Too High Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.458 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Artist: Alan Sparhawk Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.458 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Album: Alan Sparhawk with Trampled by Turtles Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.458 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Album art URL: https://static.qobuz.com/images/covers/wb/34/sdbnl40y434wb_600.jpg Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.488 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2622226&eid=323544098&fmt=7&profile=raw&app_id=174516466&cid=1819272&etsp=1749408699&hmac=-BtBBr3dtMaSeKduep8ZNmTLdC8 Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.508 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 4]: Metadata became available: Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.508 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Title: Heaven Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.508 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Artist: Alan Sparhawk Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.508 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Album: Alan Sparhawk with Trampled by Turtles Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.508 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Album art URL: https://static.qobuz.com/images/covers/wb/34/sdbnl40y434wb_600.jpg Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.539 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 4]: stream information have been fetched Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.606 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2622226&eid=323544097&fmt=7&profile=raw&app_id=174516466&cid=1819272&etsp=1749408699&hmac=SwGz61D24pWA6NUs5r3BSqTm0Bo Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.884 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 3]: stream information have been fetched Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.884 [3631.3631] INFO UrlAudioSource: [0xaafdd4d0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2622226&eid=323544097&fmt=7&profile=raw&app_id=174516466&cid=1819272&etsp=1749408699&hmac=SwGz61D24pWA6NUs5r3BSqTm0Bo Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.885 [3631.3631] INFO ContentFetcher: [0xab197ab8]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2622226&eid=323544097&fmt=7&profile=raw&app_id=174516466&cid=1819272&etsp=1749408699&hmac=SwGz61D24pWA6NUs5r3BSqTm0Bo, offset: 0 Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.885 [3631.3631] INFO AudioRenderer: [0xaaf00940]: Starting audio renderer, initial playback state: Playing Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.885 [3631.3631] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms) Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.885 [3631.3631] INFO SampleApp: [Stream 3]: Stream metadata became available: Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.886 [3631.3631] INFO SampleApp: Title: Too High Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.886 [3631.3631] INFO SampleApp: Artist: Alan Sparhawk Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.886 [3631.3631] INFO SampleApp: Album: Alan Sparhawk with Trampled by Turtles Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.886 [3631.3631] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/wb/34/sdbnl40y434wb_600.jpg Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:39 rivoff volumio[3298]: info: QobuzConnect: alread currrent service, send playback confirmation Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.891 [3631.3631] INFO SampleApp: Initiating playback, initial state: Playing Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.902 [3631.3631] INFO SampleApp: Playback state changed: Playing Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.903 [3631.3631] INFO StreamingEventReporter: [0xaaf01278]: Reporting streaming started event Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.903 [3631.3631] INFO HttpDownloader: [0xaaf012d0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.903 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.903 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.903 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:39 rivoff volumio[3298]: info: FusionDsp - ---- read samplerate, raw: 96000,S32_LE,2,32 Jun 08 18:51:39 rivoff volumio[3298]: info: FusionDsp - ---- read samplerate from file: 96000 Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.904 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending FileAudioQualityChanged message Jun 08 18:51:39 rivoff qobuz-connect[3631]: 20250608 18:51:39.905 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:39 rivoff volumio[3298]: info: camilladsp service terminated, instance 1 Jun 08 18:51:39 rivoff volumio[3298]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 08 18:51:39 rivoff volumio[3298]: info: camilladsp spawned new process with pid 4815, instance 1, run: true Jun 08 18:51:39 rivoff volumio[3298]: info: camilladsp service started and running in background, instance 1 Jun 08 18:51:39 rivoff volumio[3298]: info: FusionDsp - ---- read samplerate, raw: 96000,S32_LE,2,32 Jun 08 18:51:39 rivoff volumio[3298]: info: FusionDsp - ---- read samplerate from file: 96000 Jun 08 18:51:39 rivoff volumio[3298]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:39 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.073 [3631.3631] INFO UrlAudioSource: [0xaafdd4d0]: Content info extracted Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.073 [3631.3631] INFO UrlAudioSource: [0xaafdd4d0]: Size: 86340444 Jun 08 18:51:40 rivoff volumio[3298]: info: Signalling Playback active due to playback status change Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.075 [3631.4823] INFO AudioDecoder: [0xab5acc60]: Stream info: Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.075 [3631.4823] INFO AudioDecoder: [0xab5acc60]: Total samples: 23654614 Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.075 [3631.4823] INFO AudioDecoder: [0xab5acc60]: Sample rate: 96000 Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.075 [3631.4823] INFO AudioDecoder: [0xab5acc60]: Channel count: 2 Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.075 [3631.4823] INFO AudioDecoder: [0xab5acc60]: Bits per sample: 24 Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.075 [3631.4823] INFO AudioDecoder: [0xab5acc60]: Duration: 246402 Jun 08 18:51:40 rivoff qobuz-connect[3631]: 20250608 18:51:40.075 [3631.3631] INFO UrlAudioSource: [0xaafdd4d0]: Audio properties have changed Jun 08 18:51:40 rivoff volumio[3298]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 08 18:51:40 rivoff volumio[3298]: info: MCU Signalled Playback Active Jun 08 18:51:45 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 08 18:51:49 rivoff qobuz-connect[3631]: 20250608 18:51:49.903 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:51:49 rivoff qobuz-connect[3631]: 20250608 18:51:49.903 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:51:49 rivoff qobuz-connect[3631]: 20250608 18:51:49.903 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:49 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:49 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:49 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:49 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:51:49 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:49 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:53 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 08 18:51:53 rivoff volumio[3298]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 08 18:51:53 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 08 18:51:53 rivoff volumio[3298]: info: Received Get System Version Jun 08 18:51:53 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 08 18:51:53 rivoff volumio[3298]: info: Received Get System Info Jun 08 18:51:53 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:51:53 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:51:53 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:51:53 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:53 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:51:56 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 08 18:51:56 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 08 18:51:56 rivoff volumio[3298]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 18:51:56 rivoff volumio[3298]: info: FusionDsp - no preset used Jun 08 18:51:56 rivoff volumio[3298]: info: FusionDsp - undefined Jun 08 18:51:59 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:51:59 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:51:59 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:51:59 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:51:59 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:51:59 rivoff qobuz-connect[3631]: 20250608 18:51:59.920 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:51:59 rivoff qobuz-connect[3631]: 20250608 18:51:59.920 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:51:59 rivoff qobuz-connect[3631]: 20250608 18:51:59.920 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:51:59 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:01 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:52:01 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:52:01 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:52:01 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:01 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:52:09 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetQueue Jun 08 18:52:09 rivoff volumio[3298]: info: CoreStateMachine::getQueue Jun 08 18:52:09 rivoff volumio[3298]: info: CorePlayQueue::getQueue Jun 08 18:52:09 rivoff qobuz-connect[3631]: 20250608 18:52:09.903 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:52:09 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:09 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:52:09 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:52:09 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:52:09 rivoff qobuz-connect[3631]: 20250608 18:52:09.907 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:52:09 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:52:09 rivoff qobuz-connect[3631]: 20250608 18:52:09.908 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:52:09 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:12 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jun 08 18:52:13 rivoff volumio[3298]: info: handleBrowseUri took 153 milliseconds Jun 08 18:52:13 rivoff volumio[3298]: info: Preload queue cleared Jun 08 18:52:13 rivoff volumio[3298]: info: Preload queue cleared Jun 08 18:52:19 rivoff qobuz-connect[3631]: 20250608 18:52:19.904 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:52:19 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:19 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:52:19 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:52:19 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:52:19 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:52:19 rivoff qobuz-connect[3631]: 20250608 18:52:19.908 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:52:19 rivoff qobuz-connect[3631]: 20250608 18:52:19.909 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:52:19 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:25 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 08 18:52:25 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 08 18:52:29 rivoff qobuz-connect[3631]: 20250608 18:52:29.903 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:52:29 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:29 rivoff volumio[3298]: info: CoreCommandRouter::servicePushState Jun 08 18:52:29 rivoff volumio[3298]: info: CoreStateMachine::pushState Jun 08 18:52:29 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 18:52:29 rivoff volumio[3298]: info: CoreCommandRouter::volumioPushState Jun 08 18:52:29 rivoff qobuz-connect[3631]: 20250608 18:52:29.908 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:52:29 rivoff qobuz-connect[3631]: 20250608 18:52:29.909 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:52:29 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 18:52:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 18:52:31 rivoff volumio[3298]: info: Discovery: Getting this device information Jun 08 18:52:31 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:31 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 18:52:34 rivoff volumio[3298]: info: FusionDsp - Stopping FusionDsp service Jun 08 18:52:34 rivoff volumio[3298]: info: camilladsp stopping service pid 4815... Jun 08 18:52:35 rivoff volumio[3298]: info: camilladsp service terminated, instance 1 Jun 08 18:52:35 rivoff volumio[3298]: info: Disabling plugin fusiondsp Jun 08 18:52:35 rivoff volumio[3298]: info: Preparing to generate the ALSA configuration file Jun 08 18:52:35 rivoff sudo[4923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Jun 08 18:52:35 rivoff sudo[4923]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:35 rivoff systemd[1]: Stopping FusionDsp Daemon... Jun 08 18:52:35 rivoff volumio[3662]: Backend configuration: Jun 08 18:52:35 rivoff volumio[3662]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jun 08 18:52:35 rivoff volumio[3662]: active_config_txt: null Jun 08 18:52:35 rivoff volumio[3662]: camilla_host: 127.0.0.1 Jun 08 18:52:35 rivoff volumio[3662]: camilla_port: 9876 Jun 08 18:52:35 rivoff volumio[3662]: coeff_dir: /data/INTERNAL/FusionDsp/filters Jun 08 18:52:35 rivoff volumio[3662]: config_dir: /data/configuration/audio_interface/fusiondsp Jun 08 18:52:35 rivoff volumio[3662]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jun 08 18:52:35 rivoff volumio[3662]: log_file: /tmp/camilladsp.log Jun 08 18:52:35 rivoff volumio[3662]: on_get_active_config: null Jun 08 18:52:35 rivoff volumio[3662]: on_set_active_config: null Jun 08 18:52:35 rivoff volumio[3662]: port: 5011 Jun 08 18:52:35 rivoff volumio[3662]: supported_capture_types: null Jun 08 18:52:35 rivoff volumio[3662]: supported_playback_types: null Jun 08 18:52:35 rivoff volumio[3662]: update_config_symlink: false Jun 08 18:52:35 rivoff volumio[3662]: update_config_txt: false Jun 08 18:52:35 rivoff volumio[3662]: ======== Running on http://0.0.0.0:5011 ======== Jun 08 18:52:35 rivoff volumio[3662]: (Press CTRL+C to quit) Jun 08 18:52:35 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 08 18:52:35 rivoff volumio[3298]: info: Asound.conf file written Jun 08 18:52:35 rivoff sudo[4927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 08 18:52:35 rivoff sudo[4927]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:35 rivoff sudo[4927]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:35 rivoff kernel: Fine tdm clk setting range (0~2000000), 12287994 Jun 08 18:52:35 rivoff kernel: Err: can not set rate to 4278967296! Jun 08 18:52:35 rivoff kernel: Range[3920000 - 500000000] Jun 08 18:52:35 rivoff kernel: out of value, fixed it Jun 08 18:52:35 rivoff kernel: id=0 set inskew=0 Jun 08 18:52:35 rivoff volumio[3298]: xcb_connection_has_error() returned true Jun 08 18:52:35 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Jun 08 18:52:35 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Jun 08 18:52:35 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Jun 08 18:52:35 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Jun 08 18:52:35 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 41 Validity:0' : Operation not permitted Jun 08 18:52:35 rivoff volumio[3298]: info: Output device has changed, restarting MPD Jun 08 18:52:35 rivoff systemd[1]: fusiondsp.service: Succeeded. Jun 08 18:52:35 rivoff systemd[1]: Stopped FusionDsp Daemon. Jun 08 18:52:35 rivoff sudo[4923]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: setDeactiveState invoked Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: setDeactiveState(): relinquishing Volumio State Jun 08 18:52:35 rivoff volumio[3298]: verbose: UNSET VOLATILE: Service: qobuzconnect Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: onUnsetVolatile() called, relinquishing Volumio State to another service Jun 08 18:52:35 rivoff sudo[4932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 08 18:52:35 rivoff sudo[4932]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.330 [3631.3631] INFO MediaEngine: [0xaaf00720]: Stopping playback, keeping tracks Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.330 [3631.3631] INFO AudioRenderer: [0xaaf00940]: Stopping audio renderer Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.330 [3631.3631] INFO SampleApp: Stopping playback Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.331 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Clearing all streams Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.331 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 3]: Disposing of audio stream Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.332 [3631.3631] INFO ContentFetcher: [0xab197ab8]: Canceling download Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: Received stop Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: Done. Jun 08 18:52:35 rivoff sudo[4932]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.348 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: New stream: 5 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.348 [3631.3631] INFO HttpDownloader: [0xaafdbb50]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=ad45db0fd640762e4aa5d7b0ee1a8b10&request_ts=1749405155&track_id=323544097 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.349 [3631.3631] INFO HttpDownloader: [0xab2f17a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=323544097 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.349 [3631.3631] INFO HttpDownloader: [0xaaf08dd8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=b7eee2fa5c3f2c22fda78f7fb951964c&request_ts=1749405155&track_id=323544097 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.349 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 5]: Running audio stream Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.349 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: New stream: 6 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.349 [3631.3631] INFO HttpDownloader: [0xab191c68]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=c6834fefc4e218614f80aace268cebd6&request_ts=1749405155&track_id=323544098 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.349 [3631.3631] INFO HttpDownloader: [0xab2ebe50]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=323544098 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.350 [3631.3631] INFO HttpDownloader: [0xab0842e8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=64e3f34ac92153a07a5d445975347ef4&request_ts=1749405155&track_id=323544098 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.353 [3631.3631] INFO SampleApp: Playback state changed: Stopped Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.354 [3631.3631] INFO StreamingEventReporter: [0xaaf01278]: Reporting streaming ended event Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.354 [3631.3631] INFO HttpDownloader: [0xaaf012d0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.354 [3631.3631] INFO ProtocolHandler: [0xaaf00e60]: Need to send state update Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.354 [3631.3631] INFO QConnectMessageSender: [0xaaf40788]: Sending StateUpdated message Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.354 [3631.3631] INFO SampleApp: [Stream 3]: Audio stream has been disposed of Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.354 [3631.3631] INFO QwspMessageSender: [0xab00ad18]: Sending Payload message Jun 08 18:52:35 rivoff sudo[4934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 08 18:52:35 rivoff sudo[4934]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:35 rivoff systemd[1]: Stopping Music Player Daemon... Jun 08 18:52:35 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 08 18:52:35 rivoff sudo[4943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 08 18:52:35 rivoff sudo[4943]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: playback_stop received, deferred solved Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:35 rivoff volumio[3298]: info: CorePlayQueue::getTrack 0 Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:35 rivoff volumio[3298]: info: CorePlayQueue::getTrack 0 Jun 08 18:52:35 rivoff volumio[3298]: info: MPD Permissions set Jun 08 18:52:35 rivoff volumio[3298]: info: FusionDsp - Reporting Fusion DSP Disabled Jun 08 18:52:35 rivoff volumio[3298]: info: Removing fusiondspeq DSP Signal Path Element Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff systemd[1]: mpd.service: Succeeded. Jun 08 18:52:35 rivoff systemd[1]: Stopped Music Player Daemon. Jun 08 18:52:35 rivoff systemd[1]: Starting Music Player Daemon... Jun 08 18:52:35 rivoff sudo[4943]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.471 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 6]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2622226&eid=323544098&fmt=7&profile=raw&app_id=174516466&cid=1819272&etsp=1749408755&hmac=MKpo-2QbUMZxl-OEou_ZF448a_Y Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.472 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 6]: Metadata became available: Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.472 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Title: Heaven Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.472 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Artist: Alan Sparhawk Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.472 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Album: Alan Sparhawk with Trampled by Turtles Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.472 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Album art URL: https://static.qobuz.com/images/covers/wb/34/sdbnl40y434wb_600.jpg Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.483 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 5]: Metadata became available: Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.483 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Title: Too High Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.483 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Artist: Alan Sparhawk Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.483 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Album: Alan Sparhawk with Trampled by Turtles Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.483 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: Album art URL: https://static.qobuz.com/images/covers/wb/34/sdbnl40y434wb_600.jpg Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.492 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 6]: stream information have been fetched Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 08 18:52:35 rivoff sudo[4947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 08 18:52:35 rivoff sudo[4947]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.515 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 5]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2622226&eid=323544097&fmt=7&profile=raw&app_id=174516466&cid=1819272&etsp=1749408755&hmac=AZadC-GkBL-zU8HIboh5eyH1yVg Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.515 [3631.3631] INFO UrlAudioSource: [0xab5a5ae8]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2622226&eid=323544097&fmt=7&profile=raw&app_id=174516466&cid=1819272&etsp=1749408755&hmac=AZadC-GkBL-zU8HIboh5eyH1yVg Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.515 [3631.3631] INFO ContentFetcher: [0xab50baa8]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2622226&eid=323544097&fmt=7&profile=raw&app_id=174516466&cid=1819272&etsp=1749408755&hmac=AZadC-GkBL-zU8HIboh5eyH1yVg, offset: 0 Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.516 [3631.3631] INFO AudioStreamManager: [0xaaf00808]: [Stream 5]: stream information have been fetched Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.516 [3631.3631] INFO SampleApp: [Stream 5]: New audio stream (starting from 0ms) Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.517 [3631.3631] INFO SampleApp: [Stream 5]: Stream metadata became available: Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.517 [3631.3631] INFO SampleApp: Title: Too High Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.517 [3631.3631] INFO SampleApp: Artist: Alan Sparhawk Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.517 [3631.3631] INFO SampleApp: Album: Alan Sparhawk with Trampled by Turtles Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.517 [3631.3631] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/wb/34/sdbnl40y434wb_600.jpg Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.534 [3631.3631] INFO ContentFetcher: [0xab50baa8]: Canceling download Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.534 [3631.3631] INFO CloudClient: [0xaaf00cf8]: Disconnecting from the cloud Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.534 [3631.3631] INFO CloudClient: [0xaaf00cf8]: Connection closed Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:35 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 08 18:52:35 rivoff systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 08 18:52:35 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:35 rivoff volumio[3298]: info: CorePlayQueue::getTrack 0 Jun 08 18:52:35 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.602 [3631.3631] INFO SampleApp: Stopping Local configuration server Jun 08 18:52:35 rivoff qobuz-connect[3631]: 20250608 18:52:35.613 [3631.3631] INFO SampleApp: shat down connection on UNIX socket Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: setDeactiveState invoked Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:35 rivoff volumio[3298]: info: CorePlayQueue::getTrack 0 Jun 08 18:52:35 rivoff systemd[1]: qobuz-connect.service: Succeeded. Jun 08 18:52:35 rivoff systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 08 18:52:35 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 08 18:52:35 rivoff systemd[1]: Started Volumio Qobuz Connect Service. Jun 08 18:52:35 rivoff sudo[4947]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:35 rivoff sudo[4945]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 08 18:52:35 rivoff sudo[4945]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:35 rivoff sudo[4945]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:35 rivoff volumio[3298]: info: Executing endpoint qc_getconfig Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.743 [4960.4960] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 08 18:52:35 rivoff volumio[3298]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.750 [4960.4960] INFO VolumeManager: [0xaccd3b88]: Setting new playback volume: 75 Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.750 [4960.4960] INFO VolumeManager: [0xaccd3b88]: Setting new mute state: 0 Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.750 [4960.4960] INFO QobuzConnect: [0xaccd4558]: Client initialized! Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.750 [4960.4960] INFO SampleApp: Starting Avahi advertising, name: Rivoff!, service name: _qobuz-connect._tcp Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.762 [4960.4960] INFO LocalConfigManager: [0xaccd3468]: Starting Local Configuration server Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.762 [4960.4960] INFO SampleApp: Starting Local configuration server Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.762 [4960.4960] INFO SampleApp: Connected to UNIX socket client 0xaccc8ed8 Jun 08 18:52:35 rivoff qobuz-connect[4960]: 20250608 18:52:35.894 [4960.4960] INFO SampleApp: Playback volume changed: 75 Jun 08 18:52:35 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:35 rivoff volumio[3298]: info: CorePlayQueue::getTrack 0 Jun 08 18:52:37 rivoff mpd[4963]: Jun 08 18:52 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 08 18:52:37 rivoff systemd[1]: Started Music Player Daemon. Jun 08 18:52:37 rivoff sudo[4934]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:37 rivoff volumio[3298]: error: updateQueue error: null Jun 08 18:52:50 rivoff volumio[3298]: info: Enabling plugin fusiondsp Jun 08 18:52:50 rivoff volumio[3298]: info: Loading plugin "fusiondsp"... Jun 08 18:52:50 rivoff volumio[3298]: info: Applying required configuration parameters for plugin fusiondsp Jun 08 18:52:50 rivoff volumio[3298]: info: Preparing to generate the ALSA configuration file Jun 08 18:52:50 rivoff volumio[3298]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 08 18:52:50 rivoff volumio[3298]: info: Reading ALSA contributions from plugins. Jun 08 18:52:50 rivoff volumio[3298]: info: Asound.conf file written Jun 08 18:52:50 rivoff sudo[5045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 08 18:52:50 rivoff sudo[5045]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:50 rivoff sudo[5045]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:50 rivoff kernel: Fine tdm clk setting range (0~2000000), 12287994 Jun 08 18:52:50 rivoff kernel: Err: can not set rate to 4274967296! Jun 08 18:52:50 rivoff kernel: Range[3920000 - 500000000] Jun 08 18:52:50 rivoff kernel: out of value, fixed it Jun 08 18:52:50 rivoff kernel: id=0 set inskew=0 Jun 08 18:52:50 rivoff volumio[3298]: xcb_connection_has_error() returned true Jun 08 18:52:50 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Jun 08 18:52:50 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Jun 08 18:52:50 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Jun 08 18:52:50 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Jun 08 18:52:50 rivoff volumio[3298]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 41 Validity:0' : Operation not permitted Jun 08 18:52:50 rivoff volumio[3298]: info: Output device has changed, restarting MPD Jun 08 18:52:50 rivoff volumio[3298]: info: QobuzConnect: setDeactiveState invoked Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::volumioGetState Jun 08 18:52:50 rivoff volumio[3298]: info: CorePlayQueue::getTrack 0 Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff sudo[5050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 08 18:52:50 rivoff volumio[3298]: info: PLUGIN START: fusiondsp Jun 08 18:52:50 rivoff sudo[5050]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:50 rivoff sudo[5050]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:50 rivoff volumio[3298]: info: Loading i18n strings for locale en Jun 08 18:52:50 rivoff sudo[5052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: FusionDsp - mixtype--------------------- Hardware Jun 08 18:52:50 rivoff volumio[3298]: info: Preparing to generate the ALSA configuration file Jun 08 18:52:50 rivoff sudo[5052]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:50 rivoff volumio[3298]: info: Done. Jun 08 18:52:50 rivoff systemd[1]: Stopping Music Player Daemon... Jun 08 18:52:50 rivoff systemd[1]: mpd.service: Succeeded. Jun 08 18:52:50 rivoff systemd[1]: Stopped Music Player Daemon. Jun 08 18:52:50 rivoff volumio[3298]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 08 18:52:50 rivoff systemd[1]: Starting Music Player Daemon... Jun 08 18:52:50 rivoff volumio[3298]: info: Reading ALSA contributions from plugins. Jun 08 18:52:50 rivoff sudo[5059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 08 18:52:50 rivoff sudo[5059]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:50 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 08 18:52:50 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 08 18:52:50 rivoff volumio[3298]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 08 18:52:50 rivoff volumio[3298]: info: MPD Permissions set Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff sudo[5059]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 08 18:52:50 rivoff sudo[5070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 08 18:52:50 rivoff sudo[5070]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:50 rivoff systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 08 18:52:50 rivoff volumio[3298]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 08 18:52:50 rivoff qobuz-connect[4960]: 20250608 18:52:50.685 [4960.4960] INFO SampleApp: Stopping Local configuration server Jun 08 18:52:50 rivoff volumio[3298]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 18:52:50 rivoff qobuz-connect[4960]: 20250608 18:52:50.695 [4960.4960] INFO SampleApp: shat down connection on UNIX socket Jun 08 18:52:50 rivoff volumio[3298]: TypeError: Cannot read property 'off' of undefined Jun 08 18:52:50 rivoff volumio[3298]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Jun 08 18:52:50 rivoff volumio[3298]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jun 08 18:52:50 rivoff volumio[3298]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Jun 08 18:52:50 rivoff volumio[3298]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Jun 08 18:52:50 rivoff volumio[3298]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Jun 08 18:52:50 rivoff volumio[3298]: at Socket.emit (events.js:400:28) Jun 08 18:52:50 rivoff volumio[3298]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jun 08 18:52:50 rivoff volumio[3298]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jun 08 18:52:50 rivoff systemd[1]: qobuz-connect.service: Succeeded. Jun 08 18:52:50 rivoff volumio[3298]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 18:52:50 rivoff systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 08 18:52:50 rivoff systemd[1]: Started Volumio Qobuz Connect Service. Jun 08 18:52:50 rivoff sudo[5070]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:50 rivoff sudo[5060]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 08 18:52:50 rivoff sudo[5060]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 18:52:50 rivoff sudo[5060]: pam_unix(sudo:session): session closed for user root Jun 08 18:52:51 rivoff sudo[5093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-08 18:51 Jun 08 18:52:51 rivoff sudo[5093]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 06:24:39 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="c8a59422b1bfedffc72f72cef58ad20b"