-- Logs begin at Fri 2025-10-10 15:43:27 UTC, end at Thu 2025-10-16 06:05:52 UTC. -- Oct 16 06:04:30 volumio volumio[1136]: info: Oct 16 06:04:30 volumio volumio[1136]: ---------------------------- MPD announces system playlist update Oct 16 06:04:30 volumio volumio[1136]: info: Ignoring MPD Status Update Oct 16 06:04:30 volumio volumio[1136]: info: Oct 16 06:04:30 volumio volumio[1136]: ---------------------------- MPD announces state update: player Oct 16 06:04:30 volumio volumio[1136]: info: ControllerMpd::getState Oct 16 06:04:30 volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Oct 16 06:04:30 volumio volumio[1136]: info: Oct 16 06:04:30 volumio volumio[1136]: ---------------------------- MPD announces system playlist update Oct 16 06:04:30 volumio volumio[1136]: info: Ignoring MPD Status Update Oct 16 06:04:30 volumio volumio[1136]: info: Oct 16 06:04:30 volumio volumio[1136]: ---------------------------- MPD announces state update: player Oct 16 06:04:30 volumio volumio[1136]: info: ControllerMpd::getState Oct 16 06:04:30 volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Oct 16 06:04:30 volumio volumio[1136]: info: ------------------------------ 8ms Oct 16 06:04:30 volumio volumio[1136]: info: sendMpdCommand status took 7 milliseconds Oct 16 06:04:30 volumio volumio[1136]: info: ------------------------------ 6ms Oct 16 06:04:30 volumio volumio[1136]: info: sendMpdCommand status took 5 milliseconds Oct 16 06:04:30 volumio volumio[1136]: verbose: ControllerMpd::parseState Oct 16 06:04:30 volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 06:04:30 volumio volumio[1136]: verbose: ControllerMpd::parseState Oct 16 06:04:30 volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 06:04:30 volumio volumio[1136]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 16 06:04:30 volumio volumio[1136]: verbose: ControllerMpd::parseTrackInfo Oct 16 06:04:30 volumio volumio[1136]: info: ControllerMpd::pushState Oct 16 06:04:30 volumio volumio[1136]: info: CoreCommandRouter::servicePushState Oct 16 06:04:30 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:04:30 volumio volumio[1136]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 16 06:04:30 volumio volumio[1136]: info: ControllerMpd::pushState Oct 16 06:04:30 volumio volumio[1136]: info: CoreCommandRouter::servicePushState Oct 16 06:04:30 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:04:30 volumio volumio[1136]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 16 06:04:30 volumio volumio[1136]: info: ------------------------------ 13ms Oct 16 06:04:30 volumio volumio[1136]: info: ------------------------------ 12ms Oct 16 06:04:45 volumio volumio[1136]: info: Oct 16 06:04:45 volumio volumio[1136]: ---------------------------- MPD announces system playlist update Oct 16 06:04:45 volumio volumio[1136]: info: Ignoring MPD Status Update Oct 16 06:04:45 volumio volumio[1136]: info: Oct 16 06:04:45 volumio volumio[1136]: ---------------------------- MPD announces state update: player Oct 16 06:04:45 volumio volumio[1136]: info: ControllerMpd::getState Oct 16 06:04:45 volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Oct 16 06:04:45 volumio volumio[1136]: info: Oct 16 06:04:45 volumio volumio[1136]: ---------------------------- MPD announces system playlist update Oct 16 06:04:45 volumio volumio[1136]: info: Ignoring MPD Status Update Oct 16 06:04:45 volumio volumio[1136]: info: Oct 16 06:04:45 volumio volumio[1136]: ---------------------------- MPD announces state update: player Oct 16 06:04:45 volumio volumio[1136]: info: ControllerMpd::getState Oct 16 06:04:45 volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Oct 16 06:04:45 volumio volumio[1136]: info: ------------------------------ 5ms Oct 16 06:04:45 volumio volumio[1136]: info: sendMpdCommand status took 4 milliseconds Oct 16 06:04:45 volumio volumio[1136]: info: ------------------------------ 3ms Oct 16 06:04:45 volumio volumio[1136]: info: sendMpdCommand status took 2 milliseconds Oct 16 06:04:45 volumio volumio[1136]: verbose: ControllerMpd::parseState Oct 16 06:04:45 volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 06:04:45 volumio volumio[1136]: verbose: ControllerMpd::parseState Oct 16 06:04:45 volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 06:04:45 volumio volumio[1136]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 06:04:45 volumio volumio[1136]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 06:04:45 volumio volumio[1136]: verbose: ControllerMpd::parseTrackInfo Oct 16 06:04:45 volumio volumio[1136]: info: ControllerMpd::pushState Oct 16 06:04:45 volumio volumio[1136]: info: CoreCommandRouter::servicePushState Oct 16 06:04:45 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:04:45 volumio volumio[1136]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 16 06:04:45 volumio volumio[1136]: info: ControllerMpd::pushState Oct 16 06:04:45 volumio volumio[1136]: info: CoreCommandRouter::servicePushState Oct 16 06:04:45 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:04:45 volumio volumio[1136]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 16 06:04:45 volumio volumio[1136]: info: ------------------------------ 9ms Oct 16 06:04:45 volumio volumio[1136]: info: ------------------------------ 7ms Oct 16 06:05:42 volumio volumio[1136]: info: [1760594742375] [80s80s] Pushing the next song state Womack & Womack - Teardrops and getting next track. Oct 16 06:05:42 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:05:42 volumio volumio[1136]: info: CoreCommandRouter::servicePushState Oct 16 06:05:42 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:05:42 volumio volumio[1136]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music124/v4/9c/0b/19/9c0b1940-0130-12d3-0b36-17c415608164/source/600x600bb.jpg","name":"Womack & Womack - Teardrops","title":"Teardrops","artist":"80s80s Love","album":"","streaming":true,"disableUiControls":true,"duration":"288","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 16 06:05:42 volumio volumio[1136]: verbose: CURRENT POSITION 0 Oct 16 06:05:42 volumio volumio[1136]: info: CoreStateMachine::syncState stateService play Oct 16 06:05:42 volumio volumio[1136]: info: CoreStateMachine::syncState currentStatus play Oct 16 06:05:42 volumio volumio[1136]: info: Received an update from plugin. extracting info from payload Oct 16 06:05:42 volumio volumio[1136]: info: CoreStateMachine::pushState Oct 16 06:05:42 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:05:42 volumio volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 06:05:42 volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Oct 16 06:05:42 volumio volumio[1136]: info: CoreStateMachine::pushState Oct 16 06:05:42 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:05:42 volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Oct 16 06:05:42 volumio volumio[1136]: info: [1760594742384] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=85&count=1 Oct 16 06:05:42 volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Oct 16 06:05:42 volumio volumio[1136]: info: Prefetching next song Oct 16 06:05:51 volumio volumio[1136]: info: [1760594751655] [80s80s] Failed to query api, status code: 504 Oct 16 06:05:51 volumio volumio[1136]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 06:05:51 volumio volumio[1136]: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/80s80s/fake-data.json' Oct 16 06:05:51 volumio volumio[1136]: at Object.openSync (fs.js:498:3) Oct 16 06:05:51 volumio volumio[1136]: at Object.readFileSync (fs.js:394:35) Oct 16 06:05:51 volumio volumio[1136]: at ClientRequest. (/data/plugins/music_service/80s80s/index.js:485:23) Oct 16 06:05:51 volumio volumio[1136]: at Object.onceWrapper (events.js:520:26) Oct 16 06:05:51 volumio volumio[1136]: at ClientRequest.emit (events.js:400:28) Oct 16 06:05:51 volumio volumio[1136]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Oct 16 06:05:51 volumio volumio[1136]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Oct 16 06:05:51 volumio volumio[1136]: at Socket.socketOnData (_http_client.js:515:22) Oct 16 06:05:51 volumio volumio[1136]: at Socket.emit (events.js:400:28) Oct 16 06:05:51 volumio volumio[1136]: at addChunk (internal/streams/readable.js:293:12) Oct 16 06:05:51 volumio volumio[1136]: at readableAddChunk (internal/streams/readable.js:267:9) Oct 16 06:05:51 volumio volumio[1136]: at Socket.Readable.push (internal/streams/readable.js:206:10) Oct 16 06:05:51 volumio volumio[1136]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23) { Oct 16 06:05:51 volumio volumio[1136]: errno: -2, Oct 16 06:05:51 volumio volumio[1136]: syscall: 'open', Oct 16 06:05:51 volumio volumio[1136]: code: 'ENOENT', Oct 16 06:05:51 volumio volumio[1136]: path: '/data/plugins/music_service/80s80s/fake-data.json' Oct 16 06:05:51 volumio volumio[1136]: } Oct 16 06:05:51 volumio volumio[1136]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 06:05:52 volumio sudo[1652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-16 06:04 Oct 16 06:05:52 volumio sudo[1652]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"