Aug 30 18:03:03 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:05 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:03:06 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:06 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:06 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:10 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:13 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:03:14 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:14 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:14 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:17 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:17 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:18 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:21 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:03:22 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:25 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:25 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:26 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:28 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:28 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:29 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:03:30 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:34 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:36 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:36 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:37 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:03:38 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:40 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:03:42 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:44 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:44 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:46 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:48 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:03:50 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:52 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:52 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:54 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:55 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:55 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:03:56 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:03:58 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:03:59 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:02 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:03 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:03 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:05 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:05.329 [2419.2423] INFO SampleApp: API endpoint invoked: get-display-info
Aug 30 18:04:05 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:05.338 [2419.2423] INFO SampleApp: API endpoint invoked: get-connect-info
Aug 30 18:04:06 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:06 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:06 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:08 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:09 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:09 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:10 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:13 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:13 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:14 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:15 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:15.728 [2419.2423] INFO SampleApp: API endpoint invoked: get-display-info
Aug 30 18:04:15 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:15.735 [2419.2423] INFO SampleApp: API endpoint invoked: get-connect-info
Aug 30 18:04:16 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:16 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:16 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:18 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:19 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:22 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:22 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:24 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:24 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:26 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:30 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:30 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:32 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:32 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:33 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:34 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:35 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:35 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:36 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:38 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:38 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:38 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:41 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:41 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:43 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:44 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:46 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:49 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:49 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:50 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:52 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:52 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:52 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:54 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:54.260 [2419.2423] INFO SampleApp: API endpoint invoked: get-display-info
Aug 30 18:04:54 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:54.291 [2419.2423] INFO SampleApp: API endpoint invoked: get-connect-info
Aug 30 18:04:54 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:55 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:55 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.92
Aug 30 18:04:55 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:58 volumio-bwk5-rpi5 volumio[1336]: info: Discovery: Remote connection error: 192.168.1.64
Aug 30 18:04:58 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.277 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Received SetActive message: active
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.277 [2419.2419] INFO ActiveStateManager: [0x20d6a48]: Setting new active state: active
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.277 [2419.2419] INFO PlaybackSessionManager: [0x20d7cc8]: Starting playback session maintenance
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.277 [2419.2419] INFO QConnectMessageSender: [0x227d018]: Sending VolumeChanged message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.277 [2419.2419] INFO QConnectMessageSender: [0x227d018]: Sending VolumeMuted message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.277 [2419.2419] INFO QConnectMessageSender: [0x227d018]: Sending MaxAudioQualityChanged message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.277 [2419.2419] INFO SampleApp: Renderer is now active
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.277 [2419.2419] INFO QwspMessageSender: [0x227d008]: Sending Payload message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Received SetState message:
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Playing state: Playing
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Playback position: 44800
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Queue version: 6.1
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Current track: TID: 401292959, QID: 0, Context UUID: 5082b7c5-2fa2-4586-b63d-638d5455f111
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Next track: TID: 27243704, QID: 1, Context UUID: 5082b7c5-2fa2-4586-b63d-638d5455f111
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO MediaEngine: [0x20d7ed0]: Stopping playback, clearing tracks
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO MediaEngine: [0x20d7ed0]: Initiating playback
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO RendererActionAvailabilityManager: [0x20d8408]: Renderer action 'Next' is available
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Received SetLoopMode message: Off
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO PlaybackModeManager: [0x20d8198]: Setting new loop mode: Off
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO MediaEngine: [0x20d7ed0]: Setting current track: 401292959, initial offset: 44800ms
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Clearing all streams
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: New stream: 1
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO HttpDownloader: [0x20db350]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=de15168eb3f9b81e258db5adc7bc90e6&request_ts=1788105899&track_id=401292959
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO HttpDownloader: [0x20db788]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=401292959
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO HttpDownloader: [0x20ddfd0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=cbf61ba10096b0fc3df0c468c366085c&request_ts=1788105899&track_id=401292959
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: [Stream 1]: Running audio stream
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Received SetShuffleMode message: disabled
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO PlaybackModeManager: [0x20d8198]: Setting new shuffle mode: disabled
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO MediaEngine: [0x20d7ed0]: Setting next track: 27243704
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: New stream: 2
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO HttpDownloader: [0x20de200]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=dd821435da1179c60f8dbc599b5548ce&request_ts=1788105899&track_id=27243704
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO HttpDownloader: [0x20de518]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=27243704
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO HttpDownloader: [0x20e36e0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=a4efd78ec88b75640e48e9ad13f98edc&request_ts=1788105899&track_id=27243704
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.308 [2419.2419] INFO MediaEngine: [0x20d7ed0]: Waiting for current stream to start before starting audio renderer
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.526 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=376682&eid=27243704&fmt=6&profile=raw&app_id=174516466&cid=1346919&etsp=1788109499&hmac=qORO7L-KhN48i_xDZV6LCh-HE0E
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.560 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: [Stream 2]: Metadata became available:
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.560 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Title: Pretty Pimpin
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.560 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Artist: Kurt Vile
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.560 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Album: b'lieve i'm goin down...
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.560 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Album art URL: https://static.qobuz.com/images/covers/56/33/0744861103356_600.jpg
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.589 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=376682&eid=401292959&fmt=7&profile=raw&app_id=174516466&cid=1346919&etsp=1788109499&hmac=JoPTKpZl6ClwMm8QRdEMHe3IGNM
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.620 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: [Stream 1]: stream information have been fetched
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.620 [2419.2419] INFO UrlAudioSource: [0x20dbf20]: Starting URL audio source, initial position: 44800ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=376682&eid=401292959&fmt=7&profile=raw&app_id=174516466&cid=1346919&etsp=1788109499&hmac=JoPTKpZl6ClwMm8QRdEMHe3IGNM
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.620 [2419.2419] INFO ContentFetcher: [0x24a9ce0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=376682&eid=401292959&fmt=7&profile=raw&app_id=174516466&cid=1346919&etsp=1788109499&hmac=JoPTKpZl6ClwMm8QRdEMHe3IGNM, offset: 0
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.620 [2419.2419] INFO AudioRenderer: [0x20d8038]: Starting audio renderer, initial playback state: Playing
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.620 [2419.2419] INFO SampleApp: [Stream 1]: New audio stream (starting from 44800ms)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CorePlayQueue::getTrack 0
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: QobuzConnect: setActiveState()
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CorePlayQueue::getTrack 0
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: QobuzConnect: Set Qobuz connect default volume to 23
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.622 [2419.2419] INFO VolumeManager: [0x20d8228]: Setting new playback volume: 23
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CorePlayQueue::getTrack 0
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CorePlayQueue::getTrack 0
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: QobuzConnect: Stopping currently active service
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioStop
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreStateMachine::stop
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::servicePushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreStateMachine::pushState
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.625 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: [Stream 2]: stream information have been fetched
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioPushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: MRS: Pushing multiroomSync output update for this device
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: MRS: Pushing multiroomSync output
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CorePlayQueue::getTrack 0
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received qobuzconnect
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: QobuzConnect: setActiveState() completed, send playback confirmation
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: FusionDsp - Volumio is not playing
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: FusionDsp - Clipped samples monitor stopped
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio5-onboarding[1756]: time=2026-08-30T18:04:59.632+02:00 level=WARN msg="received unknown player status" component=volumio status=""
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.648 [2419.2419] INFO SampleApp: Initiating playback, initial state: Playing
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.665 [2419.2419] INFO SampleApp: Playback state changed: Playing
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.665 [2419.2419] INFO StreamingEventReporter: [0x20d8858]: Reporting streaming started event
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.665 [2419.2419] INFO HttpDownloader: [0x20d88b0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.665 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Need to send state update
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.665 [2419.2419] INFO QConnectMessageSender: [0x227d018]: Sending StateUpdated message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.665 [2419.2419] INFO QwspMessageSender: [0x227d008]: Sending Payload message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.665 [2419.2419] INFO QConnectMessageSender: [0x227d018]: Sending FileAudioQualityChanged message
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::servicePushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreStateMachine::pushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioPushState
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.667 [2419.2419] INFO QwspMessageSender: [0x227d008]: Sending Payload message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.667 [2419.2419] INFO QConnectMessageSender: [0x227d018]: Sending DeviceAudioQualityChanged message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.667 [2419.2419] INFO QwspMessageSender: [0x227d008]: Sending Payload message
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: MRS: Pushing multiroomSync output update for this device
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: MRS: Pushing multiroomSync output
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.669 [2419.2419] INFO VolumeManager: [0x20d8228]: Setting new playback volume: 23
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.669 [2419.2419] INFO VolumeManager: [0x20d8228]: Setting new mute state: 0
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::servicePushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreStateMachine::pushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioPushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: MRS: Pushing multiroomSync output update for this device
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: MRS: Pushing multiroomSync output
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::servicePushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreStateMachine::pushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioPushState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: MRS: Pushing multiroomSync output update for this device
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: MRS: Pushing multiroomSync output
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: CoreCommandRouter::volumioGetState
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: FusionDsp - Volumio is playing
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: warn: FusionDsp - Monitor WebSocket not open, skipping commands
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title!
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: TypeError: Cannot read properties of undefined (reading 'indexOf')
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14)
Aug 30 18:04:59 volumio-bwk5-rpi5 volumio[1336]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.2419] INFO UrlAudioSource: [0x20dbf20]: Content info extracted
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.2419] INFO UrlAudioSource: [0x20dbf20]: Size: 116274968
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.9280] INFO AudioDecoder: [0x2559718]: Stream info:
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.9280] INFO AudioDecoder: [0x2559718]: Total samples: 28293120
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.9280] INFO AudioDecoder: [0x2559718]: Sample rate: 96000
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.9280] INFO AudioDecoder: [0x2559718]: Channel count: 2
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.9280] INFO AudioDecoder: [0x2559718]: Bits per sample: 24
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.9280] INFO AudioDecoder: [0x2559718]: Duration: 294720
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.2419] INFO UrlAudioSource: [0x20dbf20]: Audio properties have changed
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.2419] INFO UrlAudioSource: [0x20dbf20]: Seeking input stream to byte offset: 17587771
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.685 [2419.2419] INFO ContentFetcher: [0x24a9ce0]: Adjusting download offset to: 17587771
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: [Stream 1]: Metadata became available:
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Title: Zoom 97
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Artist: Kurt Vile
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Album: Philadelphia's been good to me
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO AudioStreamManager: [0x20d7f80]: Album art URL: https://static.qobuz.com/images/covers/qy/xt/ifjjjkp00xtqy_600.jpg
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO SampleApp: [Stream 1]: Stream metadata became available:
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO SampleApp: Title: Zoom 97
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO SampleApp: Artist: Kurt Vile
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO SampleApp: Album: Philadelphia's been good to me
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.717 [2419.2419] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/qy/xt/ifjjjkp00xtqy_600.jpg
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.773 [2419.2419] INFO SampleApp: Playback volume changed: 23
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.773 [2419.2419] INFO ProtocolHandler: [0x20d84a8]: Volume changed: 23
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.773 [2419.2419] INFO QConnectMessageSender: [0x227d018]: Sending VolumeChanged message
Aug 30 18:04:59 volumio-bwk5-rpi5 qobuz-connect[2419]: 20260830 18:04:59.773 [2419.2419] INFO QwspMessageSender: [0x227d008]: Sending Payload message
Aug 30 18:04:59 volumio-bwk5-rpi5 sudo[9295]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-30 18:03'
Aug 30 18:04:59 volumio-bwk5-rpi5 sudo[9295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="ad2b65e62ee66106fc9799a5d56d019303babfad"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="9938d7179e3b7c4e41f3e2d60c255985cff08fee"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Aug 25 08:06:05 UTC 2026"
VOLUMIO_VERSION="4.194"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="454605b41233fa2c5fb1a1c1e886fec8"