May 25 16:49:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 25 16:49:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 16:49:01 volumio volumio[1385]: info: Received Get System Info
May 25 16:49:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 16:49:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 16:49:01 volumio volumio[1385]: info: Discovery: Getting this device information
May 25 16:49:01 volumio volumio[1385]: info: CoreCommandRouter::volumioGetState
May 25 16:49:01 volumio volumio[1385]: info: CorePlayQueue::getTrack 0
May 25 16:49:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 16:49:02 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 16:49:02 volumio volumio[1385]: info: Received Get System Info
May 25 16:49:02 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 16:49:02 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 16:49:02 volumio volumio[1385]: info: Discovery: Getting this device information
May 25 16:49:02 volumio volumio[1385]: info: CoreCommandRouter::volumioGetState
May 25 16:49:02 volumio volumio[1385]: info: CorePlayQueue::getTrack 0
May 25 16:49:02 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 16:49:07 volumio ntpd[1163]: PROTO: 193.219.61.120 unlink local addr 192.168.1.4 ->
May 25 16:49:08 volumio volumio[1385]: error: [now-playing] Error fetching https://api.openweathermap.org/data/3.0/onecall?appid=6cd12afcc686b595464432ea230ebe14&lat=55.8985&lon=21.1443&units=metric: Error: Response error: 401 - Unauthorized
May 25 16:49:08 volumio volumio[1385]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:30:15)
May 25 16:49:08 volumio volumio[1385]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 16:49:08 volumio volumio[1385]: at async Promise.all (index 0)
May 25 16:49:08 volumio volumio[1385]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:91:24)
May 25 16:49:08 volumio volumio[1385]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:104:45)
May 25 16:49:08 volumio volumio[1385]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:301:25
May 25 16:49:09 volumio volumio[1385]: error: [now-playing] Error fetching https://api.openweathermap.org/data/3.0/onecall?appid=6cd12afcc686b595464432ea230ebe14&lat=55.8985&lon=21.1443&units=metric: Error: Response error: 401 - Unauthorized
May 25 16:49:09 volumio volumio[1385]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:30:15)
May 25 16:49:09 volumio volumio[1385]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 16:49:09 volumio volumio[1385]: at async Promise.all (index 0)
May 25 16:49:09 volumio volumio[1385]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:91:24)
May 25 16:49:09 volumio volumio[1385]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:104:45)
May 25 16:49:09 volumio volumio[1385]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:301:25
May 25 16:49:09 volumio volumio[1385]: error: [now-playing] Caught error in callback of WeatherAPI.#getFetchPromise(): Response error: 401 - Unauthorized
May 25 16:49:09 volumio volumio[1385]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not fetch weather: Response error: 401 - Unauthorized
May 25 16:49:09 volumio volumio[1385]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:108:25)
May 25 16:49:09 volumio volumio[1385]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 16:49:09 volumio volumio[1385]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:126:28)
May 25 16:49:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 25 16:49:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri
May 25 16:49:09 volumio volumio[1385]: info: [ytmusic-browse] browseUri: ytmusic
May 25 16:49:09 volumio volumio[1385]: info: Preload queue cleared
May 25 16:49:12 volumio ntpd[1163]: PROTO: 195.72.61.39 unlink local addr 192.168.1.4 ->
May 25 16:49:15 volumio volumio[1385]: Searching plugin music_service/ytmusic
May 25 16:49:15 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search
May 25 16:49:16 volumio volumio[1385]: Searching plugin music_service/ytmusic
May 25 16:49:16 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search
May 25 16:49:16 volumio volumio[1385]: Searching plugin music_service/ytmusic
May 25 16:49:16 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search
May 25 16:49:17 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 25 16:49:17 volumio volumio[1385]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 25 16:49:17 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 25 16:49:17 volumio volumio[1385]: info: Received Get System Version
May 25 16:49:17 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 25 16:49:17 volumio volumio[1385]: info: Received Get System Info
May 25 16:49:17 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 16:49:17 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 16:49:17 volumio volumio[1385]: info: Discovery: Getting this device information
May 25 16:49:17 volumio volumio[1385]: info: CoreCommandRouter::volumioGetState
May 25 16:49:17 volumio volumio[1385]: info: CorePlayQueue::getTrack 0
May 25 16:49:17 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 16:49:38 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 16:49:38 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 25 16:49:38 volumio volumio[1385]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 16:49:42 volumio volumio[1385]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 16:49:42 volumio volumio[1385]: error: [ytmusic] Error getting i18n options: VM operation timed out Error: VM operation timed out
May 25 16:49:42 volumio volumio[1385]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15)
May 25 16:49:42 volumio volumio[1385]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 16:49:42 volumio volumio[1385]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35)
May 25 16:49:42 volumio volumio[1385]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25)
May 25 16:49:42 volumio volumio[1385]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9)
May 25 16:49:42 volumio volumio[1385]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9)
May 25 16:49:42 volumio volumio[1385]: warn: [ytmusic] Failed to get account config: VM operation timed out Error: VM operation timed out
May 25 16:49:42 volumio volumio[1385]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15)
May 25 16:49:42 volumio volumio[1385]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 16:49:42 volumio volumio[1385]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35)
May 25 16:49:42 volumio volumio[1385]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25)
May 25 16:49:42 volumio volumio[1385]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9)
May 25 16:49:42 volumio volumio[1385]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9)
May 25 16:49:50 volumio volumio[1385]: info: CALLMETHOD: music_service ytmusic configSaveAccount [object Object]
May 25 16:49:50 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: ytmusic , configSaveAccount
May 25 16:50:07 volumio volumio[1385]: verbose: New Socket.io Connection to 192.168.1.4 from 192.168.1.6 UA: Mozilla/5.0 (Linux; Android 15; ALI-NX1 Build/HONORALI-N21; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/148.0.7778.120 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::volumioGetVisibleSources
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::volumioGetState
May 25 16:50:07 volumio volumio[1385]: info: CorePlayQueue::getTrack 0
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 25 16:50:07 volumio volumio[1385]: info: Received Get System Info
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 16:50:07 volumio volumio[1385]: info: Discovery: Getting this device information
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::volumioGetState
May 25 16:50:07 volumio volumio[1385]: info: CorePlayQueue::getTrack 0
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::volumioGetState
May 25 16:50:07 volumio volumio[1385]: info: CorePlayQueue::getTrack 0
May 25 16:50:07 volumio volumio[1385]: info: Listing playlists
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 25 16:50:07 volumio volumio[1385]: error: [ytmusic] Error getting i18n options: VM operation timed out Error: VM operation timed out
May 25 16:50:07 volumio volumio[1385]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15)
May 25 16:50:07 volumio volumio[1385]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 16:50:07 volumio volumio[1385]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35)
May 25 16:50:07 volumio volumio[1385]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25)
May 25 16:50:07 volumio volumio[1385]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9)
May 25 16:50:07 volumio volumio[1385]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9)
May 25 16:50:07 volumio volumio[1385]: warn: [ytmusic] Failed to get account config: VM operation timed out Error: VM operation timed out
May 25 16:50:07 volumio volumio[1385]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15)
May 25 16:50:07 volumio volumio[1385]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 16:50:07 volumio volumio[1385]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35)
May 25 16:50:07 volumio volumio[1385]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25)
May 25 16:50:07 volumio volumio[1385]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9)
May 25 16:50:07 volumio volumio[1385]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9)
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::getUIConfigOnPlugin
May 25 16:50:07 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 25 16:50:08 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 16:50:09 volumio volumio[1385]: info: Received Get System Info
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 16:50:09 volumio volumio[1385]: info: Discovery: Getting this device information
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::volumioGetState
May 25 16:50:09 volumio volumio[1385]: info: CorePlayQueue::getTrack 0
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 16:50:09 volumio volumio[1385]: info: Received Get System Info
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 16:50:09 volumio volumio[1385]: info: Discovery: Getting this device information
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::volumioGetState
May 25 16:50:09 volumio volumio[1385]: info: CorePlayQueue::getTrack 0
May 25 16:50:09 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 16:50:17 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 25 16:50:19 volumio volumio[1385]: info: CALLMETHOD: music_service ytmusic configSaveAccount [object Object]
May 25 16:50:19 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: ytmusic , configSaveAccount
May 25 16:50:19 volumio volumio[1385]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 25 16:50:19 volumio volumio[1385]: Error: VM operation timed out
May 25 16:50:19 volumio volumio[1385]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15)
May 25 16:50:19 volumio volumio[1385]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 16:50:19 volumio volumio[1385]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35)
May 25 16:50:19 volumio volumio[1385]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25)
May 25 16:50:19 volumio volumio[1385]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9)
May 25 16:50:19 volumio volumio[1385]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9)
May 25 16:50:19 volumio volumio[1385]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 25 16:50:20 volumio sudo[4569]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-25 16:49'
May 25 16:50:20 volumio sudo[4569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"