-- Logs begin at Wed 2025-12-24 05:24:34 CET, end at Wed 2025-12-24 18:29:13 CET. -- Dec 24 18:28:14 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 24 18:28:15 primo volumio[3396]: info: Preload queue cleared Dec 24 18:28:31 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 24 18:28:31 primo volumio[3396]: info: Received Get System Info Dec 24 18:28:31 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 24 18:28:31 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 24 18:28:31 primo volumio[3396]: info: Discovery: Getting this device information Dec 24 18:28:31 primo volumio[3396]: info: CoreCommandRouter::volumioGetState Dec 24 18:28:31 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 24 18:28:35 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 24 18:28:36 primo volumio[3396]: info: Preload queue cleared Dec 24 18:28:40 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 24 18:28:40 primo volumio[3396]: info: Preload queue cleared Dec 24 18:28:40 primo volumio[3396]: info: Preloading song: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-5807759675469091916-co6D67580B237A7302 Dec 24 18:28:40 primo volumio[3396]: info: Preloading song: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d8977244189775578396-co6D67580B237A7302 Dec 24 18:28:40 primo volumio[3396]: info: Preloading song: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-3966767913920104175-co6D67580B237A7302 Dec 24 18:28:40 primo volumio[3396]: info: Preloading song: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d1097630780658275832-co6D67580B237A7302 Dec 24 18:28:40 primo volumio[3396]: info: Preloading song: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-8361590798927039966-co6D67580B237A7302 Dec 24 18:28:40 primo volumio[3396]: info: Preloading song: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-9121704999059600734-co6D67580B237A7302 Dec 24 18:28:40 primo volumio[3396]: info: Preloading song: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d4105099306776751139-co6D67580B237A7302 Dec 24 18:28:40 primo volumio[3396]: info: Preloading song: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-6017452394370909002-co6D67580B237A7302 Dec 24 18:28:40 primo volumio[3396]: info: Exploding uri upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-5807759675469091916-co6D67580B237A7302 in service upnp_browser Dec 24 18:28:40 primo volumio[3396]: info: Exploding uri upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d8977244189775578396-co6D67580B237A7302 in service upnp_browser Dec 24 18:28:40 primo volumio[3396]: info: Executing endpoint getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: Executing endpoint getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: Executing endpoint getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: Exploding uri upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-3966767913920104175-co6D67580B237A7302 in service upnp_browser Dec 24 18:28:40 primo volumio[3396]: info: Exploding uri upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d1097630780658275832-co6D67580B237A7302 in service upnp_browser Dec 24 18:28:40 primo volumio[3396]: info: Executing endpoint getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: Executing endpoint getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Dec 24 18:28:40 primo volumio[3396]: info: Exploding uri upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-8361590798927039966-co6D67580B237A7302 in service upnp_browser Dec 24 18:28:40 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:40 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:40 primo volumio[3396]: info: Exploding uri upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-9121704999059600734-co6D67580B237A7302 in service upnp_browser Dec 24 18:28:40 primo volumio[3396]: info: Exploding uri upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d4105099306776751139-co6D67580B237A7302 in service upnp_browser Dec 24 18:28:40 primo volumio[3396]: info: Exploding uri upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d-6017452394370909002-co6D67580B237A7302 in service upnp_browser Dec 24 18:28:40 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:40 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:41 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:41 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:41 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:41 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:41 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:41 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:42 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:42 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:42 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:42 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:44 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:44 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:44 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:44 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:44 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:28:44 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:28:48 primo volumio[3396]: error: Failed request for metavolumio API Dec 24 18:28:49 primo volumio[3396]: error: Failed request for metavolumio API Dec 24 18:28:51 primo volumio[3396]: error: Failed request for metavolumio API Dec 24 18:28:53 primo volumio[3396]: STREAMING PROXY: Client dropped request, destroying Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 24 18:28:57 primo volumio[3396]: info: Discovery: Getting this device information Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::volumioGetState Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 24 18:28:57 primo volumio[3396]: verbose: New Socket.io Connection to 192.168.85.53:3000 from 192.168.85.47 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 24 18:28:57 primo volumio[3396]: info: Discovery: Getting this device information Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::volumioGetState Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 24 18:28:57 primo volumio[3396]: verbose: New Socket.io Connection to 192.168.85.52:3000 from 192.168.85.47 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 24 18:28:57 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 24 18:29:03 primo volumio[3396]: info: CoreCommandRouter::volumioplayNextItems Dec 24 18:29:03 primo volumio[3396]: info: CoreStateMachine::playNextItems Dec 24 18:29:03 primo volumio[3396]: info: CorePlayQueue::addPlayNextItems Dec 24 18:29:03 primo volumio[3396]: info: Preload queue cleared Dec 24 18:29:03 primo volumio[3396]: info: Adding Item to play next: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d4105099306776751139-co6D67580B237A7302 Dec 24 18:29:03 primo volumio[3396]: info: Using cached record of: upnp/http://192.168.85.45:26125/ContentDirectory/FED9D74B-ADE0-FAD5-0-123456789abc/control.xml@d4105099306776751139-co6D67580B237A7302 Dec 24 18:29:03 primo volumio[3396]: info: CoreCommandRouter::volumioPushQueue Dec 24 18:29:03 primo volumio[3396]: info: CorePlayQueue::saveQueue Dec 24 18:29:03 primo volumio[3396]: info: CoreStateMachine::updateTrackBlock Dec 24 18:29:03 primo volumio[3396]: info: CorePlayQueue::getTrackBlock Dec 24 18:29:09 primo volumio[3396]: info: CoreCommandRouter::volumioGetState Dec 24 18:29:09 primo volumio[3396]: info: CorePlayQueue::getTrack 1 Dec 24 18:29:09 primo volumio[3396]: info: CorePlayQueue::getTrack 2 Dec 24 18:29:10 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:29:10 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:29:10 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:29:10 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:29:11 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:29:11 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:29:11 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:29:11 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:29:11 primo volumio[3396]: info: Executing endpoint metavolumio Dec 24 18:29:11 primo volumio[3396]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 24 18:29:12 primo volumio[3396]: info: CoreCommandRouter::volumioGetState Dec 24 18:29:13 primo volumio[3396]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 24 18:29:13 primo volumio[3396]: TypeError: Cannot read property 'slice' of null Dec 24 18:29:13 primo volumio[3396]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 24 18:29:13 primo volumio[3396]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 24 18:29:13 primo volumio[3396]: at Object.onceWrapper (events.js:520:26) Dec 24 18:29:13 primo volumio[3396]: at ClientRequest.emit (events.js:400:28) Dec 24 18:29:13 primo volumio[3396]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Dec 24 18:29:13 primo volumio[3396]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Dec 24 18:29:13 primo volumio[3396]: at TLSSocket.socketOnData (_http_client.js:515:22) Dec 24 18:29:13 primo volumio[3396]: at TLSSocket.emit (events.js:400:28) Dec 24 18:29:13 primo volumio[3396]: at addChunk (internal/streams/readable.js:293:12) Dec 24 18:29:13 primo volumio[3396]: at readableAddChunk (internal/streams/readable.js:267:9) Dec 24 18:29:13 primo volumio[3396]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Dec 24 18:29:13 primo volumio[3396]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Dec 24 18:29:13 primo volumio[3396]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 24 18:29:13 primo sudo[16946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-24 18:28 Dec 24 18:29:13 primo sudo[16946]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 07:52:21 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="060c5b31331b90c840ee52059a8e3db0"