-- Logs begin at Fri 2025-06-20 04:58:54 -04, end at Sun 2025-06-22 19:54:29 -04. -- Jun 22 19:53:00 volumio qobuz-connect[1499]: 20250622 19:53:00.345 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:53:00 volumio qobuz-connect[1499]: 20250622 19:53:00.345 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:53:00 volumio qobuz-connect[1499]: 20250622 19:53:00.345 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:53:00 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:00 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:53:00 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:53:00 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:53:00 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:53:00 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:10 volumio qobuz-connect[1499]: 20250622 19:53:10.344 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:53:10 volumio qobuz-connect[1499]: 20250622 19:53:10.344 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:53:10 volumio qobuz-connect[1499]: 20250622 19:53:10.344 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:53:10 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:10 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:53:10 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:53:10 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:53:10 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:53:10 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:10 volumio kernel: hwmon hwmon1: Voltage normalised Jun 22 19:53:12 volumio kernel: hwmon hwmon1: Undervoltage detected! Jun 22 19:53:20 volumio qobuz-connect[1499]: 20250622 19:53:20.345 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:53:20 volumio qobuz-connect[1499]: 20250622 19:53:20.345 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:53:20 volumio qobuz-connect[1499]: 20250622 19:53:20.345 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:53:20 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:20 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:53:20 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:53:20 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:53:20 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:53:20 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:30 volumio qobuz-connect[1499]: 20250622 19:53:30.345 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:53:30 volumio qobuz-connect[1499]: 20250622 19:53:30.345 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:53:30 volumio qobuz-connect[1499]: 20250622 19:53:30.346 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:53:30 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:30 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:53:30 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:53:30 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:53:30 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:53:30 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:40 volumio qobuz-connect[1499]: 20250622 19:53:40.346 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:53:40 volumio qobuz-connect[1499]: 20250622 19:53:40.346 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:53:40 volumio qobuz-connect[1499]: 20250622 19:53:40.346 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:53:40 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:40 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:53:40 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:53:40 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:53:40 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:53:40 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:50 volumio qobuz-connect[1499]: 20250622 19:53:50.346 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:53:50 volumio qobuz-connect[1499]: 20250622 19:53:50.347 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:53:50 volumio qobuz-connect[1499]: 20250622 19:53:50.347 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:53:50 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:50 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:53:50 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:53:50 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:53:50 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:53:50 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:53:59 volumio qobuz-connect[1499]: 20250622 19:53:59.353 [1499.1499] INFO PlaybackSessionManager: [0x53b280]: Playback session needs refreshing Jun 22 19:53:59 volumio qobuz-connect[1499]: 20250622 19:53:59.353 [1499.1499] INFO HttpDownloader: [0x53b470]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start Jun 22 19:53:59 volumio qobuz-connect[1499]: 20250622 19:53:59.638 [1499.1499] INFO PlaybackSessionManager: [0x53b280]: Playback session has been refreshed Jun 22 19:54:00 volumio qobuz-connect[1499]: 20250622 19:54:00.347 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:54:00 volumio qobuz-connect[1499]: 20250622 19:54:00.347 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:54:00 volumio qobuz-connect[1499]: 20250622 19:54:00.347 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:00 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:00 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:00 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:00 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:54:00 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:00 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:09 volumio kernel: hwmon hwmon1: Voltage normalised Jun 22 19:54:10 volumio qobuz-connect[1499]: 20250622 19:54:10.346 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:54:10 volumio qobuz-connect[1499]: 20250622 19:54:10.347 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:54:10 volumio qobuz-connect[1499]: 20250622 19:54:10.347 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:10 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:10 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:10 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:10 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:54:10 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:10 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:11 volumio kernel: hwmon hwmon1: Undervoltage detected! Jun 22 19:54:15 volumio kernel: hwmon hwmon1: Voltage normalised Jun 22 19:54:17 volumio kernel: hwmon hwmon1: Undervoltage detected! Jun 22 19:54:20 volumio qobuz-connect[1499]: 20250622 19:54:20.347 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:54:20 volumio qobuz-connect[1499]: 20250622 19:54:20.347 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:54:20 volumio qobuz-connect[1499]: 20250622 19:54:20.347 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:20 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:20 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:20 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:20 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:54:20 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:20 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:21 volumio qobuz-connect[1499]: 20250622 19:54:21.563 [1499.31810] INFO SampleApp: API endpoint invoked: get-display-info Jun 22 19:54:21 volumio qobuz-connect[1499]: 20250622 19:54:21.569 [1499.31810] INFO SampleApp: API endpoint invoked: get-display-info Jun 22 19:54:25 volumio kernel: hwmon hwmon1: Voltage normalised Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.742 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Received SetState message: Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.742 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Playing state: Paused Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.742 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Playback position: Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.742 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Queue version: Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.742 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Current track: Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.742 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Next track: Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.742 [1499.1499] INFO MediaEngine: [0x53b518]: Pausing playback Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.742 [1499.1499] INFO AudioRenderer: [0x53b738]: Pausing audio renderer Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.743 [1499.1499] INFO SampleApp: Pausing playback Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.743 [1499.1499] ERROR SampleApp: Unable to pause ALSA audio sink: Function not implemented (-38) Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.747 [1499.1499] ERROR AudioRenderer: [0x53b738]: Playback error occurred Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.747 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending PlaybackError message Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.747 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.747 [1499.1499] INFO SampleApp: Playback state changed: Stopped Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.747 [1499.1499] INFO StreamingEventReporter: [0x53c070]: Reporting streaming ended event Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.748 [1499.1499] INFO HttpDownloader: [0x53c0c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.748 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.748 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.749 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:27 volumio kernel: hwmon hwmon1: Undervoltage detected! Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.911 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Received SetState message: Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.911 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Playing state: Playing Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.911 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Playback position: 0 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.911 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Queue version: 1.2 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.911 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Current track: TID: 1076148, QID: 4, Context UUID: fcee1489-9c96-45de-b587-b0fc0cf569e5 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.912 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Next track: TID: 68846436, QID: 67, Context UUID: fcee1489-9c96-45de-b587-b0fc0cf569e5 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.912 [1499.1499] INFO MediaEngine: [0x53b518]: Reseting Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.912 [1499.1499] INFO MediaEngine: [0x53b518]: Stopping playback, clearing tracks Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.912 [1499.1499] INFO MediaEngine: [0x53b518]: Initiating playback Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.912 [1499.1499] INFO AudioRenderer: [0x53b738]: Reseting audio renderer Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.912 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.912 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.912 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.913 [1499.1499] INFO MediaEngine: [0x53b518]: Setting current track: 1076148, initial offset: 0ms Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.913 [1499.1499] INFO AudioStreamManager: [0x53b600]: Clearing all streams Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.913 [1499.1499] INFO AudioStreamManager: [0x53b600]: [Stream 10]: Disposing of audio stream Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.913 [1499.1499] INFO ContentFetcher: [0xa3e970]: Canceling download Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:27 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.928 [1499.1499] INFO AudioStreamManager: [0x53b600]: New stream: 12 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.929 [1499.1499] INFO HttpDownloader: [0x87d188]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=246a6f07055e66043ef449e5bc6fc3ca&request_ts=1750636467&track_id=1076148 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.930 [1499.1499] INFO HttpDownloader: [0x73ac58]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=1076148 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.930 [1499.1499] INFO HttpDownloader: [0x6e3500]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=4b23f334634564f66ebaf6f2ed5a583d&request_ts=1750636467&track_id=1076148 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.930 [1499.1499] INFO AudioStreamManager: [0x53b600]: [Stream 12]: Running audio stream Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.933 [1499.1499] INFO SampleApp: [Stream 10]: Audio stream has been disposed of Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.933 [1499.1499] INFO MediaEngine: [0x53b518]: Setting next track: 68846436 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.934 [1499.1499] INFO AudioStreamManager: [0x53b600]: New stream: 13 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.934 [1499.1499] INFO HttpDownloader: [0x59daa0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=c1738483e63a5d3d8ead0b824c40e8f9&request_ts=1750636467&track_id=68846436 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.934 [1499.1499] INFO HttpDownloader: [0x769168]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=68846436 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.934 [1499.1499] INFO HttpDownloader: [0x778980]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=f3074ac307997083178ff05b95449df6&request_ts=1750636467&track_id=68846436 Jun 22 19:54:27 volumio qobuz-connect[1499]: 20250622 19:54:27.937 [1499.1499] INFO MediaEngine: [0x53b518]: Waiting for current stream to start before starting audio renderer Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.200 [1499.1499] INFO AudioStreamManager: [0x53b600]: [Stream 12]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2304271&eid=1076148&fmt=6&profile=raw&app_id=174516466&cid=1597831&etsp=1750640068&hmac=2B92p036HbRLM0kBPDwMoRrc9mo Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.284 [1499.1499] INFO AudioStreamManager: [0x53b600]: [Stream 12]: stream information have been fetched Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.284 [1499.1499] INFO UrlAudioSource: [0x53f3b0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2304271&eid=1076148&fmt=6&profile=raw&app_id=174516466&cid=1597831&etsp=1750640068&hmac=2B92p036HbRLM0kBPDwMoRrc9mo Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.285 [1499.1499] INFO ContentFetcher: [0x58b668]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2304271&eid=1076148&fmt=6&profile=raw&app_id=174516466&cid=1597831&etsp=1750640068&hmac=2B92p036HbRLM0kBPDwMoRrc9mo, offset: 0 Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.285 [1499.1499] INFO AudioRenderer: [0x53b738]: Starting audio renderer, initial playback state: Playing Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.285 [1499.1499] INFO SampleApp: [Stream 12]: New audio stream (starting from 0ms) Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:28 volumio volumio[1146]: info: QobuzConnect: alread currrent service, send playback confirmation Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.288 [1499.1499] INFO SampleApp: Initiating playback, initial state: Playing Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.314 [1499.1499] INFO SampleApp: Playback state changed: Playing Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.315 [1499.1499] INFO StreamingEventReporter: [0x53c070]: Reporting streaming started event Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.315 [1499.1499] INFO HttpDownloader: [0x53c0c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.315 [1499.1499] INFO ProtocolHandler: [0x53bc58]: Need to send state update Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.315 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending StateUpdated message Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.315 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.317 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending FileAudioQualityChanged message Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.317 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.317 [1499.1499] INFO QConnectMessageSender: [0x667a48]: Sending DeviceAudioQualityChanged message Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.318 [1499.1499] INFO QwspMessageSender: [0x693bf8]: Sending Payload message Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.319 [1499.1499] INFO AudioStreamManager: [0x53b600]: [Stream 13]: Metadata became available: Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.319 [1499.1499] INFO AudioStreamManager: [0x53b600]: Title: Embraceable You Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.320 [1499.1499] INFO AudioStreamManager: [0x53b600]: Artist: Ruby Braff Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.320 [1499.1499] INFO AudioStreamManager: [0x53b600]: Album: Complete Recordings Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.320 [1499.1499] INFO AudioStreamManager: [0x53b600]: Album art URL: https://static.qobuz.com/images/covers/8b/ez/vt4orw5p8ez8b_600.jpg Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::servicePushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreStateMachine::pushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioPushState Jun 22 19:54:28 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Jun 22 19:54:28 volumio volumio[1146]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Jun 22 19:54:28 volumio volumio[1146]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 19:54:28 volumio volumio[1146]: TypeError: Cannot read property 'indexOf' of undefined Jun 22 19:54:28 volumio volumio[1146]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Jun 22 19:54:28 volumio volumio[1146]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Jun 22 19:54:28 volumio volumio[1146]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Jun 22 19:54:28 volumio volumio[1146]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 22 19:54:28 volumio volumio[1146]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Jun 22 19:54:28 volumio volumio[1146]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Jun 22 19:54:28 volumio volumio[1146]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 22 19:54:28 volumio volumio[1146]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 22 19:54:28 volumio volumio[1146]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Jun 22 19:54:28 volumio volumio[1146]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 22 19:54:28 volumio volumio[1146]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Jun 22 19:54:28 volumio volumio[1146]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Jun 22 19:54:28 volumio volumio[1146]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Jun 22 19:54:28 volumio volumio[1146]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 22 19:54:28 volumio volumio[1146]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 22 19:54:28 volumio volumio[1146]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Jun 22 19:54:28 volumio volumio[1146]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO AudioStreamManager: [0x53b600]: [Stream 12]: Metadata became available: Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO AudioStreamManager: [0x53b600]: Title: Blues For Brenda (1997 Remastered) Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO AudioStreamManager: [0x53b600]: Artist: Freddie Hubbard Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO AudioStreamManager: [0x53b600]: Album: Goin' Up (1997 Remastered) Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO AudioStreamManager: [0x53b600]: Album art URL: https://static.qobuz.com/images/covers/54/80/0724385938054_600.jpg Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO SampleApp: [Stream 12]: Stream metadata became available: Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO SampleApp: Title: Blues For Brenda (1997 Remastered) Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO SampleApp: Artist: Freddie Hubbard Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.673 [1499.1499] INFO SampleApp: Album: Goin' Up (1997 Remastered) Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.674 [1499.1499] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/54/80/0724385938054_600.jpg Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.708 [1499.1499] INFO AudioStreamManager: [0x53b600]: [Stream 13]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2304271&eid=68846436&fmt=6&profile=raw&app_id=174516466&cid=1597831&etsp=1750640068&hmac=we1S7ooxHhYeZJRuHLXzBG88qsU Jun 22 19:54:28 volumio qobuz-connect[1499]: 20250622 19:54:28.762 [1499.1499] INFO AudioStreamManager: [0x53b600]: [Stream 13]: stream information have been fetched Jun 22 19:54:29 volumio sudo[6567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-22 19:53 Jun 22 19:54:29 volumio sudo[6567]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"