Dec 09 08:05:00 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:00 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:16 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:16 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:18 volumio-215 go-librespot[1473]: time="2025-12-09T08:05:18+01:00" level=trace msg="sent dealer ping" Dec 09 08:05:19 volumio-215 go-librespot[1473]: time="2025-12-09T08:05:19+01:00" level=trace msg="received dealer pong" Dec 09 08:05:28 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:28 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:29 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:29 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:30 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:30 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:34 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:34 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:39 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:39 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:40 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:40 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:41 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:41 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:43 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:43 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:44 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:44 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: [1765263945269] [80s80s] Pushing the next song state Simply Red - Holding Back the Years and getting next track. Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreCommandRouter::servicePushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music/v4/f3/5c/0c/f35c0cd3-7eba-e62a-1469-af2f2ae6db9d/source/600x600bb.jpg","name":"Simply Red - Holding Back the Years","title":"Holding Back the Years","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"248","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Dec 09 08:05:45 volumio-215 volumio[1090]: verbose: CURRENT POSITION 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreStateMachine::syncState stateService play Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreStateMachine::syncState currentStatus play Dec 09 08:05:45 volumio-215 volumio[1090]: info: Received an update from plugin. extracting info from payload Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreStateMachine::pushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioPushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreStateMachine::pushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioPushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: [1765263945274] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=1 Dec 09 08:05:45 volumio-215 volumio[1090]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Dec 09 08:05:45 volumio-215 volumio[1090]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Dec 09 08:05:45 volumio-215 volumio[1090]: info: [1765263945334] [80s80s] Pushing the next song state Simply Red - Holding Back the Years and getting next track. Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreCommandRouter::servicePushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music/v4/f3/5c/0c/f35c0cd3-7eba-e62a-1469-af2f2ae6db9d/source/600x600bb.jpg","name":"Simply Red - Holding Back the Years","title":"Holding Back the Years","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"248","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Dec 09 08:05:45 volumio-215 volumio[1090]: verbose: CURRENT POSITION 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreStateMachine::syncState stateService play Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreStateMachine::syncState currentStatus play Dec 09 08:05:45 volumio-215 volumio[1090]: info: Received an update from plugin. extracting info from payload Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreStateMachine::pushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioPushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreStateMachine::pushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioPushState Dec 09 08:05:45 volumio-215 volumio[1090]: info: [1765263945338] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=1 Dec 09 08:05:45 volumio-215 volumio[1090]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Dec 09 08:05:45 volumio-215 volumio[1090]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:45 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 1 Dec 09 08:05:46 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:46 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:47 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:47 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:48 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:48 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:48 volumio-215 go-librespot[1473]: time="2025-12-09T08:05:48+01:00" level=trace msg="sent dealer ping" Dec 09 08:05:49 volumio-215 go-librespot[1473]: time="2025-12-09T08:05:49+01:00" level=trace msg="received dealer pong" Dec 09 08:05:49 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:49 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:50 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:50 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:50 volumio-215 volumio[1090]: info: [1765263950426] [80s80s] received new event containing 1 songs. Dec 09 08:05:50 volumio-215 volumio[1090]: info: [1765263950426] [80s80s] PlayNextTrack API delay: 30 Dec 09 08:05:50 volumio-215 volumio[1090]: info: [1765263950427] [80s80s] Setting timer to: 248000 milliseconds. Dec 09 08:05:51 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:51 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:52 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:52 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:53 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:53 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:54 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:54 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:55 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:55 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:56 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:56 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:57 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:57 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:58 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:58 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:05:59 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:05:59 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:06:00 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:06:00 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:06:01 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:06:01 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:06:02 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:06:02 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:06:03 volumio-215 volumio[1090]: info: CoreCommandRouter::volumioGetState Dec 09 08:06:03 volumio-215 volumio[1090]: info: CorePlayQueue::getTrack 0 Dec 09 08:06:03 volumio-215 volumio[1090]: info: [1765263963258] [80s80s] Failed to query api, status code: 503 Dec 09 08:06:03 volumio-215 volumio[1090]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 09 08:06:03 volumio-215 volumio[1090]: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/80s80s/fake-data.json' Dec 09 08:06:03 volumio-215 volumio[1090]: at Object.openSync (node:fs:602:3) Dec 09 08:06:03 volumio-215 volumio[1090]: at Object.readFileSync (node:fs:470:35) Dec 09 08:06:03 volumio-215 volumio[1090]: at ClientRequest. (/data/plugins/music_service/80s80s/index.js:485:23) Dec 09 08:06:03 volumio-215 volumio[1090]: at Object.onceWrapper (node:events:629:26) Dec 09 08:06:03 volumio-215 volumio[1090]: at ClientRequest.emit (node:events:514:28) Dec 09 08:06:03 volumio-215 volumio[1090]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Dec 09 08:06:03 volumio-215 volumio[1090]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Dec 09 08:06:03 volumio-215 volumio[1090]: at Socket.socketOnData (node:_http_client:535:22) Dec 09 08:06:03 volumio-215 volumio[1090]: at Socket.emit (node:events:514:28) Dec 09 08:06:03 volumio-215 volumio[1090]: at addChunk (node:internal/streams/readable:343:12) { Dec 09 08:06:03 volumio-215 volumio[1090]: errno: -2, Dec 09 08:06:03 volumio-215 volumio[1090]: syscall: 'open', Dec 09 08:06:03 volumio-215 volumio[1090]: code: 'ENOENT', Dec 09 08:06:03 volumio-215 volumio[1090]: path: '/data/plugins/music_service/80s80s/fake-data.json' Dec 09 08:06:03 volumio-215 volumio[1090]: } Dec 09 08:06:03 volumio-215 volumio[1090]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 09 08:06:04 volumio-215 sudo[14118]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-09 08:05' Dec 09 08:06:04 volumio-215 sudo[14118]: 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="ac7dd5922ede329d1459d48b226ddc71f5209a2c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="3441cddd43405c36fe444484553f10f2f5bc830b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Nov 13 11:04:27 UTC 2025" VOLUMIO_VERSION="4.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="7da8d6d9f8baf8621af4ec2af5a00f00"