-- Logs begin at Thu 2019-02-14 05:11:58 EST, end at Tue 2026-01-13 10:26:40 EST. -- Jan 13 10:25:30 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 10:25:30 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 10:25:30 volumiopi4 volumio[1213]: info: Discovery: Getting this device information Jan 13 10:25:30 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetState Jan 13 10:25:30 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:25:30 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 10:25:31 volumiopi4 volumio[1213]: verbose: New Socket.io Connection to 192.168.1.159:3000 from 192.168.1.71 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 10:25:31 volumiopi4 volumio[1213]: info: Discovery: Getting this device information Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetState Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 10:25:31 volumiopi4 volumio[1213]: verbose: New Socket.io Connection to 192.168.1.161:3000 from 192.168.1.71 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 13 10:25:31 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 13 10:25:58 volumiopi4 volumio[1213]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.71 UA: Mozilla/5.0 (Linux; Android 16; SM-S938U1 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetState Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetQueue Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreStateMachine::getQueue Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CorePlayQueue::getQueue Jan 13 10:25:58 volumiopi4 volumio[1213]: info: Listing playlists Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 13 10:25:58 volumiopi4 volumio[1213]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 13 10:25:58 volumiopi4 volumio[1213]: info: Received Get System Info Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 10:25:58 volumiopi4 volumio[1213]: info: Discovery: Getting this device information Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetState Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetState Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 10:25:58 volumiopi4 volumio[1213]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 10:25:58 volumiopi4 volumio[1213]: info: FusionDsp - Meze Elite hybrid Jan 13 10:25:58 volumiopi4 volumio[1213]: info: FusionDsp - Meze Elite hybrid Jan 13 10:25:59 volumiopi4 volumio[1213]: info: FusionDsp - Empyrean basic.json,Empyrean ii alcantara.json,Empyrean ii duo.json,Empyrean leather.json,Meze Elite alcantara.json,Meze Elite hybrid.json,Meze empyrean alcantara.json Jan 13 10:25:59 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 13 10:25:59 volumiopi4 volumio[1213]: info: FusionDsp - Empyrean basic.json,Empyrean ii alcantara.json,Empyrean ii duo.json,Empyrean leather.json,Meze Elite alcantara.json,Meze Elite hybrid.json,Meze empyrean alcantara.json Jan 13 10:26:13 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jan 13 10:26:13 volumiopi4 volumio[1213]: info: handleBrowseUri took 100 milliseconds Jan 13 10:26:13 volumiopi4 volumio[1213]: info: Preload queue cleared Jan 13 10:26:13 volumiopi4 volumio[1213]: info: Preload queue cleared Jan 13 10:26:15 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jan 13 10:26:17 volumiopi4 volumio[1213]: info: handleBrowseUri took 2369 milliseconds Jan 13 10:26:17 volumiopi4 volumio[1213]: info: Preload queue cleared Jan 13 10:26:19 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jan 13 10:26:19 volumiopi4 volumio[1213]: info: handleBrowseUri took 329 milliseconds Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preload queue cleared Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669287 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669288 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669289 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669290 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669291 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669292 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669293 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669294 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669295 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Preloading song: qobuz://song/372669296 Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669287 in service qobuz Jan 13 10:26:19 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:19 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669288 in service qobuz Jan 13 10:26:19 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669289 in service qobuz Jan 13 10:26:20 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Executing endpoint getSimilarAlbums Jan 13 10:26:20 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669290 in service qobuz Jan 13 10:26:20 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669291 in service qobuz Jan 13 10:26:20 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Executing endpoint metavolumio Jan 13 10:26:20 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Executing endpoint metavolumio Jan 13 10:26:20 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669292 in service qobuz Jan 13 10:26:20 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 278 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 237 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669293 in service qobuz Jan 13 10:26:20 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669294 in service qobuz Jan 13 10:26:20 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 287 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669295 in service qobuz Jan 13 10:26:20 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: Exploding uri qobuz://song/372669296 in service qobuz Jan 13 10:26:20 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 300 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 326 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 315 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 269 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 326 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 266 milliseconds Jan 13 10:26:20 volumiopi4 volumio[1213]: info: explodeUri took 461 milliseconds Jan 13 10:26:27 volumiopi4 volumio[1213]: info: Preload queue cleared Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::ClearQueue Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::stop Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CorePlayQueue::clearPlayQueue Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CorePlayQueue::saveQueue Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioPushQueue Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::addQueueItems Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CorePlayQueue::addQueueItems Jan 13 10:26:27 volumiopi4 volumio[1213]: info: Preload queue cleared Jan 13 10:26:27 volumiopi4 volumio[1213]: info: Adding Item to queue: qobuz://album/xhmnzrn13otxd Jan 13 10:26:27 volumiopi4 volumio[1213]: info: Exploding uri qobuz://album/xhmnzrn13otxd in service qobuz Jan 13 10:26:27 volumiopi4 volumio[1213]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 13 10:26:27 volumiopi4 volumio[1213]: info: explodeUri took 185 milliseconds Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioPushQueue Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CorePlayQueue::saveQueue Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::updateTrackBlock Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrackBlock Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioPlay Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::play index 0 Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::stop Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::play index undefined Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreStateMachine::startPlaybackTimer Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:26:27 volumiopi4 volumio[1213]: info: [1768317987772] ControllerQobuz::clearAddPlayTrack Jan 13 10:26:27 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 10:26:27 volumiopi4 volumio[1213]: info: sendMpdCommand stop took 6 milliseconds Jan 13 10:26:27 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 10:26:27 volumiopi4 volumio[1213]: info: Jan 13 10:26:27 volumiopi4 volumio[1213]: ---------------------------- MPD announces system playlist update Jan 13 10:26:27 volumiopi4 volumio[1213]: info: Ignoring MPD Status Update Jan 13 10:26:27 volumiopi4 volumio[1213]: info: sendMpdCommand clear took 2 milliseconds Jan 13 10:26:27 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/372669287" Jan 13 10:26:27 volumiopi4 volumio[1213]: error: updateQueue error: null Jan 13 10:26:27 volumiopi4 volumio[1213]: info: ------------------------------ 3ms Jan 13 10:26:27 volumiopi4 volumio[1213]: STREAMING PROXY: Handling url /?data=qobuz://song/372669287 Jan 13 10:26:27 volumiopi4 volumio[1213]: info: Executing endpoint getStreamUrlqobuz Jan 13 10:26:27 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jan 13 10:26:28 volumiopi4 volumio[1213]: info: getStreamUrl took 251 milliseconds Jan 13 10:26:28 volumiopi4 volumio[1213]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2675691&eid=372669287&fmt=7&profile=raw&app_id=539451548&cid=1858634&etsp=1768321587&hmac=Jb1IOuO_E3ZZV0YMFUUXUAt7Pwg Jan 13 10:26:29 volumiopi4 volumio[1213]: STREAMING PROXY: Response: 200, length: 61617328 Jan 13 10:26:29 volumiopi4 volumio[1213]: STREAMING PROXY: Client dropped request, destroying Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/372669287" Jan 13 10:26:29 volumiopi4 volumio[1213]: info: Jan 13 10:26:29 volumiopi4 volumio[1213]: ---------------------------- MPD announces system playlist update Jan 13 10:26:29 volumiopi4 volumio[1213]: info: Ignoring MPD Status Update Jan 13 10:26:29 volumiopi4 volumio[1213]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/372669287" took 1 milliseconds Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand play Jan 13 10:26:29 volumiopi4 volumio[1213]: info: ------------------------------ 3ms Jan 13 10:26:29 volumiopi4 volumio[1213]: info: sendMpdCommand play took 2 milliseconds Jan 13 10:26:29 volumiopi4 volumio[1213]: STREAMING PROXY: Handling url /?data=qobuz://song/372669287 Jan 13 10:26:29 volumiopi4 volumio[1213]: info: Executing endpoint getStreamUrlqobuz Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jan 13 10:26:29 volumiopi4 volumio[1213]: info: getStreamUrl took 227 milliseconds Jan 13 10:26:29 volumiopi4 volumio[1213]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2675691&eid=372669287&fmt=7&profile=raw&app_id=539451548&cid=1858634&etsp=1768321589&hmac=x0fP5zJUSCeCLXdq_w1O2RezZ84 Jan 13 10:26:29 volumiopi4 volumio[1213]: STREAMING PROXY: Response: 200, length: 61617328 Jan 13 10:26:29 volumiopi4 volumio[1213]: info: Jan 13 10:26:29 volumiopi4 volumio[1213]: ---------------------------- MPD announces state update: player Jan 13 10:26:29 volumiopi4 volumio[1213]: info: ControllerMpd::getState Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand status Jan 13 10:26:29 volumiopi4 volumio[1213]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 13 10:26:29 volumiopi4 volumio[1213]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 13 10:26:29 volumiopi4 volumio[1213]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 13 10:26:29 volumiopi4 volumio[1213]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 13 10:26:29 volumiopi4 volumio[1213]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 13 10:26:29 volumiopi4 volumio[1213]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 13 10:26:29 volumiopi4 volumio[1213]: info: Jan 13 10:26:29 volumiopi4 volumio[1213]: ---------------------------- MPD announces state update: player Jan 13 10:26:29 volumiopi4 volumio[1213]: info: sendMpdCommand status took 30 milliseconds Jan 13 10:26:29 volumiopi4 volumio[1213]: info: ControllerMpd::getState Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand status Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::parseState Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 10:26:29 volumiopi4 volumio[1213]: info: sendMpdCommand status took 3 milliseconds Jan 13 10:26:29 volumiopi4 volumio[1213]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::parseState Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::parseTrackInfo Jan 13 10:26:29 volumiopi4 volumio[1213]: info: ControllerMpd::pushState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreCommandRouter::servicePushState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"372669287","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/372669287","trackType":"qobuz"} Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: CURRENT POSITION 0 Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreStateMachine::syncState stateService play Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreStateMachine::syncState currentStatus stop Jan 13 10:26:29 volumiopi4 volumio[1213]: info: ------------------------------ 38ms Jan 13 10:26:29 volumiopi4 volumio[1213]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: ControllerMpd::parseTrackInfo Jan 13 10:26:29 volumiopi4 volumio[1213]: info: ControllerMpd::pushState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreCommandRouter::servicePushState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CorePlayQueue::getTrack 0 Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"372669287","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/372669287","trackType":"qobuz"} Jan 13 10:26:29 volumiopi4 volumio[1213]: verbose: CURRENT POSITION 0 Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreStateMachine::syncState stateService play Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreStateMachine::syncState currentStatus play Jan 13 10:26:29 volumiopi4 volumio[1213]: info: Received an update from plugin. extracting info from payload Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreStateMachine::pushState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioPushState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: MRS: Pushing multiroomSync output update for this device Jan 13 10:26:29 volumiopi4 volumio[1213]: info: MRS: Pushing multiroomSync output Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreStateMachine::pushState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioPushState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: MRS: Pushing multiroomSync output update for this device Jan 13 10:26:29 volumiopi4 volumio[1213]: info: MRS: Pushing multiroomSync output Jan 13 10:26:29 volumiopi4 volumio[1213]: info: CoreCommandRouter::volumioGetState Jan 13 10:26:29 volumiopi4 volumio[1213]: info: ------------------------------ 43ms Jan 13 10:26:29 volumiopi4 volumio[1213]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 13 10:26:29 volumiopi4 volumio[1213]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 13 10:26:32 volumiopi4 volumio[1213]: STREAMING PROXY: Client dropped request, destroying Jan 13 10:26:37 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 13 10:26:37 volumiopi4 volumio[1213]: info: CURURI: artists:// Jan 13 10:26:37 volumiopi4 volumio[1213]: info: Preload queue cleared Jan 13 10:26:39 volumiopi4 volumio[1213]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 13 10:26:39 volumiopi4 volumio[1213]: info: CURURI: genres:// Jan 13 10:26:39 volumiopi4 volumio[1213]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Jan 13 10:26:39 volumiopi4 volumio[1213]: info: Preload queue cleared Jan 13 10:26:40 volumiopi4 volumio[1213]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 10:26:40 volumiopi4 volumio[1213]: TypeError: Cannot read property 'slice' of null Jan 13 10:26:40 volumiopi4 volumio[1213]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Jan 13 10:26:40 volumiopi4 volumio[1213]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Jan 13 10:26:40 volumiopi4 volumio[1213]: at Object.onceWrapper (events.js:422:26) Jan 13 10:26:40 volumiopi4 volumio[1213]: at ClientRequest.emit (events.js:315:20) Jan 13 10:26:40 volumiopi4 volumio[1213]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Jan 13 10:26:40 volumiopi4 volumio[1213]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Jan 13 10:26:40 volumiopi4 volumio[1213]: at TLSSocket.socketOnData (_http_client.js:509:22) Jan 13 10:26:40 volumiopi4 volumio[1213]: at TLSSocket.emit (events.js:315:20) Jan 13 10:26:40 volumiopi4 volumio[1213]: at addChunk (internal/streams/readable.js:309:12) Jan 13 10:26:40 volumiopi4 volumio[1213]: at readableAddChunk (internal/streams/readable.js:284:9) Jan 13 10:26:40 volumiopi4 volumio[1213]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Jan 13 10:26:40 volumiopi4 volumio[1213]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Jan 13 10:26:40 volumiopi4 volumio[1213]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 10:26:40 volumiopi4 sudo[3158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-13 10:25 Jan 13 10:26:40 volumiopi4 sudo[3158]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"