-- Logs begin at Mon 2025-06-09 06:45:21 CEST, end at Mon 2025-06-09 10:05:44 CEST. -- Jun 09 10:04:01 leporello qobuz-connect[4018]: 20250609 10:04:01.799 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Need to send state update Jun 09 10:04:01 leporello qobuz-connect[4018]: 20250609 10:04:01.799 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending StateUpdated message Jun 09 10:04:01 leporello qobuz-connect[4018]: 20250609 10:04:01.799 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:04:01 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:01 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:04:01 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:04:01 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:04:01 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:04:01 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:01 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:04:11 leporello qobuz-connect[4018]: 20250609 10:04:11.799 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Need to send state update Jun 09 10:04:11 leporello qobuz-connect[4018]: 20250609 10:04:11.800 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending StateUpdated message Jun 09 10:04:11 leporello qobuz-connect[4018]: 20250609 10:04:11.800 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:04:11 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:11 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:04:11 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:04:11 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:04:11 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:04:11 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:11 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:04:21 leporello qobuz-connect[4018]: 20250609 10:04:21.801 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Need to send state update Jun 09 10:04:21 leporello qobuz-connect[4018]: 20250609 10:04:21.801 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending StateUpdated message Jun 09 10:04:21 leporello qobuz-connect[4018]: 20250609 10:04:21.801 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:04:21 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:21 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:04:21 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:04:21 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:04:21 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:04:21 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:21 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:04:31 leporello qobuz-connect[4018]: 20250609 10:04:31.802 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Need to send state update Jun 09 10:04:31 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:31 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:04:31 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:04:31 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:04:31 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:04:31 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:31 leporello qobuz-connect[4018]: 20250609 10:04:31.807 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending StateUpdated message Jun 09 10:04:31 leporello qobuz-connect[4018]: 20250609 10:04:31.808 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:04:31 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:04:41 leporello qobuz-connect[4018]: 20250609 10:04:41.805 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Need to send state update Jun 09 10:04:41 leporello qobuz-connect[4018]: 20250609 10:04:41.805 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending StateUpdated message Jun 09 10:04:41 leporello qobuz-connect[4018]: 20250609 10:04:41.805 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:04:41 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:41 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:04:41 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:04:41 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:04:41 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:04:41 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:41 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Received SetState message: Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Playing state: Paused Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Playback position: Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Queue version: Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Current track: Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Next track: Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO MediaEngine: [0xac8b93c0]: Pausing playback Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO AudioRenderer: [0xac8b95e0]: Pausing audio renderer Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.251 [4018.4018] INFO SampleApp: Pausing playback Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.252 [4018.4018] INFO SampleApp: Playback state changed: Paused Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.252 [4018.4018] INFO StreamingEventReporter: [0xac8b9f18]: Reporting streaming ended event Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.252 [4018.4018] INFO HttpDownloader: [0xac8b9f70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.252 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Need to send state update Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.252 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending StateUpdated message Jun 09 10:04:50 leporello qobuz-connect[4018]: 20250609 10:04:50.252 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:04:50 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:04:50 leporello volumio[3777]: info: MCU Signalled Playback Inactive Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.953 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Received SetState message: Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.953 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Playing state: Playing Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.953 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Playback position: 0 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.953 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Queue version: 6.1 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.954 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Current track: TID: 318745574, QID: 0, Context UUID: b20391a3-4da9-4905-8fdc-4cfbf59a0054 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.954 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Next track: TID: 318745575, QID: 1, Context UUID: b20391a3-4da9-4905-8fdc-4cfbf59a0054 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.954 [4018.4018] INFO MediaEngine: [0xac8b93c0]: Stopping playback, clearing tracks Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.954 [4018.4018] INFO MediaEngine: [0xac8b93c0]: Initiating playback Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.954 [4018.4018] INFO AudioRenderer: [0xac8b95e0]: Stopping audio renderer Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.954 [4018.4018] INFO SampleApp: Stopping playback Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.984 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Clearing all streams Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.984 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: [Stream 25]: Disposing of audio stream Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.984 [4018.4018] INFO ContentFetcher: [0xacdc7968]: Canceling download Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.992 [4018.4018] INFO SampleApp: Playback state changed: Stopped Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.992 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Need to send state update Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.992 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending StateUpdated message Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.992 [4018.4018] INFO SampleApp: [Stream 25]: Audio stream has been disposed of Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.992 [4018.4018] INFO MediaEngine: [0xac8b93c0]: Setting current track: 318745574, initial offset: 0ms Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.992 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Clearing all streams Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.992 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: New stream: 27 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.993 [4018.4018] INFO HttpDownloader: [0xac922d40]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=f4859328e8f1031ee4c3145925d09f7c&request_ts=1749456342&track_id=318745574 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.993 [4018.4018] INFO HttpDownloader: [0xacdf9140]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=318745574 Jun 09 10:05:42 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:42 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:05:42 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:05:42 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.993 [4018.4018] INFO HttpDownloader: [0xacad8fb0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=64380278fb26141a9ff8fc953403a539&request_ts=1749456342&track_id=318745574 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.993 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: [Stream 27]: Running audio stream Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.993 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.995 [4018.4018] INFO MediaEngine: [0xac8b93c0]: Setting next track: 318745575 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.996 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: New stream: 28 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.996 [4018.4018] INFO HttpDownloader: [0xac9c8b58]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=1575131bca1830c12003e45b4b1801c1&request_ts=1749456342&track_id=318745575 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.996 [4018.4018] INFO HttpDownloader: [0xac924488]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=318745575 Jun 09 10:05:42 leporello qobuz-connect[4018]: 20250609 10:05:42.996 [4018.4018] INFO HttpDownloader: [0xac925908]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=3a29974114ae164c01fe84f01973b403&request_ts=1749456342&track_id=318745575 Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:42.998 [4018.4018] INFO MediaEngine: [0xac8b93c0]: Waiting for current stream to start before starting audio renderer Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.153 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: [Stream 27]: stream information have been fetched Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.161 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: [Stream 27]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=318745574&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1749459943&hmac=CrIiQ5pprdcISMsdDm_kdKr7EZA Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.161 [4018.4018] INFO UrlAudioSource: [0xac9dfc28]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=318745574&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1749459943&hmac=CrIiQ5pprdcISMsdDm_kdKr7EZA Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.162 [4018.4018] INFO ContentFetcher: [0xacfa7c40]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=318745574&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1749459943&hmac=CrIiQ5pprdcISMsdDm_kdKr7EZA, offset: 0 Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.163 [4018.4018] INFO AudioRenderer: [0xac8b95e0]: Starting audio renderer, initial playback state: Playing Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.163 [4018.4018] INFO SampleApp: [Stream 27]: New audio stream (starting from 0ms) Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.164 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: [Stream 28]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=318745575&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1749459943&hmac=qj06gPokX6iQiSRN53TTxxnMt_8 Jun 09 10:05:43 leporello volumio[3777]: info: QobuzConnect: alread currrent service, send playback confirmation Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.165 [4018.4018] INFO SampleApp: Initiating playback, initial state: Playing Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.242 [4018.4018] INFO SampleApp: Playback state changed: Playing Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.242 [4018.4018] INFO StreamingEventReporter: [0xac8b9f18]: Reporting streaming started event Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.243 [4018.4018] INFO HttpDownloader: [0xac8b9f70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.243 [4018.4018] INFO ProtocolHandler: [0xac8b9b00]: Need to send state update Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.243 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending StateUpdated message Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.243 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.244 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending FileAudioQualityChanged message Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.245 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.245 [4018.4018] INFO QConnectMessageSender: [0xac9df778]: Sending DeviceAudioQualityChanged message Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.245 [4018.4018] INFO QwspMessageSender: [0xac9df768]: Sending Payload message Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.247 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: [Stream 28]: stream information have been fetched Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.247 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: [Stream 27]: Metadata became available: Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.247 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Title: When I Turn This Corner (Acoustic) Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.248 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Artist: Fink Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.248 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Album: Beauty In Your Wake (Acoustic) Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.248 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Album art URL: https://static.qobuz.com/images/covers/2b/tb/rdw6bueritb2b_600.jpg Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.248 [4018.4018] INFO SampleApp: [Stream 27]: Stream metadata became available: Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.248 [4018.4018] INFO SampleApp: Title: When I Turn This Corner (Acoustic) Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.248 [4018.4018] INFO SampleApp: Artist: Fink Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.248 [4018.4018] INFO SampleApp: Album: Beauty In Your Wake (Acoustic) Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.248 [4018.4018] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/2b/tb/rdw6bueritb2b_600.jpg Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.252 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: [Stream 28]: Metadata became available: Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.252 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Title: Follow You Down (Acoustic) Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.252 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Artist: Fink Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.252 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Album: Beauty In Your Wake (Acoustic) Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.252 [4018.4018] INFO AudioStreamManager: [0xac8b94a8]: Album art URL: https://static.qobuz.com/images/covers/2b/tb/rdw6bueritb2b_600.jpg Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::servicePushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreStateMachine::pushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioPushState Jun 09 10:05:43 leporello volumio[3777]: info: CoreCommandRouter::volumioGetState Jun 09 10:05:43 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:05:43 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:05:43 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:05:43 leporello volumio[3777]: info: Signalling Playback active due to playback status change Jun 09 10:05:43 leporello volumio[3777]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Jun 09 10:05:43 leporello volumio[3777]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 10:05:43 leporello volumio[3777]: TypeError: Cannot read property 'indexOf' of undefined Jun 09 10:05:43 leporello volumio[3777]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Jun 09 10:05:43 leporello volumio[3777]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Jun 09 10:05:43 leporello volumio[3777]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Jun 09 10:05:43 leporello volumio[3777]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 09 10:05:43 leporello volumio[3777]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Jun 09 10:05:43 leporello volumio[3777]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Jun 09 10:05:43 leporello volumio[3777]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 09 10:05:43 leporello volumio[3777]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 09 10:05:43 leporello volumio[3777]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Jun 09 10:05:43 leporello volumio[3777]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 09 10:05:43 leporello volumio[3777]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Jun 09 10:05:43 leporello volumio[3777]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Jun 09 10:05:43 leporello volumio[3777]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Jun 09 10:05:43 leporello volumio[3777]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 09 10:05:43 leporello volumio[3777]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 09 10:05:43 leporello volumio[3777]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Jun 09 10:05:43 leporello volumio[3777]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.444 [4018.4018] INFO UrlAudioSource: [0xac9dfc28]: Content info extracted Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.444 [4018.4018] INFO UrlAudioSource: [0xac9dfc28]: Size: 48853031 Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.447 [4018.1891] INFO AudioDecoder: [0xacc77b70]: Stream info: Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.447 [4018.1891] INFO AudioDecoder: [0xacc77b70]: Total samples: 13073464 Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.448 [4018.1891] INFO AudioDecoder: [0xacc77b70]: Sample rate: 48000 Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.448 [4018.1891] INFO AudioDecoder: [0xacc77b70]: Channel count: 2 Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.448 [4018.1891] INFO AudioDecoder: [0xacc77b70]: Bits per sample: 24 Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.448 [4018.1891] INFO AudioDecoder: [0xacc77b70]: Duration: 272363 Jun 09 10:05:43 leporello qobuz-connect[4018]: 20250609 10:05:43.448 [4018.4018] INFO UrlAudioSource: [0xac9dfc28]: Audio properties have changed Jun 09 10:05:44 leporello sudo[1893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-09 10:04 Jun 09 10:05:44 leporello sudo[1893]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Jun 2025 12:03:48 PM CEST" VOLUMIO_VERSION="3.814" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="202ef1ac23d45c852aeb3bc3d2ca3041"