-- Logs begin at Mon 2025-07-07 08:31:54 CEST, end at Thu 2025-07-10 12:30:28 CEST. -- Jul 10 12:29:28 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 12:29:28 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 12:29:28 leporello volumio[3264]: info: Discovery: Getting this device information Jul 10 12:29:28 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:29:28 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 12:29:58 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 12:29:58 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 12:29:58 leporello volumio[3264]: info: Discovery: Getting this device information Jul 10 12:29:58 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:29:58 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.766 [3741.21774] INFO SampleApp: API endpoint invoked: get-connect-info Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.967 [3741.21774] INFO SampleApp: API endpoint invoked: connect-to-qconnect Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.967 [3741.3741] INFO EndpointManager: [0xad02fd38]: Updating API endpoint Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.967 [3741.3741] INFO EndpointManager: [0xad02fd38]: Updating QConnect endpoint Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.967 [3741.3741] INFO ActiveStateManager: [0xad02ed50]: Setting new active state: active Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.967 [3741.3741] INFO PlaybackSessionManager: [0xad030128]: Starting playback session maintenance Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.968 [3741.3741] INFO HttpDownloader: [0xad030318]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.968 [3741.3741] INFO CloudClient: [0xad030998]: Connecting to the cloud Jul 10 12:30:22 leporello qobuz-connect[3741]: 20250710 12:30:22.969 [3741.3741] INFO SampleApp: Renderer is now active Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.223 [3741.3741] INFO CloudClient: [0xad030998]: Connection established Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.223 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Authenticate message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.223 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Subscribe message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.224 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending JoinSession message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.224 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending VolumeChanged message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.224 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending VolumeMuted message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.224 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending MaxAudioQualityChanged message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.224 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Received SetActive message: active Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Received SetState message: Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Playing state: Paused Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Playback position: 54830 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Queue version: 1.1 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Current track: TID: 330241583, QID: 0, Context UUID: 2a76909c-be29-4cf5-ab6f-fe0156708a25 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Next track: TID: 330241584, QID: 1, Context UUID: 2a76909c-be29-4cf5-ab6f-fe0156708a25 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO MediaEngine: [0xad0303c0]: Stopping playback, clearing tracks Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.276 [3741.3741] INFO MediaEngine: [0xad0303c0]: Initiating playback Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO RendererActionAvailabilityManager: [0xad030a50]: Renderer action 'Next' is available Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Received SetLoopMode message: Off Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO PlaybackControlsManager: [0xad030798]: Setting new loop mode: Off Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO MediaEngine: [0xad0303c0]: Setting current track: 330241583, initial offset: 54830ms Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Clearing all streams Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: New stream: 1 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO HttpDownloader: [0xad10ba28]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=96a07d690fad25609306c1c865947773&request_ts=1752143423&track_id=330241583 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO HttpDownloader: [0xad10c9b8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=330241583 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 1]: Running audio stream Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Received SetShuffleMode message: disabled Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.277 [3741.3741] INFO PlaybackControlsManager: [0xad030798]: Setting new shuffle mode: disabled Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.278 [3741.3741] INFO MediaEngine: [0xad0303c0]: Setting next track: 330241584 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.278 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: New stream: 2 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.279 [3741.3741] INFO HttpDownloader: [0xad1d0b60]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=4e9458fae3ebeeb1cfd8ff25ccd7caf2&request_ts=1752143423&track_id=330241584 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.279 [3741.3741] INFO HttpDownloader: [0xad1d1b00]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=330241584 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.280 [3741.3741] INFO MediaEngine: [0xad0303c0]: Waiting for current stream to start before starting audio renderer Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.287 [3741.3741] INFO PlaybackSessionManager: [0xad030128]: Playback session has been refreshed Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.287 [3741.3741] INFO HttpDownloader: [0xad03c4a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=669df496c8487098c0d3f0cc3a0b1a4f&request_ts=1752143423&track_id=330241583 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.287 [3741.3741] INFO HttpDownloader: [0xad035fe0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=68e26dc32fe51414566d4cddb7d2bc17&request_ts=1752143423&track_id=330241584 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.403 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=330241583&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1752147023&hmac=nddcIji1sT3uNtj9eB6YM-o1Tdw Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.474 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 2]: Metadata became available: Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.474 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Title: Tunnel Maze Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.475 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Artist: Sharon Mansur Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.475 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Album: Trigger Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.475 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Album art URL: https://static.qobuz.com/images/covers/ua/mo/qpt5r10bpmoua_600.jpg Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.475 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 1]: stream information have been fetched Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.475 [3741.3741] INFO UrlAudioSource: [0xad1d2890]: Starting URL audio source, initial position: 54830ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=330241583&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1752147023&hmac=nddcIji1sT3uNtj9eB6YM-o1Tdw Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.475 [3741.3741] INFO ContentFetcher: [0xad03aee0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=330241583&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1752147023&hmac=nddcIji1sT3uNtj9eB6YM-o1Tdw, offset: 0 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.475 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 2]: stream information have been fetched Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.476 [3741.3741] INFO AudioRenderer: [0xad0305e0]: Starting audio renderer, initial playback state: Paused Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.477 [3741.3741] INFO SampleApp: [Stream 1]: New audio stream (starting from 54830ms) Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.479 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 1]: Metadata became available: Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.479 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Title: Outside In Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.479 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Artist: Sharon Mansur Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.479 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Album: Trigger Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.479 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Album art URL: https://static.qobuz.com/images/covers/ua/mo/qpt5r10bpmoua_600.jpg Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.480 [3741.3741] INFO SampleApp: [Stream 1]: Stream metadata became available: Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello volumio[3264]: info: QobuzConnect: setActiveState() Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.480 [3741.3741] INFO SampleApp: Title: Outside In Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.480 [3741.3741] INFO SampleApp: Artist: Sharon Mansur Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.480 [3741.3741] INFO SampleApp: Album: Trigger Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.480 [3741.3741] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/ua/mo/qpt5r10bpmoua_600.jpg Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.484 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=330241584&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1752147023&hmac=ES_r9RwKJJdJUUOYTUwK3OidbPo Jul 10 12:30:23 leporello volumio[3264]: info: QobuzConnect: Set Qobuz connect default volume to 100 Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.485 [3741.3741] INFO VolumeManager: [0xad030828]: Setting new playback volume: 100 Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello volumio[3264]: info: QobuzConnect: Stopping currently active service Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioStop Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::stop Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::updateTrackBlock Jul 10 12:30:23 leporello volumio[3264]: info: CorePlayQueue::getTrackBlock Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::stPlaybackTimer Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::pushState Jul 10 12:30:23 leporello volumio[3264]: info: CorePlayQueue::getTrack 9 Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioPushState Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello volumio[3264]: info: CorePlayQueue::getTrack 9 Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::serviceStop Jul 10 12:30:23 leporello volumio[3264]: info: CorePlayQueue::getTrack 9 Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::serviceStop Jul 10 12:30:23 leporello volumio[3264]: info: [1752143423494] ControllerQobuz::stop Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 12:30:23 leporello volumio[3264]: info: ControllerMpd::stop Jul 10 12:30:23 leporello volumio[3264]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello volumio[3264]: info: Jul 10 12:30:23 leporello volumio[3264]: ---------------------------- MPD announces state update: player Jul 10 12:30:23 leporello volumio[3264]: info: sendMpdCommand stop took 46 milliseconds Jul 10 12:30:23 leporello volumio[3264]: info: ControllerMpd::getState Jul 10 12:30:23 leporello volumio[3264]: verbose: ControllerMpd::sendMpdCommand status Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::servicePushState Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::pushState Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioPushState Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello volumio[3264]: info: CorePlayQueue::getTrack 9 Jul 10 12:30:23 leporello volumio[3264]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect Jul 10 12:30:23 leporello volumio[3264]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Jul 10 12:30:23 leporello volumio[3264]: info: QobuzConnect: setActiveState() completed, send playback confirmation Jul 10 12:30:23 leporello volumio[3264]: info: sendMpdCommand status took 16 milliseconds Jul 10 12:30:23 leporello volumio[3264]: verbose: ControllerMpd::parseState Jul 10 12:30:23 leporello volumio[3264]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 12:30:23 leporello volumio[3264]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jul 10 12:30:23 leporello volumio[3264]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 10 12:30:23 leporello volumio[3264]: verbose: ControllerMpd::parseTrackInfo Jul 10 12:30:23 leporello volumio[3264]: info: ControllerMpd::pushState Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::servicePushState Jul 10 12:30:23 leporello volumio[3264]: info: CoreStateMachine::pushState Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioPushState Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello volumio[3264]: info: CorePlayQueue::getTrack 9 Jul 10 12:30:23 leporello volumio[3264]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jul 10 12:30:23 leporello volumio[3264]: info: ------------------------------ 37ms Jul 10 12:30:23 leporello volumio[3264]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.593 [3741.3741] INFO SampleApp: Initiating playback, initial state: Paused Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.735 [3741.3741] INFO SampleApp: Playback volume changed: 100 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.735 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Volume changed: 100 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.735 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending VolumeChanged message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.735 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.735 [3741.3741] INFO SampleApp: Playback state changed: Paused Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.736 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Need to send state update Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.736 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending StateUpdated message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.736 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.736 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending FileAudioQualityChanged message Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.737 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.737 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending DeviceAudioQualityChanged message Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.737 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:23 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.773 [3741.3741] INFO UrlAudioSource: [0xad1d2890]: Content info extracted Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.773 [3741.3741] INFO UrlAudioSource: [0xad1d2890]: Size: 35922707 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.782 [3741.21780] INFO AudioDecoder: [0xad2a59a8]: Stream info: Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.782 [3741.21780] INFO AudioDecoder: [0xad2a59a8]: Total samples: 8186844 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.782 [3741.21780] INFO AudioDecoder: [0xad2a59a8]: Sample rate: 44100 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.783 [3741.21780] INFO AudioDecoder: [0xad2a59a8]: Channel count: 2 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.783 [3741.21780] INFO AudioDecoder: [0xad2a59a8]: Bits per sample: 24 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.783 [3741.21780] INFO AudioDecoder: [0xad2a59a8]: Duration: 185642 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.783 [3741.3741] INFO UrlAudioSource: [0xad1d2890]: Audio properties have changed Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.783 [3741.3741] INFO UrlAudioSource: [0xad1d2890]: Seeking input stream to byte offset: 10658273 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.783 [3741.3741] INFO ContentFetcher: [0xad03aee0]: Adjusting download offset to: 10658273 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.928 [3741.3741] INFO UrlAudioSource: [0xad1d2890]: Seeking input stream to byte offset: 10641288 Jul 10 12:30:23 leporello qobuz-connect[3741]: 20250710 12:30:23.929 [3741.3741] INFO ContentFetcher: [0xad03aee0]: Adjusting download offset to: 10641288 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.161 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Received SetState message: Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.161 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Playing state: Playing Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.161 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Playback position: 0 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.161 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Queue version: 2.1 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.161 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Current track: TID: 327070430, QID: 0, Context UUID: 98a90004-f343-4777-b2d2-fe3781fb26e8 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.161 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Next track: TID: 327070431, QID: 1, Context UUID: 98a90004-f343-4777-b2d2-fe3781fb26e8 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.161 [3741.3741] INFO MediaEngine: [0xad0303c0]: Stopping playback, clearing tracks Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.161 [3741.3741] INFO MediaEngine: [0xad0303c0]: Initiating playback Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.162 [3741.3741] INFO AudioRenderer: [0xad0305e0]: Stopping audio renderer Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.162 [3741.3741] INFO SampleApp: Stopping playback Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.169 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Clearing all streams Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.169 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 1]: Disposing of audio stream Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.169 [3741.3741] INFO ContentFetcher: [0xad03aee0]: Canceling download Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.178 [3741.3741] INFO SampleApp: Playback state changed: Stopped Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.178 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Need to send state update Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.178 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending StateUpdated message Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.178 [3741.3741] INFO SampleApp: [Stream 1]: Audio stream has been disposed of Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.178 [3741.3741] INFO MediaEngine: [0xad0303c0]: Setting current track: 327070430, initial offset: 0ms Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.179 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Clearing all streams Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.179 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: New stream: 3 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.179 [3741.3741] INFO HttpDownloader: [0xad1d0768]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=18d407b9bccc7e16c819f7a4edf31491&request_ts=1752143427&track_id=327070430 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.179 [3741.3741] INFO HttpDownloader: [0xad034d98]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=327070430 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.179 [3741.3741] INFO HttpDownloader: [0xad1f8c68]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=78066de0a424279464ad5b615bf74c50&request_ts=1752143427&track_id=327070430 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.179 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 3]: Running audio stream Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.179 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.182 [3741.3741] INFO MediaEngine: [0xad0303c0]: Setting next track: 327070431 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.182 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: New stream: 4 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.182 [3741.3741] INFO HttpDownloader: [0xad217cc8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=079821476f9bf7476e7cec125dca8d03&request_ts=1752143427&track_id=327070431 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.182 [3741.3741] INFO HttpDownloader: [0xad1d6e38]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=327070431 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.182 [3741.3741] INFO HttpDownloader: [0xad203490]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=961b7983ad34620b80baeead7e2a1938&request_ts=1752143427&track_id=327070431 Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.184 [3741.3741] INFO MediaEngine: [0xad0303c0]: Waiting for current stream to start before starting audio renderer Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.324 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=327070431&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1752147027&hmac=GYbeBWx3voB5xtmWJuMPvnFx1yY Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.339 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 3]: stream information have been fetched Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.341 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=327070430&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1752147027&hmac=0zfpT93CrnaGxiZmQhS3aZm_4ZU Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.341 [3741.3741] INFO UrlAudioSource: [0xad269b80]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=327070430&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1752147027&hmac=0zfpT93CrnaGxiZmQhS3aZm_4ZU Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.342 [3741.3741] INFO ContentFetcher: [0xad2a0f88]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=327070430&fmt=7&profile=raw&app_id=174516466&cid=1234969&etsp=1752147027&hmac=0zfpT93CrnaGxiZmQhS3aZm_4ZU, offset: 0 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.342 [3741.3741] INFO AudioRenderer: [0xad0305e0]: Starting audio renderer, initial playback state: Playing Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.342 [3741.3741] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms) Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.344 [3741.3741] INFO VolumeManager: [0xad030828]: Setting new playback volume: 100 Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: QobuzConnect: setActiveState() Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: QobuzConnect: Set Qobuz connect default volume to 100 Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: QobuzConnect: Stopping currently active service Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioStop Jul 10 12:30:27 leporello volumio[3264]: info: CoreStateMachine::stop Jul 10 12:30:27 leporello volumio[3264]: info: CoreStateMachine::serviceStop Jul 10 12:30:27 leporello volumio[3264]: info: Received STOP, but no service to execute it Jul 10 12:30:27 leporello volumio[3264]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::servicePushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreStateMachine::pushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioPushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: CorePlayQueue::getTrack 9 Jul 10 12:30:27 leporello volumio[3264]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect Jul 10 12:30:27 leporello volumio[3264]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Jul 10 12:30:27 leporello volumio[3264]: info: QobuzConnect: setActiveState() completed, send playback confirmation Jul 10 12:30:27 leporello volumio[3264]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.427 [3741.3741] INFO SampleApp: Initiating playback, initial state: Playing Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.542 [3741.3741] INFO SampleApp: Playback state changed: Playing Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.543 [3741.3741] INFO StreamingEventReporter: [0xad030f18]: Reporting streaming started event Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.543 [3741.3741] INFO HttpDownloader: [0xad030f70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.543 [3741.3741] INFO ProtocolHandler: [0xad030b00]: Need to send state update Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.543 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending StateUpdated message Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.543 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::servicePushState Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.545 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending FileAudioQualityChanged message Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.545 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:27 leporello volumio[3264]: info: CoreStateMachine::pushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.545 [3741.3741] INFO QConnectMessageSender: [0xad070418]: Sending DeviceAudioQualityChanged message Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.546 [3741.3741] INFO QwspMessageSender: [0xad13a980]: Sending Payload message Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.546 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 3]: Metadata became available: Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioPushState Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Title: Variations on a Theme by Chopin, Op. 22 - Theme. Largo Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Artist: Alexander Melnikov Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Album: Visiting Rachmaninoff: Chopin Variations - Romances Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Album art URL: https://static.qobuz.com/images/covers/rb/b7/qadw1fys1b7rb_600.jpg Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 4]: stream information have been fetched Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: [Stream 4]: Metadata became available: Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Title: Variations on a Theme by Chopin, Op. 22 - Var. I. Moderato Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Artist: Alexander Melnikov Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Album: Visiting Rachmaninoff: Chopin Variations - Romances Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.547 [3741.3741] INFO AudioStreamManager: [0xad0304a8]: Album art URL: https://static.qobuz.com/images/covers/rb/b7/qadw1fys1b7rb_600.jpg Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.548 [3741.3741] INFO SampleApp: [Stream 3]: Stream metadata became available: Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.548 [3741.3741] INFO SampleApp: Title: Variations on a Theme by Chopin, Op. 22 - Theme. Largo Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.548 [3741.3741] INFO SampleApp: Artist: Alexander Melnikov Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.548 [3741.3741] INFO SampleApp: Album: Visiting Rachmaninoff: Chopin Variations - Romances Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.548 [3741.3741] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/rb/b7/qadw1fys1b7rb_600.jpg Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.551 [3741.3741] INFO VolumeManager: [0xad030828]: Setting new playback volume: 100 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.552 [3741.3741] INFO VolumeManager: [0xad030828]: Setting new mute state: 0 Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::servicePushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreStateMachine::pushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioPushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::servicePushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreStateMachine::pushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioPushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::servicePushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreStateMachine::pushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioPushState Jul 10 12:30:27 leporello volumio[3264]: info: CoreCommandRouter::volumioGetState Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.577 [3741.3741] INFO UrlAudioSource: [0xad269b80]: Content info extracted Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.577 [3741.3741] INFO UrlAudioSource: [0xad269b80]: Size: 19900402 Jul 10 12:30:27 leporello volumio[3264]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.584 [3741.21781] INFO AudioDecoder: [0xad2b4980]: Stream info: Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.585 [3741.21781] INFO AudioDecoder: [0xad2b4980]: Total samples: 7313920 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.585 [3741.21781] INFO AudioDecoder: [0xad2b4980]: Sample rate: 96000 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.585 [3741.21781] INFO AudioDecoder: [0xad2b4980]: Channel count: 2 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.585 [3741.21781] INFO AudioDecoder: [0xad2b4980]: Bits per sample: 24 Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.585 [3741.21781] INFO AudioDecoder: [0xad2b4980]: Duration: 76186 Jul 10 12:30:27 leporello volumio[3264]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 12:30:27 leporello qobuz-connect[3741]: 20250710 12:30:27.586 [3741.3741] INFO UrlAudioSource: [0xad269b80]: Audio properties have changed Jul 10 12:30:27 leporello volumio[3264]: TypeError: Cannot read property 'indexOf' of undefined Jul 10 12:30:27 leporello volumio[3264]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Jul 10 12:30:27 leporello volumio[3264]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Jul 10 12:30:27 leporello volumio[3264]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Jul 10 12:30:27 leporello volumio[3264]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jul 10 12:30:27 leporello volumio[3264]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Jul 10 12:30:27 leporello volumio[3264]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Jul 10 12:30:27 leporello volumio[3264]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jul 10 12:30:27 leporello volumio[3264]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jul 10 12:30:27 leporello volumio[3264]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Jul 10 12:30:27 leporello volumio[3264]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jul 10 12:30:27 leporello volumio[3264]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Jul 10 12:30:27 leporello volumio[3264]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Jul 10 12:30:27 leporello volumio[3264]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Jul 10 12:30:27 leporello volumio[3264]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jul 10 12:30:27 leporello volumio[3264]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jul 10 12:30:27 leporello volumio[3264]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Jul 10 12:30:27 leporello volumio[3264]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 12:30:28 leporello sudo[21791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-10 12:29 Jul 10 12:30:28 leporello sudo[21791]: 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="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 05:15:38 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="13b9c0f9785de91e97db9573691d3efe"