Dec 07 10:51:02 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:51:02 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:51:02 volumio volumio[1544]: info: Listing playlists Dec 07 10:51:02 volumio volumio[1544]: info: Listing playlists Dec 07 10:51:12 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:51:12 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:51:22 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:51:22 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:51:22 volumio volumio[1544]: info: Listing playlists Dec 07 10:51:22 volumio volumio[1544]: info: Listing playlists Dec 07 10:51:32 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:51:32 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:51:42 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:51:42 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:51:42 volumio volumio[1544]: info: Listing playlists Dec 07 10:51:42 volumio volumio[1544]: info: Listing playlists Dec 07 10:51:52 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:51:52 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:52:02 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:52:02 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:52:02 volumio volumio[1544]: info: Listing playlists Dec 07 10:52:02 volumio volumio[1544]: info: Listing playlists Dec 07 10:52:12 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:52:12 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:52:22 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:52:22 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:52:22 volumio volumio[1544]: info: Listing playlists Dec 07 10:52:22 volumio volumio[1544]: info: Listing playlists Dec 07 10:52:27 volumio volumio[1544]: info: CALLMETHOD: music_service ytmusic configSaveAccount [object Object] Dec 07 10:52:27 volumio volumio[1544]: info: CoreCommandRouter::executeOnPlugin: ytmusic , configSaveAccount Dec 07 10:52:27 volumio volumio[1544]: info: [ytmusic] Innertube support service: Stopping service... Dec 07 10:52:27 volumio volumio[1544]: info: [ytmusic] Innertube support service: Received SIGTERM Dec 07 10:52:27 volumio volumio[1544]: info: [ytmusic] Innertube support service: Process closed with code 0 Dec 07 10:52:27 volumio volumio[1544]: info: [ytmusic] Innertube support service: Stopped Dec 07 10:52:27 volumio volumio[1544]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 10:52:27 volumio volumio[1544]: info: [ytmusic] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version Dec 07 10:52:27 volumio volumio[1544]: info: [ytmusic] Innertube support service: Start service with Node Dec 07 10:52:28 volumio volumio[1544]: info: [ytmusic] Innertube support service: result: {"status":"started","server":{"address":"127.0.0.1","port":37707}} Dec 07 10:52:28 volumio volumio[1544]: info: [ytmusic] Innertube support service running at http://127.0.0.1:37707 Dec 07 10:52:30 volumio volumio[1544]: warn: [ytmusic] Failed to get account config: Cannot convert argument to a ByteString because the character at index 512 has a value of 8230 which is greater than 255. TypeError: Cannot convert argument to a ByteString because the character at index 512 has a value of 8230 which is greater than 255. Dec 07 10:52:30 volumio volumio[1544]: at webidl.converters.ByteString (node:internal/deps/undici/undici:1629:17) Dec 07 10:52:30 volumio volumio[1544]: at Headers.set (node:internal/deps/undici/undici:1931:35) Dec 07 10:52:30 volumio volumio[1544]: at HTTPClient.fetch (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:2445:25) Dec 07 10:52:30 volumio volumio[1544]: at Actions.execute (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:33632:46) Dec 07 10:52:30 volumio volumio[1544]: at _NavigationEndpoint.call (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:15562:22) Dec 07 10:52:30 volumio volumio[1544]: at AccountManager.getInfo (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:39005:59) Dec 07 10:52:30 volumio volumio[1544]: at getActiveAccountDatasyncIdToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Utils.js:35:47) Dec 07 10:52:30 volumio volumio[1544]: at InnertubeWrapper._InnertubeWrapper_generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:162:93) Dec 07 10:52:30 volumio volumio[1544]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 07 10:52:30 volumio volumio[1544]: at async InnertubeWrapper._InnertubeWrapper_initInnertube (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:205:24) Dec 07 10:52:30 volumio volumio[1544]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:90:9) Dec 07 10:52:30 volumio volumio[1544]: at async AccountModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:31) Dec 07 10:52:30 volumio volumio[1544]: at async AccountModel.getInfo (/data/plugins/music_service/ytmusic/dist/lib/model/AccountModel.js:7:31) Dec 07 10:52:30 volumio volumio[1544]: at async ControllerYTMusic._ControllerYTMusic_getConfigAccountInfo (/data/plugins/music_service/ytmusic/dist/index.js:435:16) Dec 07 10:52:30 volumio volumio[1544]: at async Promise.all (index 2) Dec 07 10:52:32 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:52:32 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:52:39 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:52:39 volumio volumio[1544]: info: CorePlayQueue::getTrack 4 Dec 07 10:52:39 volumio volumio[1544]: info: Prefetching next song Dec 07 10:52:39 volumio volumio[1544]: info: DOING PREFETCH IN MPD Dec 07 10:52:39 volumio volumio[1544]: verbose: ControllerMpd::sendMpdCommand add "NAS/Athena/Goldroom - Embrace/Goldroom - Embrace - 03 Fifteen (feat. Chela).flac" Dec 07 10:52:39 volumio volumio[1544]: info: sendMpdCommand add "NAS/Athena/Goldroom - Embrace/Goldroom - Embrace - 03 Fifteen (feat. Chela).flac" took 0 milliseconds Dec 07 10:52:39 volumio volumio[1544]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 07 10:52:39 volumio volumio[1544]: info: Dec 07 10:52:39 volumio volumio[1544]: ---------------------------- MPD announces system playlist update Dec 07 10:52:39 volumio volumio[1544]: info: Ignoring MPD Status Update Dec 07 10:52:39 volumio volumio[1544]: info: sendMpdCommand consume 1 took 1 milliseconds Dec 07 10:52:39 volumio volumio[1544]: info: ------------------------------ 1ms Dec 07 10:52:42 volumio volumio[1544]: info: CoreCommandRouter::volumioGetState Dec 07 10:52:42 volumio volumio[1544]: info: CorePlayQueue::getTrack 3 Dec 07 10:52:42 volumio volumio[1544]: info: Listing playlists Dec 07 10:52:42 volumio volumio[1544]: info: Listing playlists Dec 07 10:52:43 volumio nmbd[1161]: [2025/12/07 10:52:43.806531, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 07 10:52:43 volumio nmbd[1161]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.60.4 for name WORKGROUP<1d>. Dec 07 10:52:43 volumio nmbd[1161]: This response was from IP 192.168.60.7, reporting an IP address of 192.168.60.7. Dec 07 10:52:44 volumio volumio[1544]: info: CoreStateMachine::startPlaybackTimer Dec 07 10:52:44 volumio volumio[1544]: info: CorePlayQueue::getTrack 4 Dec 07 10:52:44 volumio volumio[1544]: info: CoreStateMachine::pushState Dec 07 10:52:44 volumio volumio[1544]: info: CorePlayQueue::getTrack 4 Dec 07 10:52:44 volumio volumio[1544]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 10:52:44 volumio volumio[1544]: info: CoreCommandRouter::volumioPushState Dec 07 10:52:44 volumio volumio[1544]: info: MRS: Pushing multiroomSync output update for this device Dec 07 10:52:44 volumio volumio[1544]: info: MRS: Pushing multiroomSync output Dec 07 10:52:44 volumio volumio[1544]: info: [LastFM] Current track has sufficient metadata: title (Fifteen (feat. Chela)) and artist (Goldroom) passed on explicitly Dec 07 10:52:44 volumio volumio[1544]: info: Dec 07 10:52:44 volumio volumio[1544]: ---------------------------- MPD announces system playlist update Dec 07 10:52:44 volumio volumio[1544]: info: Ignoring MPD Status Update Dec 07 10:52:44 volumio volumio[1544]: info: Dec 07 10:52:44 volumio volumio[1544]: ---------------------------- MPD announces state update: player Dec 07 10:52:44 volumio volumio[1544]: info: ControllerMpd::getState Dec 07 10:52:44 volumio volumio[1544]: verbose: ControllerMpd::sendMpdCommand status Dec 07 10:52:44 volumio volumio[1544]: info: ------------------------------ 1ms Dec 07 10:52:44 volumio volumio[1544]: info: sendMpdCommand status took 1 milliseconds Dec 07 10:52:44 volumio volumio[1544]: verbose: ControllerMpd::parseState Dec 07 10:52:44 volumio volumio[1544]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 10:52:44 volumio volumio[1544]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 07 10:52:44 volumio volumio[1544]: verbose: ControllerMpd::parseTrackInfo Dec 07 10:52:44 volumio volumio[1544]: info: ControllerMpd::pushState Dec 07 10:52:44 volumio volumio[1544]: info: CoreCommandRouter::servicePushState Dec 07 10:52:44 volumio volumio[1544]: info: CorePlayQueue::getTrack 4 Dec 07 10:52:44 volumio volumio[1544]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":300,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Fifteen (feat. Chela)","artist":"Goldroom","album":"Embrace","uri":"NAS/Athena/Goldroom - Embrace/Goldroom - Embrace - 03 Fifteen (feat. Chela).flac","trackType":"flac"} Dec 07 10:52:44 volumio volumio[1544]: verbose: CURRENT POSITION 4 Dec 07 10:52:44 volumio volumio[1544]: info: CoreStateMachine::syncState stateService play Dec 07 10:52:44 volumio volumio[1544]: info: CoreStateMachine::syncState currentStatus play Dec 07 10:52:44 volumio volumio[1544]: info: Received an update from plugin. extracting info from payload Dec 07 10:52:44 volumio volumio[1544]: info: CoreStateMachine::pushState Dec 07 10:52:44 volumio volumio[1544]: info: CorePlayQueue::getTrack 4 Dec 07 10:52:44 volumio volumio[1544]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 10:52:44 volumio volumio[1544]: info: CoreCommandRouter::volumioPushState Dec 07 10:52:44 volumio volumio[1544]: info: MRS: Pushing multiroomSync output update for this device Dec 07 10:52:44 volumio volumio[1544]: info: MRS: Pushing multiroomSync output Dec 07 10:52:44 volumio volumio[1544]: info: CoreStateMachine::pushState Dec 07 10:52:44 volumio volumio[1544]: info: CorePlayQueue::getTrack 4 Dec 07 10:52:44 volumio volumio[1544]: info: CoreCommandRouter::volumioPushState Dec 07 10:52:44 volumio volumio[1544]: info: MRS: Pushing multiroomSync output update for this device Dec 07 10:52:44 volumio volumio[1544]: info: MRS: Pushing multiroomSync output Dec 07 10:52:44 volumio volumio[1544]: info: ------------------------------ 8ms Dec 07 10:52:44 volumio volumio[1544]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Fifteen (feat. Chela)","url":"https://www.last.fm/music/Goldroom/_/Fifteen+(feat.+Chela)","duration":"299000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"20471","playcount":"83581","artist":{"name":"Goldroom","mbid":"73d91e4c-88f7-4da5-8d18-06fbb4bfcca3","url":"https://www.last.fm/music/Goldroom"},"album":{"artist":"Goldroom","title":"Embrace - EP","url":"https://www.last.fm/music/Goldroom/Embrace+-+EP","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/3468ea4704b944e5c4ae016a7bf1a854.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/3468ea4704b944e5c4ae016a7bf1a854.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/3468ea4704b944e5c4ae016a7bf1a854.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/3468ea4704b944e5c4ae016a7bf1a854.png","@":{"size":"extralarge"}}]},"userplaycount":"7","userloved":"0","toptags":""}} Dec 07 10:52:48 volumio volumio[1544]: info: CALLMETHOD: music_service ytmusic configSaveI18n [object Object] Dec 07 10:52:48 volumio volumio[1544]: info: CoreCommandRouter::executeOnPlugin: ytmusic , configSaveI18n Dec 07 10:52:48 volumio volumio[1544]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 10:52:48 volumio volumio[1544]: TypeError: Cannot convert argument to a ByteString because the character at index 512 has a value of 8230 which is greater than 255. Dec 07 10:52:48 volumio volumio[1544]: at webidl.converters.ByteString (node:internal/deps/undici/undici:1629:17) Dec 07 10:52:48 volumio volumio[1544]: at Headers.set (node:internal/deps/undici/undici:1931:35) Dec 07 10:52:48 volumio volumio[1544]: at HTTPClient.fetch (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:2445:25) Dec 07 10:52:48 volumio volumio[1544]: at Actions.execute (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:33632:46) Dec 07 10:52:48 volumio volumio[1544]: at _NavigationEndpoint.call (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:15562:22) Dec 07 10:52:48 volumio volumio[1544]: at AccountManager.getInfo (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/node_modules/volumio-youtubei.js/bundle/node.cjs:39005:59) Dec 07 10:52:48 volumio volumio[1544]: at getActiveAccountDatasyncIdToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Utils.js:35:47) Dec 07 10:52:48 volumio volumio[1544]: at InnertubeWrapper._InnertubeWrapper_generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:162:93) Dec 07 10:52:48 volumio volumio[1544]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 07 10:52:48 volumio volumio[1544]: at async InnertubeWrapper._InnertubeWrapper_initInnertube (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:205:24) Dec 07 10:52:48 volumio volumio[1544]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:90:9) Dec 07 10:52:48 volumio volumio[1544]: at async AccountModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:31) Dec 07 10:52:48 volumio volumio[1544]: at async AccountModel.getInfo (/data/plugins/music_service/ytmusic/dist/lib/model/AccountModel.js:7:31) Dec 07 10:52:48 volumio volumio[1544]: at async ControllerYTMusic._ControllerYTMusic_getConfigAccountInfo (/data/plugins/music_service/ytmusic/dist/index.js:435:16) Dec 07 10:52:48 volumio volumio[1544]: at async Promise.all (index 2) Dec 07 10:52:48 volumio volumio[1544]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 10:52:48 volumio sudo[25741]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-07 10:51' Dec 07 10:52:48 volumio sudo[25741]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"