-- Logs begin at Thu 2024-09-05 03:34:51 CEST, end at Thu 2024-09-05 12:22:17 CEST. -- Sep 05 12:21:05 volumio-3 go-librespot[1222]: time="2024-09-05T12:21:05+02:00" level=debug msg="fetched chunk 11/25, size: 524288" uri="spotify:track:0MVV5qvdj439PGVWPlCZp3" Sep 05 12:21:06 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:06 volumio-3 volumio[1001]: info: CURURI: music-library Sep 05 12:21:06 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:07 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:07 volumio-3 volumio[1001]: info: CURURI: music-library Sep 05 12:21:07 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:10 volumio-3 volumiologrotate[635]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Sep 05 12:21:10 volumio-3 volumiologrotate[635]: ls: cannot access '3': No such file or directory Sep 05 12:21:10 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:10 volumio-3 volumio[1001]: info: CURURI: music-library/USB Sep 05 12:21:10 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:17 volumio-3 go-librespot[1222]: time="2024-09-05T12:21:17+02:00" level=debug msg="fetched chunk 12/25, size: 524288" uri="spotify:track:0MVV5qvdj439PGVWPlCZp3" Sep 05 12:21:30 volumio-3 go-librespot[1222]: time="2024-09-05T12:21:30+02:00" level=debug msg="fetched chunk 13/25, size: 524288" uri="spotify:track:0MVV5qvdj439PGVWPlCZp3" Sep 05 12:21:36 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:36 volumio-3 volumio[1001]: info: CURURI: music-library Sep 05 12:21:36 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:38 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:38 volumio-3 volumio[1001]: info: CURURI: playlists Sep 05 12:21:38 volumio-3 volumio[1001]: info: Listing playlists Sep 05 12:21:38 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:42 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:42 volumio-3 volumio[1001]: info: CURURI: artists:// Sep 05 12:21:42 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:44 volumio-3 go-librespot[1222]: time="2024-09-05T12:21:44+02:00" level=debug msg="fetched chunk 14/25, size: 524288" uri="spotify:track:0MVV5qvdj439PGVWPlCZp3" Sep 05 12:21:44 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:44 volumio-3 volumio[1001]: info: CURURI: albums:// Sep 05 12:21:44 volumio-3 volumio[1001]: info: listAlbums - loading Albums from cache Sep 05 12:21:44 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:44 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:44 volumio-3 volumio[1001]: info: CURURI: albums:// Sep 05 12:21:44 volumio-3 volumio[1001]: info: listAlbums - loading Albums from cache Sep 05 12:21:44 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:48 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:48 volumio-3 volumio[1001]: info: CURURI: genres:// Sep 05 12:21:48 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:48 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 12:21:48 volumio-3 volumio[1001]: info: CURURI: genres:// Sep 05 12:21:48 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:51 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 05 12:21:51 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:21:53 volumio-3 volumio[1001]: 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' Sep 05 12:21:57 volumio-3 go-librespot[1222]: time="2024-09-05T12:21:57+02:00" level=debug msg="fetched chunk 15/25, size: 524288" uri="spotify:track:0MVV5qvdj439PGVWPlCZp3" Sep 05 12:21:59 volumio-3 volumio[1001]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Sep 05 12:21:59 volumio-3 volumio[1001]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Sep 05 12:21:59 volumio-3 volumio[1001]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Sep 05 12:21:59 volumio-3 volumio[1001]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Sep 05 12:21:59 volumio-3 volumio[1001]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Sep 05 12:21:59 volumio-3 volumio[1001]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Sep 05 12:21:59 volumio-3 volumio[1001]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Sep 05 12:21:59 volumio-3 volumio[1001]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Sep 05 12:22:03 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 05 12:22:03 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:22:08 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 05 12:22:08 volumio-3 volumio[1001]: info: Preload queue cleared Sep 05 12:22:10 volumio-3 go-librespot[1222]: time="2024-09-05T12:22:10+02:00" level=debug msg="fetched chunk 16/25, size: 524288" uri="spotify:track:0MVV5qvdj439PGVWPlCZp3" Sep 05 12:22:10 volumio-3 volumiologrotate[635]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Sep 05 12:22:10 volumio-3 volumiologrotate[635]: ls: cannot access '3': No such file or directory Sep 05 12:22:16 volumio-3 volumio[1001]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 05 12:22:16 volumio-3 volumio[1001]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 12:22:16 volumio-3 volumio[1001]: TypeError: Cannot read property 'length' of undefined Sep 05 12:22:16 volumio-3 volumio[1001]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Sep 05 12:22:16 volumio-3 volumio[1001]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Sep 05 12:22:16 volumio-3 volumio[1001]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Sep 05 12:22:16 volumio-3 volumio[1001]: at Parser.emit (events.js:315:20) Sep 05 12:22:16 volumio-3 volumio[1001]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Sep 05 12:22:16 volumio-3 volumio[1001]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Sep 05 12:22:16 volumio-3 volumio[1001]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Sep 05 12:22:16 volumio-3 volumio[1001]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Sep 05 12:22:16 volumio-3 volumio[1001]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Sep 05 12:22:16 volumio-3 volumio[1001]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Sep 05 12:22:16 volumio-3 volumio[1001]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Sep 05 12:22:16 volumio-3 volumio[1001]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Sep 05 12:22:16 volumio-3 volumio[1001]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Sep 05 12:22:16 volumio-3 volumio[1001]: at IncomingMessage.emit (events.js:327:22) Sep 05 12:22:16 volumio-3 volumio[1001]: at endReadableNT (internal/streams/readable.js:1327:12) Sep 05 12:22:16 volumio-3 volumio[1001]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Sep 05 12:22:16 volumio-3 volumio[1001]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 12:22:17 volumio-3 sudo[2923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-05 12:21 Sep 05 12:22:17 volumio-3 sudo[2923]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"