-- Logs begin at Mon 2025-05-19 17:53:19 CEST, end at Mon 2025-05-19 18:05:40 CEST. -- May 19 18:04:06 rivoplus qobuz-connect[3790]: 20250519 18:04:06.518 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Need to send state update May 19 18:04:06 rivoplus qobuz-connect[3790]: 20250519 18:04:06.518 [3790.3790] INFO QConnectMessageSender: [0xab759480]: Sending StateUpdated message May 19 18:04:06 rivoplus qobuz-connect[3790]: 20250519 18:04:06.518 [3790.3790] INFO QwspMessageSender: [0xab750ef8]: Sending Payload message May 19 18:04:06 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:06 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:06 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:06 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:04:06 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:06 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:06 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:06 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:15 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:04:15 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:04:15 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:04:15 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:15 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:04:16 rivoplus qobuz-connect[3790]: 20250519 18:04:16.518 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Need to send state update May 19 18:04:16 rivoplus qobuz-connect[3790]: 20250519 18:04:16.518 [3790.3790] INFO QConnectMessageSender: [0xab759480]: Sending StateUpdated message May 19 18:04:16 rivoplus qobuz-connect[3790]: 20250519 18:04:16.518 [3790.3790] INFO QwspMessageSender: [0xab750ef8]: Sending Payload message May 19 18:04:16 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:16 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:16 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:16 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:04:16 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:16 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:16 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:16 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:26 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:26 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:26 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:26 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:04:26 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:26 rivoplus qobuz-connect[3790]: 20250519 18:04:26.523 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Need to send state update May 19 18:04:26 rivoplus qobuz-connect[3790]: 20250519 18:04:26.523 [3790.3790] INFO QConnectMessageSender: [0xab759480]: Sending StateUpdated message May 19 18:04:26 rivoplus qobuz-connect[3790]: 20250519 18:04:26.523 [3790.3790] INFO QwspMessageSender: [0xab750ef8]: Sending Payload message May 19 18:04:26 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:26 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:26 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:32 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61:3000 from 192.168.178.66 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 May 19 18:04:32 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61 from 192.168.178.66 UA: Mozilla/5.0 (Linux; Android 14; SM-X210 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetVisibleSources May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetQueue May 19 18:04:32 rivoplus volumio[3109]: info: CoreStateMachine::getQueue May 19 18:04:32 rivoplus volumio[3109]: info: CorePlayQueue::getQueue May 19 18:04:32 rivoplus volumio[3109]: info: Listing playlists May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 19 18:04:32 rivoplus volumio[3109]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 19 18:04:32 rivoplus volumio[3109]: info: Received Get System Info May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:04:32 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:32 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 19 18:04:36 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:36 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:36 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:04:36 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:36 rivoplus qobuz-connect[3790]: 20250519 18:04:36.531 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Need to send state update May 19 18:04:36 rivoplus qobuz-connect[3790]: 20250519 18:04:36.531 [3790.3790] INFO QConnectMessageSender: [0xab759480]: Sending StateUpdated message May 19 18:04:36 rivoplus qobuz-connect[3790]: 20250519 18:04:36.531 [3790.3790] INFO QwspMessageSender: [0xab750ef8]: Sending Payload message May 19 18:04:36 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:36 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:36 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:46 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:46 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:46 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:46 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:04:46 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:46 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:46 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:46 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:46 rivoplus qobuz-connect[3790]: 20250519 18:04:46.529 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Need to send state update May 19 18:04:46 rivoplus qobuz-connect[3790]: 20250519 18:04:46.529 [3790.3790] INFO QConnectMessageSender: [0xab759480]: Sending StateUpdated message May 19 18:04:46 rivoplus qobuz-connect[3790]: 20250519 18:04:46.529 [3790.3790] INFO QwspMessageSender: [0xab750ef8]: Sending Payload message May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.518 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Need to send state update May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.518 [3790.3790] INFO QConnectMessageSender: [0xab759480]: Sending StateUpdated message May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.518 [3790.3790] INFO QwspMessageSender: [0xab750ef8]: Sending Payload message May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:56 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:56 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.595 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Received SetState message: May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.595 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Playing state: Paused May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.596 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Playback position: May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.596 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Queue version: May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.596 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Current track: May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.596 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Next track: May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.596 [3790.3790] INFO MediaEngine: [0xab74d398]: Pausing playback May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.596 [3790.3790] INFO AudioRenderer: [0xab74d5b8]: Pausing audio renderer May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.596 [3790.3790] INFO SampleApp: Pausing playback May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.596 [3790.3790] INFO SampleApp: Playback state changed: Paused May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.597 [3790.3790] INFO StreamingEventReporter: [0xab74def0]: Reporting streaming ended event May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.597 [3790.3790] INFO HttpDownloader: [0xab74df48]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.597 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Need to send state update May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.597 [3790.3790] INFO QConnectMessageSender: [0xab759480]: Sending StateUpdated message May 19 18:04:56 rivoplus qobuz-connect[3790]: 20250519 18:04:56.597 [3790.3790] INFO QwspMessageSender: [0xab750ef8]: Sending Payload message May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:56 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:56 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:56 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:56 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:04:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:04:56 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:04:56 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:04:56 rivoplus volumio[3109]: info: MCU Signalled Playback Inactive May 19 18:05:08 rivoplus qobuz-connect[3790]: 20250519 18:05:08.324 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Received SetState message: May 19 18:05:08 rivoplus qobuz-connect[3790]: 20250519 18:05:08.324 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Playing state: Paused May 19 18:05:08 rivoplus qobuz-connect[3790]: 20250519 18:05:08.324 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Playback position: May 19 18:05:08 rivoplus qobuz-connect[3790]: 20250519 18:05:08.324 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Queue version: May 19 18:05:08 rivoplus qobuz-connect[3790]: 20250519 18:05:08.324 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Current track: May 19 18:05:08 rivoplus qobuz-connect[3790]: 20250519 18:05:08.324 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Next track: May 19 18:05:08 rivoplus qobuz-connect[3790]: 20250519 18:05:08.324 [3790.3790] INFO MediaEngine: [0xab74d398]: Pausing playback May 19 18:05:12 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:05:12 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:05:12 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:05:12 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:12 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:05:12 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61:3000 from 192.168.178.60 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 May 19 18:05:12 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:12 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 19 18:05:12 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 19 18:05:12 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61:3000 from 192.168.178.66 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 May 19 18:05:14 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61 from 192.168.178.66 UA: Mozilla/5.0 (Linux; Android 14; SM-X210 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetVisibleSources May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetQueue May 19 18:05:14 rivoplus volumio[3109]: info: CoreStateMachine::getQueue May 19 18:05:14 rivoplus volumio[3109]: info: CorePlayQueue::getQueue May 19 18:05:14 rivoplus volumio[3109]: info: Listing playlists May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 19 18:05:14 rivoplus volumio[3109]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 19 18:05:14 rivoplus volumio[3109]: info: Received Get System Info May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:05:14 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 19 18:05:15 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:15 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61:3000 from 192.168.178.60 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 May 19 18:05:15 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:15 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 19 18:05:15 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 19 18:05:15 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:16 rivoplus sudo[6153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 19 18:05:16 rivoplus sudo[6153]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 18:05:16 rivoplus sudo[6153]: pam_unix(sudo:session): session closed for user root May 19 18:05:16 rivoplus sudo[6155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 19 18:05:16 rivoplus sudo[6155]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 18:05:16 rivoplus sudo[6155]: pam_unix(sudo:session): session closed for user root May 19 18:05:16 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61 from 192.168.178.60 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UI35H.11-39-16; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 May 19 18:05:16 rivoplus sudo[6161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 19 18:05:16 rivoplus sudo[6161]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 18:05:16 rivoplus sudo[6161]: pam_unix(sudo:session): session closed for user root May 19 18:05:16 rivoplus sudo[6164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 19 18:05:16 rivoplus sudo[6164]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 18:05:16 rivoplus sudo[6164]: pam_unix(sudo:session): session closed for user root May 19 18:05:16 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61 from 192.168.178.60 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UI35H.11-39-16; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetVisibleSources May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetQueue May 19 18:05:17 rivoplus volumio[3109]: info: CoreStateMachine::getQueue May 19 18:05:17 rivoplus volumio[3109]: info: CorePlayQueue::getQueue May 19 18:05:17 rivoplus volumio[3109]: info: Listing playlists May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 19 18:05:17 rivoplus volumio[3109]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 19 18:05:17 rivoplus volumio[3109]: info: Received Get System Info May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:05:17 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 19 18:05:17 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.178.61 from 192.168.178.60 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UI35H.11-39-16; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetVisibleSources May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 19 18:05:17 rivoplus volumio[3109]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 19 18:05:17 rivoplus volumio[3109]: info: Received Get System Info May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:05:17 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:17 rivoplus volumio[3109]: info: Listing playlists May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetQueue May 19 18:05:17 rivoplus volumio[3109]: info: CoreStateMachine::getQueue May 19 18:05:17 rivoplus volumio[3109]: info: CorePlayQueue::getQueue May 19 18:05:17 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 19 18:05:18 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 19 18:05:18 rivoplus volumio[3109]: info: Received Get System Info May 19 18:05:18 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:05:18 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:05:18 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:05:18 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:18 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:05:18 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 19 18:05:19 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri May 19 18:05:19 rivoplus volumio[3109]: info: handleBrowseUri took 606 milliseconds May 19 18:05:19 rivoplus volumio[3109]: info: Preload queue cleared May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191146 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191147 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191148 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191149 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191150 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191151 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191152 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191153 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191154 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191155 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191156 May 19 18:05:19 rivoplus volumio[3109]: info: Preloading song: qobuz://song/135191157 May 19 18:05:19 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 19 18:05:19 rivoplus volumio[3109]: info: Received Get System Info May 19 18:05:19 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:05:19 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:05:19 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:05:19 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:19 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191146 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191147 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191148 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191149 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191150 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191151 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191152 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191153 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191154 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191155 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 482 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 438 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191156 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: Exploding uri qobuz://song/135191157 in service qobuz May 19 18:05:20 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 481 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 457 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 511 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 506 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 416 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 573 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 488 milliseconds May 19 18:05:20 rivoplus volumio[3109]: info: explodeUri took 512 milliseconds May 19 18:05:21 rivoplus volumio[3109]: info: explodeUri took 542 milliseconds May 19 18:05:21 rivoplus volumio[3109]: info: explodeUri took 590 milliseconds May 19 18:05:22 rivoplus volumio[3109]: info: Preload queue cleared May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioReplaceandPlayItems May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::ClearQueue May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::stop May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::serviceStop May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::serviceStop May 19 18:05:22 rivoplus volumio[3109]: info: QobuzConnect: Received stop May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::clearPlayQueue May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::saveQueue May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushQueue May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.086 [3790.3790] INFO MediaEngine: [0xab74d398]: Stopping playback, keeping tracks May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.086 [3790.3790] INFO AudioRenderer: [0xab74d5b8]: Stopping audio renderer May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.086 [3790.3790] INFO SampleApp: Stopping playback May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::addQueueItems May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::addQueueItems May 19 18:05:22 rivoplus volumio[3109]: info: Preload queue cleared May 19 18:05:22 rivoplus volumio[3109]: info: Adding Item to queue: qobuz://playlist/32291586 May 19 18:05:22 rivoplus volumio[3109]: info: Exploding uri qobuz://playlist/32291586 in service qobuz May 19 18:05:22 rivoplus volumio[3109]: https://prod.vlmapi.io/v2/qobuz/explodeUri May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.119 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Clearing all streams May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.119 [3790.3790] INFO AudioStreamManager: [0xab74d480]: [Stream 11]: Disposing of audio stream May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.119 [3790.3790] INFO ContentFetcher: [0xabd65560]: Canceling download May 19 18:05:22 rivoplus volumio[3109]: info: QobuzConnect: playback_stop received, deferred solved May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.127 [3790.3790] INFO AudioStreamManager: [0xab74d480]: New stream: 13 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.127 [3790.3790] INFO HttpDownloader: [0xabb86e88]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=6944479546151b1a00102305e1b8449d&request_ts=1747670722&track_id=220108419 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.127 [3790.3790] INFO HttpDownloader: [0xab8325d0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=220108419 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.127 [3790.3790] INFO HttpDownloader: [0xab786b58]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=e1603a245e3a3e15f8379ad92d527791&request_ts=1747670722&track_id=220108419 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.128 [3790.3790] INFO AudioStreamManager: [0xab74d480]: [Stream 13]: Running audio stream May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.128 [3790.3790] INFO AudioStreamManager: [0xab74d480]: New stream: 14 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.128 [3790.3790] INFO HttpDownloader: [0xabe05118]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=d9b585f49644c0c696e433636b0f904b&request_ts=1747670722&track_id=220108420 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.128 [3790.3790] INFO HttpDownloader: [0xab7f3bc8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=220108420 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.128 [3790.3790] INFO HttpDownloader: [0xab8300c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=baa8acd73bb9ad19b30c27b3ea922608&request_ts=1747670722&track_id=220108420 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.130 [3790.3790] INFO SampleApp: Playback state changed: Stopped May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.130 [3790.3790] INFO ProtocolHandler: [0xab74dad8]: Need to send state update May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.130 [3790.3790] INFO QConnectMessageSender: [0xab759480]: Sending StateUpdated message May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.130 [3790.3790] INFO SampleApp: [Stream 11]: Audio stream has been disposed of May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.131 [3790.3790] INFO QwspMessageSender: [0xab750ef8]: Sending Payload message May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:22 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:22 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:22 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:22 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: [Stream 14]: Metadata became available: May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Title: Slay the Giant May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Artist: Jérôme Sabbagh May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Album: Vintage May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Album art URL: https://static.qobuz.com/images/covers/0a/0n/z0opzxdfw0n0a_600.jpg May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: [Stream 13]: Metadata became available: May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Title: Elson's Energy May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Artist: Jérôme Sabbagh May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Album: Vintage May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.200 [3790.3790] INFO AudioStreamManager: [0xab74d480]: Album art URL: https://static.qobuz.com/images/covers/0a/0n/z0opzxdfw0n0a_600.jpg May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.236 [3790.3790] INFO AudioStreamManager: [0xab74d480]: [Stream 13]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1393244&eid=220108419&fmt=27&profile=raw&app_id=174516466&cid=1887526&etsp=1747674322&hmac=im8BjKUVh_XMtgPE3f58TtiNK1I May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.272 [3790.3790] INFO AudioStreamManager: [0xab74d480]: [Stream 14]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1393244&eid=220108420&fmt=27&profile=raw&app_id=174516466&cid=1887526&etsp=1747674322&hmac=owT7w0DmvH5r2UZESofvbwEBhiU May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.315 [3790.3790] INFO AudioStreamManager: [0xab74d480]: [Stream 13]: stream information have been fetched May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.315 [3790.3790] INFO UrlAudioSource: [0xabe46e78]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1393244&eid=220108419&fmt=27&profile=raw&app_id=174516466&cid=1887526&etsp=1747674322&hmac=im8BjKUVh_XMtgPE3f58TtiNK1I May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.316 [3790.3790] INFO ContentFetcher: [0xabcce628]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1393244&eid=220108419&fmt=27&profile=raw&app_id=174516466&cid=1887526&etsp=1747674322&hmac=im8BjKUVh_XMtgPE3f58TtiNK1I, offset: 0 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.316 [3790.3790] INFO SampleApp: [Stream 13]: New audio stream (starting from 0ms) May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.316 [3790.3790] INFO SampleApp: [Stream 13]: Stream metadata became available: May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.316 [3790.3790] INFO SampleApp: Title: Elson's Energy May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.316 [3790.3790] INFO SampleApp: Artist: Jérôme Sabbagh May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.316 [3790.3790] INFO SampleApp: Album: Vintage May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.316 [3790.3790] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/0a/0n/z0opzxdfw0n0a_600.jpg May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.325 [3790.3790] INFO AudioStreamManager: [0xab74d480]: [Stream 14]: stream information have been fetched May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.580 [3790.3790] INFO UrlAudioSource: [0xabe46e78]: Content info extracted May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.580 [3790.3790] INFO UrlAudioSource: [0xabe46e78]: Size: 198457511 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.587 [3790.6186] INFO AudioDecoder: [0xab9ffc60]: Stream info: May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.587 [3790.6186] INFO AudioDecoder: [0xab9ffc60]: Total samples: 53649047 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.587 [3790.6186] INFO AudioDecoder: [0xab9ffc60]: Sample rate: 192000 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.587 [3790.6186] INFO AudioDecoder: [0xab9ffc60]: Channel count: 2 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.587 [3790.6186] INFO AudioDecoder: [0xab9ffc60]: Bits per sample: 24 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.587 [3790.6186] INFO AudioDecoder: [0xab9ffc60]: Duration: 279422 May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.587 [3790.3790] INFO UrlAudioSource: [0xabe46e78]: Audio properties have changed May 19 18:05:22 rivoplus volumio[3109]: info: explodeUri took 660 milliseconds May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushQueue May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::saveQueue May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::updateTrackBlock May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::getTrackBlock May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPlay May 19 18:05:22 rivoplus volumio[3109]: verbose: UNSET VOLATILE: Service: qobuzconnect May 19 18:05:22 rivoplus volumio[3109]: info: QobuzConnect: onUnsetVolatile() called, relinquishing Volumio State to another service May 19 18:05:22 rivoplus volumio[3109]: info: QobuzConnect: Received stop May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:22 rivoplus qobuz-connect[3790]: 20250519 18:05:22.766 [3790.3790] INFO MediaEngine: [0xab74d398]: Stopping playback, keeping tracks May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::play index 0 May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::stop May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::updateTrackBlock May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::getTrackBlock May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::stPlaybackTimer May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:22 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:22 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::serviceStop May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::serviceStop May 19 18:05:22 rivoplus volumio[3109]: info: [1747670722779] ControllerQobuz::stop May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::setConsumeUpdateService mpd May 19 18:05:22 rivoplus volumio[3109]: info: ControllerMpd::stop May 19 18:05:22 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand stop May 19 18:05:22 rivoplus volumio[3109]: info: sendMpdCommand stop took 32 milliseconds May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::play index undefined May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:22 rivoplus volumio[3109]: info: CoreStateMachine::startPlaybackTimer May 19 18:05:22 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:22 rivoplus volumio[3109]: info: [1747670722815] ControllerQobuz::clearAddPlayTrack May 19 18:05:22 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand stop May 19 18:05:22 rivoplus volumio[3109]: info: sendMpdCommand stop took 3 milliseconds May 19 18:05:22 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand clear May 19 18:05:22 rivoplus volumio[3109]: info: sendMpdCommand clear took 2 milliseconds May 19 18:05:22 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/135191146" May 19 18:05:22 rivoplus volumio[3109]: info: May 19 18:05:22 rivoplus volumio[3109]: ---------------------------- MPD announces system playlist update May 19 18:05:22 rivoplus volumio[3109]: info: Ignoring MPD Status Update May 19 18:05:22 rivoplus volumio[3109]: info: May 19 18:05:22 rivoplus volumio[3109]: ---------------------------- MPD announces system playlist update May 19 18:05:22 rivoplus volumio[3109]: STREAMING PROXY: Handling url /?data=qobuz://song/135191146 May 19 18:05:22 rivoplus volumio[3109]: info: Ignoring MPD Status Update May 19 18:05:22 rivoplus volumio[3109]: info: May 19 18:05:22 rivoplus volumio[3109]: ---------------------------- MPD announces system playlist update May 19 18:05:22 rivoplus volumio[3109]: info: Ignoring MPD Status Update May 19 18:05:22 rivoplus volumio[3109]: error: Upnp client error: Error: This socket has been ended by the other party May 19 18:05:22 rivoplus volumio[3109]: info: Executing endpoint getStreamUrlqobuz May 19 18:05:22 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI May 19 18:05:23 rivoplus volumio[3109]: info: getStreamUrl took 484 milliseconds May 19 18:05:23 rivoplus volumio[3109]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1393244&eid=135191146&fmt=6&profile=raw&app_id=539451548&cid=1887526&etsp=1747674323&hmac=oKYHxjovY9GCmwXHetYfJrCHdzs May 19 18:05:23 rivoplus volumio[3109]: STREAMING PROXY: Response: 200, length: 19258111 May 19 18:05:23 rivoplus volumio[3109]: STREAMING PROXY: Client dropped request, destroying May 19 18:05:23 rivoplus mpd[3776]: exception: No such playlist May 19 18:05:23 rivoplus volumio[3109]: error: updateQueue error: null May 19 18:05:23 rivoplus volumio[3109]: error: updateQueue error: null May 19 18:05:23 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/135191146" May 19 18:05:23 rivoplus volumio[3109]: info: ------------------------------ 635ms May 19 18:05:23 rivoplus volumio[3109]: info: ------------------------------ 632ms May 19 18:05:23 rivoplus volumio[3109]: info: ------------------------------ 632ms May 19 18:05:23 rivoplus volumio[3109]: info: May 19 18:05:23 rivoplus volumio[3109]: ---------------------------- MPD announces system playlist update May 19 18:05:23 rivoplus volumio[3109]: info: Ignoring MPD Status Update May 19 18:05:23 rivoplus volumio[3109]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/135191146" took 2 milliseconds May 19 18:05:23 rivoplus volumio[3109]: info: CoreStateMachine::setConsumeUpdateService mpd May 19 18:05:23 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand play May 19 18:05:23 rivoplus volumio[3109]: info: May 19 18:05:23 rivoplus volumio[3109]: ---------------------------- MPD announces system playlist update May 19 18:05:23 rivoplus volumio[3109]: info: Ignoring MPD Status Update May 19 18:05:23 rivoplus volumio[3109]: info: May 19 18:05:23 rivoplus volumio[3109]: ---------------------------- MPD announces system playlist update May 19 18:05:23 rivoplus volumio[3109]: info: Ignoring MPD Status Update May 19 18:05:23 rivoplus volumio[3109]: STREAMING PROXY: Handling url /?data=qobuz://song/135191146 May 19 18:05:23 rivoplus volumio[3109]: info: ------------------------------ 7ms May 19 18:05:23 rivoplus volumio[3109]: info: sendMpdCommand play took 10 milliseconds May 19 18:05:23 rivoplus volumio[3109]: info: ------------------------------ 9ms May 19 18:05:23 rivoplus volumio[3109]: info: ------------------------------ 8ms May 19 18:05:23 rivoplus volumio[3109]: info: Executing endpoint getStreamUrlqobuz May 19 18:05:23 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI May 19 18:05:23 rivoplus volumio[3109]: info: getStreamUrl took 385 milliseconds May 19 18:05:23 rivoplus volumio[3109]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1393244&eid=135191146&fmt=6&profile=raw&app_id=539451548&cid=1887526&etsp=1747674323&hmac=oKYHxjovY9GCmwXHetYfJrCHdzs May 19 18:05:24 rivoplus volumio[3109]: STREAMING PROXY: Response: 200, length: 19258111 May 19 18:05:24 rivoplus volumio[3109]: info: May 19 18:05:24 rivoplus volumio[3109]: ---------------------------- MPD announces state update: player May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::getState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand status May 19 18:05:24 rivoplus volumio[3109]: info: May 19 18:05:24 rivoplus volumio[3109]: ---------------------------- MPD announces state update: player May 19 18:05:24 rivoplus kernel: aml_tdm_open May 19 18:05:24 rivoplus kernel: Not init audio effects May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::getState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand status May 19 18:05:24 rivoplus volumio[3109]: info: May 19 18:05:24 rivoplus volumio[3109]: ---------------------------- MPD announces state update: player May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::getState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand status May 19 18:05:24 rivoplus kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 May 19 18:05:24 rivoplus kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 May 19 18:05:24 rivoplus kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc03d03b818, id(1), clksel(1) May 19 18:05:24 rivoplus kernel: aml_dai_set_tdm_fmt(), fmt not change May 19 18:05:24 rivoplus kernel: dump_pcm_setting(ffffffc03d03b818) May 19 18:05:24 rivoplus kernel: pcm_mode(1) May 19 18:05:24 rivoplus kernel: sysclk(12288000) May 19 18:05:24 rivoplus kernel: sysclk_bclk_ratio(4) May 19 18:05:24 rivoplus kernel: bclk(3072000) May 19 18:05:24 rivoplus kernel: bclk_lrclk_ratio(64) May 19 18:05:24 rivoplus kernel: lrclk(48000) May 19 18:05:24 rivoplus kernel: tx_mask(0x3) May 19 18:05:24 rivoplus kernel: rx_mask(0x3) May 19 18:05:24 rivoplus kernel: slots(2) May 19 18:05:24 rivoplus kernel: slot_width(32) May 19 18:05:24 rivoplus kernel: lane_mask_in(0x2) May 19 18:05:24 rivoplus kernel: lane_mask_out(0x1) May 19 18:05:24 rivoplus kernel: lane_oe_mask_in(0x0) May 19 18:05:24 rivoplus kernel: lane_oe_mask_out(0x0) May 19 18:05:24 rivoplus kernel: lane_lb_mask_in(0x0) May 19 18:05:24 rivoplus kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk May 19 18:05:24 rivoplus kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk May 19 18:05:24 rivoplus kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 May 19 18:05:24 rivoplus kernel: aml_dai_set_clkdiv, div 4, clksel(1) May 19 18:05:24 rivoplus kernel: aml_dai_set_bclk_ratio, select I2S mode May 19 18:05:24 rivoplus kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B May 19 18:05:24 rivoplus kernel: aml_tdm_prepare(), reset fddr May 19 18:05:24 rivoplus kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 May 19 18:05:24 rivoplus kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 May 19 18:05:24 rivoplus kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 May 19 18:05:24 rivoplus kernel: tdm playback mute: 0, lane_cnt = 8 May 19 18:05:24 rivoplus kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 May 19 18:05:24 rivoplus kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B May 19 18:05:24 rivoplus kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 May 19 18:05:24 rivoplus kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc03d03b818, id(1), clksel(1) May 19 18:05:24 rivoplus kernel: aml_dai_set_tdm_fmt(), fmt not change May 19 18:05:24 rivoplus kernel: dump_pcm_setting(ffffffc03d03b818) May 19 18:05:24 rivoplus kernel: pcm_mode(1) May 19 18:05:24 rivoplus kernel: sysclk(11289600) May 19 18:05:24 rivoplus kernel: sysclk_bclk_ratio(4) May 19 18:05:24 rivoplus kernel: bclk(2822400) May 19 18:05:24 rivoplus kernel: bclk_lrclk_ratio(64) May 19 18:05:24 rivoplus kernel: lrclk(44100) May 19 18:05:24 rivoplus kernel: tx_mask(0x3) May 19 18:05:24 rivoplus kernel: rx_mask(0x3) May 19 18:05:24 rivoplus kernel: slots(2) May 19 18:05:24 rivoplus kernel: slot_width(32) May 19 18:05:24 rivoplus kernel: lane_mask_in(0x2) May 19 18:05:24 rivoplus kernel: lane_mask_out(0x1) May 19 18:05:24 rivoplus kernel: lane_oe_mask_in(0x0) May 19 18:05:24 rivoplus kernel: lane_oe_mask_out(0x0) May 19 18:05:24 rivoplus kernel: lane_lb_mask_in(0x0) May 19 18:05:24 rivoplus kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk May 19 18:05:24 rivoplus kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk May 19 18:05:24 rivoplus kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 May 19 18:05:24 rivoplus kernel: aml_dai_set_clkdiv, div 4, clksel(1) May 19 18:05:24 rivoplus kernel: aml_dai_set_bclk_ratio, select I2S mode May 19 18:05:24 rivoplus kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B May 19 18:05:24 rivoplus kernel: aml_tdm_prepare(), reset fddr May 19 18:05:24 rivoplus kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 May 19 18:05:24 rivoplus kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 May 19 18:05:24 rivoplus kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 May 19 18:05:24 rivoplus kernel: tdm playback mute: 0, lane_cnt = 8 May 19 18:05:24 rivoplus kernel: aml_tdm_prepare(), reset fddr May 19 18:05:24 rivoplus kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 May 19 18:05:24 rivoplus kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 May 19 18:05:24 rivoplus kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 May 19 18:05:24 rivoplus kernel: tdm playback mute: 0, lane_cnt = 8 May 19 18:05:24 rivoplus volumio[3109]: info: May 19 18:05:24 rivoplus volumio[3109]: ---------------------------- MPD announces state update: player May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand status took 12 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand status took 10 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand status took 9 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::getState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand status May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 18:05:24 rivoplus volumio[3109]: info: May 19 18:05:24 rivoplus volumio[3109]: ---------------------------- MPD announces state update: player May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::getState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand status May 19 18:05:24 rivoplus volumio[3109]: info: May 19 18:05:24 rivoplus volumio[3109]: ---------------------------- MPD announces state update: player May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::getState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand status May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand status took 6 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand playlistinfo took 7 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand playlistinfo took 6 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand playlistinfo took 7 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand status took 5 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand status took 4 milliseconds May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseTrackInfo May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseTrackInfo May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseState May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:05:24 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:24 rivoplus volumio[3109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":185,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"135191146","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/135191146","trackType":"qobuz"} May 19 18:05:24 rivoplus volumio[3109]: verbose: CURRENT POSITION 0 May 19 18:05:24 rivoplus kernel: asoc-aml-card auge_sound: tdm playback enable May 19 18:05:24 rivoplus kernel: spdif_a is set to enable May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState stateService play May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState currentStatus stop May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:05:24 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:24 rivoplus volumio[3109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":185,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"135191146","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/135191146","trackType":"qobuz"} May 19 18:05:24 rivoplus volumio[3109]: verbose: CURRENT POSITION 0 May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState stateService play May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState currentStatus play May 19 18:05:24 rivoplus volumio[3109]: info: Received an update from plugin. extracting info from payload May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:05:24 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:24 rivoplus volumio[3109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":185,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"135191146","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/135191146","trackType":"qobuz"} May 19 18:05:24 rivoplus volumio[3109]: verbose: CURRENT POSITION 0 May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState stateService play May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState currentStatus play May 19 18:05:24 rivoplus volumio[3109]: info: Received an update from plugin. extracting info from payload May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: ------------------------------ 61ms May 19 18:05:24 rivoplus volumio[3109]: info: ------------------------------ 86ms May 19 18:05:24 rivoplus volumio[3109]: info: ------------------------------ 86ms May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand playlistinfo took 66 milliseconds May 19 18:05:24 rivoplus volumio[3109]: info: sendMpdCommand playlistinfo took 64 milliseconds May 19 18:05:24 rivoplus volumio[3109]: verbose: ControllerMpd::parseTrackInfo May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:05:24 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:24 rivoplus volumio[3109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":185,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"135191146","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/135191146","trackType":"qobuz"} May 19 18:05:24 rivoplus volumio[3109]: verbose: CURRENT POSITION 0 May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState stateService play May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState currentStatus play May 19 18:05:24 rivoplus volumio[3109]: info: Received an update from plugin. extracting info from payload May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:05:24 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:24 rivoplus volumio[3109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":185,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"135191146","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/135191146","trackType":"qobuz"} May 19 18:05:24 rivoplus volumio[3109]: verbose: CURRENT POSITION 0 May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState stateService play May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState currentStatus play May 19 18:05:24 rivoplus volumio[3109]: info: Received an update from plugin. extracting info from payload May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: ControllerMpd::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::servicePushState May 19 18:05:24 rivoplus volumio[3109]: info: CorePlayQueue::getTrack 0 May 19 18:05:24 rivoplus volumio[3109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":185,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"135191146","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/135191146","trackType":"qobuz"} May 19 18:05:24 rivoplus volumio[3109]: verbose: CURRENT POSITION 0 May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState stateService play May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::syncState currentStatus play May 19 18:05:24 rivoplus volumio[3109]: info: Received an update from plugin. extracting info from payload May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: CoreStateMachine::pushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioPushState May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output update for this device May 19 18:05:24 rivoplus volumio[3109]: info: MRS: Pushing multiroomSync output May 19 18:05:24 rivoplus volumio[3109]: info: ------------------------------ 239ms May 19 18:05:24 rivoplus volumio[3109]: info: ------------------------------ 238ms May 19 18:05:24 rivoplus volumio[3109]: info: ------------------------------ 238ms May 19 18:05:24 rivoplus volumio[3109]: info: Signalling Playback active due to playback status change May 19 18:05:24 rivoplus volumio[3109]: info: MCU Signalled Playback Active May 19 18:05:24 rivoplus volumio[3109]: info: Executing endpoint metavolumio May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 18:05:24 rivoplus volumio[3109]: info: Executing endpoint metavolumio May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 18:05:24 rivoplus volumio[3109]: info: Executing endpoint metavolumio May 19 18:05:24 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 18:05:26 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 19 18:05:26 rivoplus volumio[3109]: STREAMING PROXY: Client dropped request, destroying May 19 18:05:35 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 19 18:05:35 rivoplus volumio[3109]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 19 18:05:35 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 19 18:05:35 rivoplus volumio[3109]: info: Received Get System Version May 19 18:05:35 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 19 18:05:35 rivoplus volumio[3109]: info: Received Get System Info May 19 18:05:35 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 18:05:35 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 18:05:35 rivoplus volumio[3109]: info: Discovery: Getting this device information May 19 18:05:35 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState May 19 18:05:35 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 18:05:37 rivoplus volumio[3109]: info: Retrieving Cloud Streaming UI May 19 18:05:37 rivoplus volumio[3109]: info: Getting Tidal Cloud Configuration May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 18:05:37 rivoplus volumio[3109]: info: Getting Qobuz Cloud Configuration May 19 18:05:37 rivoplus volumio[3109]: info: Asking plugin for UI Config May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 18:05:37 rivoplus volumio[3109]: info: Getting Spotify Cloud Configuration May 19 18:05:37 rivoplus volumio[3109]: info: Asking plugin for UI Config May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 18:05:37 rivoplus volumio[3109]: info: Saving Spotify Acccount May 19 18:05:37 rivoplus volumio[3109]: info: Got it May 19 18:05:37 rivoplus volumio[3109]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 19 18:05:37 rivoplus volumio[3109]: info: Got Tidal Cloud Configuration May 19 18:05:37 rivoplus volumio[3109]: info: Got it May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetBrowseSources May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetBrowseSources May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetBrowseSources May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 19 18:05:37 rivoplus mpd[3776]: exception: No database May 19 18:05:37 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 19 18:05:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 19 18:05:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 19 18:05:39 rivoplus volumio[3109]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 18:05:39 rivoplus volumio[3109]: Error: dns service error: unknown May 19 18:05:39 rivoplus volumio[3109]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 19 18:05:39 rivoplus volumio[3109]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 19 18:05:39 rivoplus volumio[3109]: errorCode: -65537 May 19 18:05:39 rivoplus volumio[3109]: } May 19 18:05:39 rivoplus volumio[3109]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 18:05:40 rivoplus sudo[6320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-19 18:04 May 19 18:05:40 rivoplus sudo[6320]: 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="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 06:04:38 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="0064c1a7ac4363e567dacab062cb5da8"