-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2024-04-27 18:57:38 CEST. -- Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: handleBrowseUri took 442 milliseconds Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preload queue cleared Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499330 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499331 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499332 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499333 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499334 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499335 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499336 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499337 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499338 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499339 Apr 27 18:56:39 volumio-rpi5-8gb volumio[982]: info: Preloading song: qobuz://song/499340 Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499330 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499331 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499332 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Executing endpoint getSimilarAlbums Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Executing endpoint getSimilarAlbums Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499333 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499334 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Executing endpoint metavolumio Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Executing endpoint metavolumio Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Executing endpoint metavolumio Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Executing endpoint metavolumio Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499335 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 297 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499336 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499337 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 310 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 282 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499338 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499339 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 337 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: Exploding uri qobuz://song/499340 in service qobuz Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 310 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 325 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 276 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 302 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 314 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 278 milliseconds Apr 27 18:56:40 volumio-rpi5-8gb volumio[982]: info: explodeUri took 324 milliseconds Apr 27 18:56:47 volumio-rpi5-8gb volumio[982]: error: Failed request for metavolumio API Apr 27 18:57:07 volumio-rpi5-8gb volumio[982]: info: Listing playlists Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: info: [now-playing] Fetching API key... Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not fetch weather: Could not obtain API key Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:114:19) Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: at runMicrotasks () Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:113:28) Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: (node:982) UnhandledPromiseRejectionWarning: Error: Could not obtain API key Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: at doGet (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:124:19) Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: at runMicrotasks () Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 27 18:57:21 volumio-rpi5-8gb volumio[982]: (node:982) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 51) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: qobuz , explodeUri Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: info: explodeUri took 237 milliseconds Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: info: Saving Cloud item Mary J. Blige Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , saveCloudItem Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: Error: Reference.child failed: First argument was an invalid path = "/user_data/7dw50ZCOjeRDCz7C1TAL0h4A9CR2/myPlaylists/Mary J. Blige". Paths must be non-empty strings and can't contain ".", "#", "$", "[", or "]" Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at validatePathString (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:1667:15) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at validateRootPathString (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:1679:5) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at Reference.child (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:13737:17) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at Database.ref (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:15115:48) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at myVolumio.syncJSONToCloud (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:28817) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at myVolumio.saveCloudMyPlaylist (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:23840) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at myVolumio.saveCloudItem (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:18337) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at PlaylistManager.saveJSONFile (/volumio/app/playlistManager.js:613:31) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at /volumio/app/playlistManager.js:588:20 Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at /volumio/node_modules/jsonfile/index.js:46:5 Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at /volumio/node_modules/graceful-fs/graceful-fs.js:123:16 Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: at FSReqCallback.readFileAfterClose [as oncomplete] (internal/fs/read_file_context.js:63:3) Apr 27 18:57:38 volumio-rpi5-8gb volumio[982]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 18:57:38 volumio-rpi5-8gb sudo[10577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-27 18:56 Apr 27 18:57:38 volumio-rpi5-8gb sudo[10577]: 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="b51559ff3f3719e35ff52cb9ccf2ff401b5ecb06" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="9f81dc1810002a5ad8861a42d98d57bc06a5d5d3" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 17 Apr 2024 07:54:00 PM CEST" VOLUMIO_VERSION="3.649" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="9c6dee1ade565aed57d77a70a260b988"