-- Logs begin at Sat 2024-11-16 09:28:11 NZDT, end at Sun 2024-11-24 17:27:24 NZDT. -- Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 24 17:26:00 volumio volumio[948]: info: Retrieving Cloud Streaming UI Nov 24 17:26:00 volumio volumio[948]: info: Getting Tidal Cloud Configuration Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 24 17:26:00 volumio volumio[948]: info: Getting Qobuz Cloud Configuration Nov 24 17:26:00 volumio volumio[948]: info: Asking plugin for UI Config Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 24 17:26:00 volumio volumio[948]: info: Getting Spotify Cloud Configuration Nov 24 17:26:00 volumio volumio[948]: info: Asking plugin for UI Config Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 24 17:26:00 volumio volumio[948]: info: Saving Spotify Acccount Nov 24 17:26:00 volumio volumio[948]: info: Got Tidal Cloud Configuration Nov 24 17:26:00 volumio volumio[948]: info: Got it Nov 24 17:26:00 volumio volumio[948]: info: Got it Nov 24 17:26:00 volumio volumio[948]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 24 17:26:00 volumio volumio[948]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 24 17:26:00 volumio volumio[948]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, scandir '/mnt/USB/14FC-1612' Nov 24 17:26:00 volumio volumio[948]: at Object.readdirSync (fs.js:1021:3) Nov 24 17:26:00 volumio volumio[948]: at searchInFolder (/volumio/app/plugins/miscellanea/albumart/albumart.js:249:20) Nov 24 17:26:00 volumio volumio[948]: at processRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:385:11) Nov 24 17:26:00 volumio volumio[948]: at processExpressRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:433:17) Nov 24 17:26:00 volumio volumio[948]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Nov 24 17:26:00 volumio volumio[948]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Nov 24 17:26:00 volumio volumio[948]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Nov 24 17:26:00 volumio volumio[948]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Nov 24 17:26:00 volumio volumio[948]: at /volumio/node_modules/express/lib/router/index.js:281:22 Nov 24 17:26:00 volumio volumio[948]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Nov 24 17:26:00 volumio volumio[948]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Nov 24 17:26:00 volumio volumio[948]: at allowCrossDomain (/volumio/http/index.js:39:5) Nov 24 17:26:00 volumio volumio[948]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Nov 24 17:26:00 volumio volumio[948]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Nov 24 17:26:00 volumio volumio[948]: at /volumio/node_modules/express/lib/router/index.js:284:7 Nov 24 17:26:00 volumio volumio[948]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::volumioGetBrowseSources Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::volumioGetBrowseSources Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::volumioGetBrowseSources Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 24 17:26:04 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:08 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:09 volumio volumio[948]: info: Enabling MyMusic plugin metavolumio Nov 24 17:26:09 volumio volumio[948]: info: [MyVolumio PluginManager] Enabling and starting plugin miscellanea metavolumio Nov 24 17:26:09 volumio volumio[948]: info: [MyVolumio PluginManager] Plugin miscellanea metavolumio not in user plan, not enabling Nov 24 17:26:09 volumio volumio[948]: info: Error: Plugin miscellanea metavolumio not in user plan, not enabling Nov 24 17:26:09 volumio volumio[948]: error: Could not Enable MyMusic Plugin: Error Nov 24 17:26:12 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:16 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:20 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:24 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:26 volumio volumio[948]: info: CALLMETHOD: miscellanea albumart saveAlbumartOptions [object Object] Nov 24 17:26:26 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , saveAlbumartOptions Nov 24 17:26:28 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:32 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:34 volumio volumio[948]: info: CALLMETHOD: music_service mpd saveMusicLibraryOptions [object Object] Nov 24 17:26:34 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , saveMusicLibraryOptions Nov 24 17:26:36 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:40 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:44 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 24 17:26:48 volumio volumio[948]: info: CoreCommandRouter::volumioGetState Nov 24 17:26:48 volumio volumio[948]: info: CorePlayQueue::getTrack 16 Nov 24 17:26:49 volumio nmbd[614]: [2024/11/24 17:26:49.078333, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Nov 24 17:26:49 volumio nmbd[614]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.2.117 for name WORKGROUP<1d>. Nov 24 17:26:49 volumio nmbd[614]: This response was from IP 192.168.2.62, reporting an IP address of 192.168.2.62. Nov 24 17:26:49 volumio nmbd[614]: [2024/11/24 17:26:49.078628, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Nov 24 17:26:49 volumio nmbd[614]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.2.69 for name WORKGROUP<1d>. Nov 24 17:26:49 volumio nmbd[614]: This response was from IP 192.168.2.62, reporting an IP address of 192.168.2.62. Nov 24 17:26:51 volumio volumio[948]: info: CoreCommandRouter::volumioGetQueue Nov 24 17:26:51 volumio volumio[948]: info: CoreStateMachine::getQueue Nov 24 17:26:51 volumio volumio[948]: info: CorePlayQueue::getQueue Nov 24 17:26:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:26:57 volumio volumio[948]: info: Preload queue cleared Nov 24 17:27:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:04 volumio volumio[948]: info: Preload queue cleared Nov 24 17:27:05 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:10 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:12 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:12 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:17 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:18 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:19 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:19 volumio volumio[948]: info: Preload queue cleared Nov 24 17:27:19 volumio volumio[948]: info: Preload queue cleared Nov 24 17:27:20 volumio volumio[948]: info: Preload queue cleared Nov 24 17:27:23 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 24 17:27:23 volumio volumio[948]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 17:27:23 volumio volumio[948]: TypeError: Cannot read property 'length' of undefined Nov 24 17:27:23 volumio volumio[948]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Nov 24 17:27:23 volumio volumio[948]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Nov 24 17:27:23 volumio volumio[948]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Nov 24 17:27:23 volumio volumio[948]: at Parser.emit (events.js:315:20) Nov 24 17:27:23 volumio volumio[948]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Nov 24 17:27:23 volumio volumio[948]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Nov 24 17:27:23 volumio volumio[948]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Nov 24 17:27:23 volumio volumio[948]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Nov 24 17:27:23 volumio volumio[948]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Nov 24 17:27:23 volumio volumio[948]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Nov 24 17:27:23 volumio volumio[948]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Nov 24 17:27:23 volumio volumio[948]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Nov 24 17:27:23 volumio volumio[948]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Nov 24 17:27:23 volumio volumio[948]: at IncomingMessage.emit (events.js:327:22) Nov 24 17:27:23 volumio volumio[948]: at endReadableNT (internal/streams/readable.js:1327:12) Nov 24 17:27:23 volumio volumio[948]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 24 17:27:23 volumio volumio[948]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 17:27:24 volumio sudo[7456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-24 17:26 Nov 24 17:27:24 volumio sudo[7456]: 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="f8baf7ad070f376535a93fcc6590774528ddb153" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET" VOLUMIO_VERSION="3.611" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"