-- Logs begin at Thu 2025-12-25 21:18:28 CET, end at Fri 2025-12-26 08:06:15 CET. -- Dec 26 08:05:37 volumiopi4 wpa_supplicant[913]: RRM: Ignoring radio measurement request: Not RRM network Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760040] [80s80s] Pushing the next song state Cliff Richard - Mistletoe & Wine and getting next track. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 9 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreCommandRouter::servicePushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 9 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received 80s80s Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760042] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=75&count=1 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 9 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Prefetching next song Dec 26 08:06:00 volumiopi4 volumio[1032]: info: DOING PREFETCH IN MPD Dec 26 08:06:00 volumiopi4 volumio[1032]: verbose: ControllerMpd::sendMpdCommand add "USB/Musica/fla/FLAC/Pink Floyd - The Dark Side Of The Moon (50th Anniversary) (2023 Remaster) (1973) [24Bit]/06. Pink Floyd - Money (2023 Remaster) (Explicit).flac" Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreStateMachine::startPlaybackTimer Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Dec 26 08:06:00 volumiopi4 volumio[1032]: ---------------------------- MPD announces system playlist update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Ignoring MPD Status Update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: sendMpdCommand add "USB/Musica/fla/FLAC/Pink Floyd - The Dark Side Of The Moon (50th Anniversary) (2023 Remaster) (1973) [24Bit]/06. Pink Floyd - Money (2023 Remaster) (Explicit).flac" took 1 milliseconds Dec 26 08:06:00 volumiopi4 volumio[1032]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Dec 26 08:06:00 volumiopi4 volumio[1032]: ---------------------------- MPD announces system playlist update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Ignoring MPD Status Update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Dec 26 08:06:00 volumiopi4 volumio[1032]: ---------------------------- MPD announces system playlist update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Ignoring MPD Status Update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Dec 26 08:06:00 volumiopi4 volumio[1032]: ---------------------------- MPD announces system playlist update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Ignoring MPD Status Update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760078] [80s80s] Pushing the next song state Cliff Richard - Mistletoe & Wine and getting next track. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreCommandRouter::servicePushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received 80s80s Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760078] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=75&count=1 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: ------------------------------ 24ms Dec 26 08:06:00 volumiopi4 volumio[1032]: info: sendMpdCommand consume 1 took 24 milliseconds Dec 26 08:06:00 volumiopi4 volumio[1032]: info: ------------------------------ 35ms Dec 26 08:06:00 volumiopi4 volumio[1032]: info: ------------------------------ 46ms Dec 26 08:06:00 volumiopi4 volumio[1032]: info: ------------------------------ 58ms Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760126] [80s80s] Pushing the next song state Cliff Richard - Mistletoe & Wine and getting next track. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreCommandRouter::servicePushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received 80s80s Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760127] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=75&count=1 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760172] [80s80s] Pushing the next song state Cliff Richard - Mistletoe & Wine and getting next track. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreCommandRouter::servicePushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received 80s80s Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760173] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=75&count=1 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760174] [80s80s] Pushing the next song state Cliff Richard - Mistletoe & Wine and getting next track. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreCommandRouter::servicePushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received 80s80s Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760174] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=75&count=1 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760204] [80s80s] received new event containing 1 songs. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760204] [80s80s] PlayNextTrack API delay: 30 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760205] [80s80s] Setting timer to: 237000 milliseconds. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760256] [80s80s] received new event containing 1 songs. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760256] [80s80s] PlayNextTrack API delay: 30 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: [1766732760257] [80s80s] Setting timer to: 237000 milliseconds. Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 5 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 4 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Prefetching next song Dec 26 08:06:00 volumiopi4 volumio[1032]: info: DOING PREFETCH IN MPD Dec 26 08:06:00 volumiopi4 volumio[1032]: verbose: ControllerMpd::sendMpdCommand add "USB/Musica/fla/FLAC/Pink Floyd - The Dark Side Of The Moon (50th Anniversary) (2023 Remaster) (1973) [24Bit]/05. Pink Floyd - The Great Gig in the Sky (2023 Remaster) (Explicit).flac" Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreStateMachine::startPlaybackTimer Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 4 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Dec 26 08:06:00 volumiopi4 volumio[1032]: ---------------------------- MPD announces system playlist update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Ignoring MPD Status Update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: sendMpdCommand add "USB/Musica/fla/FLAC/Pink Floyd - The Dark Side Of The Moon (50th Anniversary) (2023 Remaster) (1973) [24Bit]/05. Pink Floyd - The Great Gig in the Sky (2023 Remaster) (Explicit).flac" took 1 milliseconds Dec 26 08:06:00 volumiopi4 volumio[1032]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Dec 26 08:06:00 volumiopi4 volumio[1032]: ---------------------------- MPD announces system playlist update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Ignoring MPD Status Update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Dec 26 08:06:00 volumiopi4 volumio[1032]: ---------------------------- MPD announces system playlist update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Ignoring MPD Status Update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Dec 26 08:06:00 volumiopi4 volumio[1032]: ---------------------------- MPD announces system playlist update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: Ignoring MPD Status Update Dec 26 08:06:00 volumiopi4 volumio[1032]: info: ------------------------------ 17ms Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreStateMachine::pushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 4 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreCommandRouter::volumioPushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: FusionDsp - volume level for loudness 0 gain applied 23.00 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 26 08:06:00 volumiopi4 volumio[1032]: info: FusionDsp - Loudness is ON true Dec 26 08:06:00 volumiopi4 volumio[1032]: info: sendMpdCommand consume 1 took 26 milliseconds Dec 26 08:06:00 volumiopi4 volumio[1032]: info: ------------------------------ 36ms Dec 26 08:06:00 volumiopi4 volumio[1032]: info: ------------------------------ 46ms Dec 26 08:06:00 volumiopi4 volumio[1032]: info: ------------------------------ 59ms Dec 26 08:06:00 volumiopi4 volumio[1032]: error: FusionDsp - WebSocket error: [object Object] Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreStateMachine::pushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CorePlayQueue::getTrack 4 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: CoreCommandRouter::volumioPushState Dec 26 08:06:00 volumiopi4 volumio[1032]: info: FusionDsp - volume level for loudness 0 gain applied 23.00 Dec 26 08:06:00 volumiopi4 volumio[1032]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 26 08:06:00 volumiopi4 volumio[1032]: info: FusionDsp - Loudness is ON true Dec 26 08:06:00 volumiopi4 volumio[1032]: error: FusionDsp - WebSocket error: [object Object] Dec 26 08:06:15 volumiopi4 volumio[1032]: info: [1766732775290] [80s80s] Failed to query api, status code: 504 Dec 26 08:06:15 volumiopi4 volumio[1032]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 08:06:15 volumiopi4 volumio[1032]: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/80s80s/fake-data.json' Dec 26 08:06:15 volumiopi4 volumio[1032]: at Object.openSync (fs.js:476:3) Dec 26 08:06:15 volumiopi4 volumio[1032]: at Object.readFileSync (fs.js:377:35) Dec 26 08:06:15 volumiopi4 volumio[1032]: at ClientRequest. (/data/plugins/music_service/80s80s/index.js:485:23) Dec 26 08:06:15 volumiopi4 volumio[1032]: at Object.onceWrapper (events.js:422:26) Dec 26 08:06:15 volumiopi4 volumio[1032]: at ClientRequest.emit (events.js:315:20) Dec 26 08:06:15 volumiopi4 volumio[1032]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Dec 26 08:06:15 volumiopi4 volumio[1032]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Dec 26 08:06:15 volumiopi4 volumio[1032]: at Socket.socketOnData (_http_client.js:509:22) Dec 26 08:06:15 volumiopi4 volumio[1032]: at Socket.emit (events.js:315:20) Dec 26 08:06:15 volumiopi4 volumio[1032]: at addChunk (internal/streams/readable.js:309:12) Dec 26 08:06:15 volumiopi4 volumio[1032]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 26 08:06:15 volumiopi4 volumio[1032]: at Socket.Readable.push (internal/streams/readable.js:223:10) Dec 26 08:06:15 volumiopi4 volumio[1032]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23) { Dec 26 08:06:15 volumiopi4 volumio[1032]: errno: -2, Dec 26 08:06:15 volumiopi4 volumio[1032]: syscall: 'open', Dec 26 08:06:15 volumiopi4 volumio[1032]: code: 'ENOENT', Dec 26 08:06:15 volumiopi4 volumio[1032]: path: '/data/plugins/music_service/80s80s/fake-data.json' Dec 26 08:06:15 volumiopi4 volumio[1032]: } Dec 26 08:06:15 volumiopi4 volumio[1032]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 08:06:15 volumiopi4 sudo[24032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-26 08:05 Dec 26 08:06:15 volumiopi4 sudo[24032]: pam_unix(sudo:session): session opened for user root by (uid=0) 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"