-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sat 2025-07-05 05:20:19 CST. -- Jul 05 05:19:02 volumio volumio-remote-updater[519]: [2025-07-05 05:19:02] [connect] Successful connection Jul 05 05:19:15 volumio volumio-remote-updater[519]: [2025-07-05 05:19:15] [connect] Successful connection Jul 05 05:19:30 volumio volumio-remote-updater[519]: [2025-07-05 05:19:30] [connect] Successful connection Jul 05 05:19:34 volumio volumio[846]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 05 05:19:35 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 05 05:19:35 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 05:19:35 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 05:19:35 volumio volumio[846]: info: Starting MyVolumio Remote Streaming Endpoints Jul 05 05:19:35 volumio volumio[846]: info: MyVolumio login type: Token Jul 05 05:19:35 volumio volumio[846]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 05 05:19:35 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 05 05:19:41 volumio volumio[846]: info: Starting Streaming Service Transparent Proxy Jul 05 05:19:41 volumio volumio[846]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 05 05:19:41 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 05 05:19:41 volumio volumio[846]: info: Streaming services startup Jul 05 05:19:41 volumio volumio[846]: info: Starting Streaming Daemon Jul 05 05:19:41 volumio volumio[846]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 05 05:19:42 volumio sudo[2051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 05 05:19:42 volumio sudo[2051]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 05:19:42 volumio volumio[846]: info: [now-playing] OpenWeatherMap API key obtained. Jul 05 05:19:42 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 05 05:19:42 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 05 05:19:42 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 05 05:19:42 volumio volumio[846]: info: Version has changed, forcing UI Reload Jul 05 05:19:42 volumio volumio[846]: info: CoreCommandRouter::Reload Ui Jul 05 05:19:42 volumio volumio[846]: info: BOOT COMPLETED Jul 05 05:19:42 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Jul 05 05:19:42 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Jul 05 05:19:42 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 05:19:42 volumio volumio[846]: info: Discovery: Getting this device information Jul 05 05:19:42 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Jul 05 05:19:42 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Jul 05 05:19:42 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 05:19:43 volumio volumio[846]: info: Listing playlists Jul 05 05:19:43 volumio volumio[846]: info: Listing playlists Jul 05 05:19:43 volumio sudo[2051]: pam_unix(sudo:session): session closed for user root Jul 05 05:19:43 volumio volumio[846]: error: Cannot start Volumio Streaming Daemon Jul 05 05:19:43 volumio volumio[846]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 05 05:19:43 volumio volumio[846]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 05 05:19:44 volumio volumio[846]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=30.27995&lon=120.16221: Error: Response error: 401 - Unauthorized Jul 05 05:19:44 volumio volumio[846]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Jul 05 05:19:44 volumio volumio[846]: at runMicrotasks () Jul 05 05:19:44 volumio volumio[846]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jul 05 05:19:44 volumio volumio[846]: at async Promise.all (index 0) Jul 05 05:19:44 volumio volumio[846]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Jul 05 05:19:44 volumio volumio[846]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Jul 05 05:19:44 volumio volumio[846]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Jul 05 05:19:47 volumio volumio-remote-updater[519]: [2025-07-05 05:19:45] [connect] Successful connection Jul 05 05:19:47 volumio volumio[846]: (node:846) UnhandledPromiseRejectionWarning: Error: Response error: 401 - Unauthorized Jul 05 05:19:47 volumio volumio[846]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Jul 05 05:19:47 volumio volumio[846]: at runMicrotasks () Jul 05 05:19:47 volumio volumio[846]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jul 05 05:19:47 volumio volumio[846]: at async Promise.all (index 0) Jul 05 05:19:47 volumio volumio[846]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Jul 05 05:19:47 volumio volumio[846]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Jul 05 05:19:47 volumio volumio[846]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Jul 05 05:19:47 volumio volumio[846]: (Use `node --trace-warnings ...` to show where the warning was created) Jul 05 05:19:48 volumio volumio[846]: (node:846) 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: 2) Jul 05 05:19:48 volumio volumio[846]: (node:846) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Jul 05 05:19:48 volumio volumio[846]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=30.27995&lon=120.16221: Error: Response error: 401 - Unauthorized Jul 05 05:19:48 volumio volumio[846]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Jul 05 05:19:48 volumio volumio[846]: at runMicrotasks () Jul 05 05:19:48 volumio volumio[846]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jul 05 05:19:48 volumio volumio[846]: at async Promise.all (index 1) Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 05 05:19:48 volumio volumio[846]: info: Adding plugin bluetooth to MyMusic Plugins Jul 05 05:19:48 volumio volumio[846]: info: Adding plugin multiroom to MyMusic Plugins Jul 05 05:19:48 volumio volumio[846]: info: Adding plugin metavolumio to MyMusic Plugins Jul 05 05:19:48 volumio volumio[846]: info: Adding plugin cd_controller to MyMusic Plugins Jul 05 05:19:48 volumio volumio[846]: info: Adding plugin qobuzconnect to MyMusic Plugins Jul 05 05:19:48 volumio volumio[846]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 05 05:19:48 volumio volumio[846]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 05 05:19:48 volumio volumio[846]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 05 05:19:48 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 05:19:48 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 05:19:48 volumio volumio[846]: info: Starting MyVolumio Remote Streaming Endpoints Jul 05 05:19:48 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Jul 05 05:19:48 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Jul 05 05:19:48 volumio volumio[846]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Jul 05 05:19:49 volumio volumio[846]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jul 05 05:19:49 volumio volumio[846]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jul 05 05:19:49 volumio volumio[846]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 05 05:19:49 volumio volumio-remote-updater[519]: [2025-07-05 05:19:49] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751663985 101 Jul 05 05:19:50 volumio volumio[846]: error: MyVolumio Custom Token format not valid, refreshing it Jul 05 05:19:50 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 05 05:19:50 volumio volumio[846]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 05 05:19:50 volumio volumio[846]: info: CoreCommandRouter::volumioGetState Jul 05 05:19:50 volumio volumio[846]: info: CorePlayQueue::getTrack 0 Jul 05 05:19:51 volumio volumio[846]: STREAMING PROXY: Starting server on port 3245 Jul 05 05:19:51 volumio volumio[846]: Node JS runtime: 14 Jul 05 05:19:52 volumio volumio[846]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 05 05:19:53 volumio volumio[846]: info: MyVolumio login type: Token Jul 05 05:19:53 volumio volumio[846]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=30.27995&lon=120.16221: Error: Response error: 401 - Unauthorized Jul 05 05:19:53 volumio volumio[846]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Jul 05 05:19:53 volumio volumio[846]: at runMicrotasks () Jul 05 05:19:53 volumio volumio[846]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jul 05 05:19:53 volumio volumio[846]: at async Promise.all (index 1) Jul 05 05:19:53 volumio volumio[846]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Jul 05 05:19:53 volumio volumio[846]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Jul 05 05:19:53 volumio volumio[846]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Jul 05 05:19:53 volumio volumio[846]: info: [now-playing] Fetching API key... Jul 05 05:19:53 volumio volumio[846]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=30.27995&lon=120.16221: Error: Response error: 401 - Unauthorized Jul 05 05:19:53 volumio volumio[846]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Jul 05 05:19:53 volumio volumio[846]: at runMicrotasks () Jul 05 05:19:53 volumio volumio[846]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jul 05 05:19:53 volumio volumio[846]: at async Promise.all (index 0) Jul 05 05:19:55 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 05:19:56 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 05:19:56 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 05 05:19:56 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 05 05:19:56 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 05 05:19:57 volumio volumio[846]: info: CoreCommandRouter::volumioGetBrowseSources Jul 05 05:19:59 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 05:20:07 volumio volumio[846]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jul 05 05:20:07 volumio volumio[846]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jul 05 05:20:07 volumio volumio[846]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 05:20:07 volumio volumio[846]: TypeError: Cannot read property 'ping' of undefined Jul 05 05:20:07 volumio volumio[846]: at Timeout._onTimeout (/data/plugins/music_service/volroon/node_modules/node-roon-api/transport-websocket.js:26:21) Jul 05 05:20:07 volumio volumio[846]: at listOnTimeout (internal/timers.js:554:17) Jul 05 05:20:07 volumio volumio[846]: at processTimers (internal/timers.js:497:7) Jul 05 05:20:09 volumio volumio[846]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 05:20:13 volumio sudo[2145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-05 05:19 Jul 05 05:20:13 volumio sudo[2145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 05 05:20:19 volumio volumio-remote-updater[519]: [2025-07-05 05:20:19] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"