Aug 28 07:50:00 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 28 07:50:00 volumio volumio[1203]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 28 07:50:00 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 28 07:50:00 volumio volumio[1203]: info: Received Get System Version Aug 28 07:50:00 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 07:50:00 volumio volumio[1203]: info: Received Get System Info Aug 28 07:50:00 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 07:50:00 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 07:50:00 volumio volumio[1203]: info: Discovery: Getting this device information Aug 28 07:50:00 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Aug 28 07:50:00 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Aug 28 07:50:00 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 07:50:32 volumio ntpd[1031]: CLOCK: time stepped by 0.456305 Aug 28 07:50:32 volumio ntpd[1031]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Aug 28 07:50:42 volumio volumio[1203]: info: [ytmusic] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version Aug 28 07:50:42 volumio volumio[1203]: info: [ytmusic] Innertube support service: Start service with Node Aug 28 07:50:58 volumio volumio[1203]: info: [ytmusic] Innertube support service: result: {"status":"started","server":{"address":"127.0.0.1","port":44007}} Aug 28 07:50:58 volumio volumio[1203]: info: [ytmusic] Innertube support service running at http://127.0.0.1:44007 Aug 28 07:51:15 volumio volumio[1203]: error: [ytmusic] Error getting i18n options: VM operation timed out Error: VM operation timed out Aug 28 07:51:15 volumio volumio[1203]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Aug 28 07:51:15 volumio volumio[1203]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 07:51:15 volumio volumio[1203]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Aug 28 07:51:15 volumio volumio[1203]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Aug 28 07:51:15 volumio volumio[1203]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Aug 28 07:51:15 volumio volumio[1203]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Aug 28 07:51:15 volumio volumio[1203]: at async ConfigModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:25) Aug 28 07:51:15 volumio volumio[1203]: at async ConfigModel._ConfigModel_fetchSettingsPage (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:117:27) Aug 28 07:51:15 volumio volumio[1203]: at async ConfigModel.getI18nOptions (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:49:26) Aug 28 07:51:15 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_getConfigI18nOptions (/data/plugins/music_service/ytmusic/dist/index.js:488:25) Aug 28 07:51:15 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_doGetUIConfig (/data/plugins/music_service/ytmusic/dist/index.js:382:49) Aug 28 07:51:15 volumio volumio[1203]: warn: [ytmusic] Failed to get account config: VM operation timed out Error: VM operation timed out Aug 28 07:51:15 volumio volumio[1203]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Aug 28 07:51:15 volumio volumio[1203]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 07:51:15 volumio volumio[1203]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Aug 28 07:51:15 volumio volumio[1203]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Aug 28 07:51:15 volumio volumio[1203]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Aug 28 07:51:15 volumio volumio[1203]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Aug 28 07:51:15 volumio volumio[1203]: at async ConfigModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:25) Aug 28 07:51:15 volumio volumio[1203]: at async ConfigModel._ConfigModel_fetchSettingsPage (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:117:27) Aug 28 07:51:15 volumio volumio[1203]: at async ConfigModel.getI18nOptions (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:49:26) Aug 28 07:51:15 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_getConfigI18nOptions (/data/plugins/music_service/ytmusic/dist/index.js:488:25) Aug 28 07:51:15 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_doGetUIConfig (/data/plugins/music_service/ytmusic/dist/index.js:382:49) Aug 28 07:51:35 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Aug 28 07:51:35 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Aug 28 07:51:35 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 28 07:51:35 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 28 07:51:35 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 28 07:51:35 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 28 07:51:36 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Aug 28 07:51:36 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Aug 28 07:51:36 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Aug 28 07:51:36 volumio volumio[1203]: verbose: New Socket.io Connection to 10.98.47.70 from 10.98.47.184 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Aug 28 07:51:36 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Aug 28 07:51:37 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 07:51:37 volumio volumio[1203]: info: Received Get System Info Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 07:51:37 volumio volumio[1203]: info: Discovery: Getting this device information Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Aug 28 07:51:37 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Aug 28 07:51:37 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Aug 28 07:51:37 volumio volumio[1203]: info: Listing playlists Aug 28 07:51:37 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 28 07:51:41 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 07:51:41 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 28 07:51:43 volumio volumio[1203]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 07:51:43 volumio volumio[1203]: error: [ytmusic] Error getting i18n options: VM operation timed out Error: VM operation timed out Aug 28 07:51:43 volumio volumio[1203]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Aug 28 07:51:43 volumio volumio[1203]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 07:51:43 volumio volumio[1203]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Aug 28 07:51:43 volumio volumio[1203]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Aug 28 07:51:43 volumio volumio[1203]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Aug 28 07:51:43 volumio volumio[1203]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Aug 28 07:51:43 volumio volumio[1203]: at async ConfigModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:25) Aug 28 07:51:43 volumio volumio[1203]: at async ConfigModel._ConfigModel_fetchSettingsPage (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:117:27) Aug 28 07:51:43 volumio volumio[1203]: at async ConfigModel.getI18nOptions (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:49:26) Aug 28 07:51:43 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_getConfigI18nOptions (/data/plugins/music_service/ytmusic/dist/index.js:488:25) Aug 28 07:51:43 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_doGetUIConfig (/data/plugins/music_service/ytmusic/dist/index.js:382:49) Aug 28 07:51:43 volumio volumio[1203]: warn: [ytmusic] Failed to get account config: VM operation timed out Error: VM operation timed out Aug 28 07:51:43 volumio volumio[1203]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Aug 28 07:51:43 volumio volumio[1203]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 07:51:43 volumio volumio[1203]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Aug 28 07:51:43 volumio volumio[1203]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Aug 28 07:51:43 volumio volumio[1203]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Aug 28 07:51:43 volumio volumio[1203]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Aug 28 07:51:43 volumio volumio[1203]: at async ConfigModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:25) Aug 28 07:51:43 volumio volumio[1203]: at async ConfigModel._ConfigModel_fetchSettingsPage (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:117:27) Aug 28 07:51:43 volumio volumio[1203]: at async ConfigModel.getI18nOptions (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:49:26) Aug 28 07:51:43 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_getConfigI18nOptions (/data/plugins/music_service/ytmusic/dist/index.js:488:25) Aug 28 07:51:43 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_doGetUIConfig (/data/plugins/music_service/ytmusic/dist/index.js:382:49) Aug 28 07:51:50 volumio volumio[1203]: info: CALLMETHOD: music_service ytmusic configSaveI18n [object Object] Aug 28 07:51:50 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: ytmusic , configSaveI18n Aug 28 07:51:50 volumio volumio[1203]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 07:51:50 volumio volumio[1203]: Error: VM operation timed out Aug 28 07:51:50 volumio volumio[1203]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Aug 28 07:51:50 volumio volumio[1203]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 07:51:50 volumio volumio[1203]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Aug 28 07:51:50 volumio volumio[1203]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Aug 28 07:51:50 volumio volumio[1203]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Aug 28 07:51:50 volumio volumio[1203]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Aug 28 07:51:50 volumio volumio[1203]: at async ConfigModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:25) Aug 28 07:51:50 volumio volumio[1203]: at async ConfigModel._ConfigModel_fetchSettingsPage (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:117:27) Aug 28 07:51:50 volumio volumio[1203]: at async ConfigModel.getI18nOptions (/data/plugins/music_service/ytmusic/dist/lib/model/ConfigModel.js:49:26) Aug 28 07:51:50 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_getConfigI18nOptions (/data/plugins/music_service/ytmusic/dist/index.js:488:25) Aug 28 07:51:50 volumio volumio[1203]: at async ControllerYTMusic._ControllerYTMusic_doGetUIConfig (/data/plugins/music_service/ytmusic/dist/index.js:382:49) Aug 28 07:51:50 volumio volumio[1203]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 07:51:54 volumio sudo[2191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 07:50' Aug 28 07:51:54 volumio sudo[2191]: 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"