-- Logs begin at Mon 2026-08-24 12:11:33 CEST, end at Tue 2026-08-25 20:42:52 CEST. -- Aug 25 20:41:04 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:04 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:09 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:09 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:14 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:14 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:20 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:20 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:25 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:25 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:30 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:30 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:35 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:35 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:40 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:40 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:45 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:45 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:50 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:51 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:41:56 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:41:56 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:01 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:01 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:06 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:06 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:11 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:11 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:16 volumio volumio[9745]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 20:42:16 volumio volumio[9745]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 25 20:42:16 volumio volumio[9745]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 20:42:16 volumio volumio[9745]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 20:42:18 volumio volumio[9745]: info: [SmartRemote] Fermato Aug 25 20:42:18 volumio volumio[9745]: info: Disabling plugin smartremote Aug 25 20:42:18 volumio volumio[9745]: info: Done. Aug 25 20:42:19 volumio volumio[9745]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 20:42:19 volumio volumio[9745]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 20:42:19 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:19 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:20 volumio volumio[9745]: info: Aug 25 20:42:20 volumio volumio[9745]: ---------------------------- MPD announces system playlist update Aug 25 20:42:20 volumio volumio[9745]: info: Ignoring MPD Status Update Aug 25 20:42:20 volumio volumio[9745]: info: Aug 25 20:42:20 volumio volumio[9745]: ---------------------------- MPD announces state update: player Aug 25 20:42:20 volumio volumio[9745]: info: ControllerMpd::getState Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::sendMpdCommand status Aug 25 20:42:20 volumio volumio[9745]: info: Aug 25 20:42:20 volumio volumio[9745]: ---------------------------- MPD announces system playlist update Aug 25 20:42:20 volumio volumio[9745]: info: Ignoring MPD Status Update Aug 25 20:42:20 volumio volumio[9745]: info: Aug 25 20:42:20 volumio volumio[9745]: ---------------------------- MPD announces state update: player Aug 25 20:42:20 volumio volumio[9745]: info: ControllerMpd::getState Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::sendMpdCommand status Aug 25 20:42:20 volumio volumio[9745]: info: Aug 25 20:42:20 volumio volumio[9745]: ---------------------------- MPD announces system playlist update Aug 25 20:42:20 volumio volumio[9745]: info: Ignoring MPD Status Update Aug 25 20:42:20 volumio volumio[9745]: info: Aug 25 20:42:20 volumio volumio[9745]: ---------------------------- MPD announces state update: player Aug 25 20:42:20 volumio volumio[9745]: info: ControllerMpd::getState Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::sendMpdCommand status Aug 25 20:42:20 volumio volumio[9745]: info: Aug 25 20:42:20 volumio volumio[9745]: ---------------------------- MPD announces system playlist update Aug 25 20:42:20 volumio volumio[9745]: info: Ignoring MPD Status Update Aug 25 20:42:20 volumio volumio[9745]: info: Aug 25 20:42:20 volumio volumio[9745]: ---------------------------- MPD announces state update: player Aug 25 20:42:20 volumio volumio[9745]: info: ControllerMpd::getState Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::sendMpdCommand status Aug 25 20:42:20 volumio volumio[9745]: info: ------------------------------ 177ms Aug 25 20:42:20 volumio volumio[9745]: info: sendMpdCommand status took 165 milliseconds Aug 25 20:42:20 volumio volumio[9745]: info: ------------------------------ 160ms Aug 25 20:42:20 volumio volumio[9745]: info: sendMpdCommand status took 152 milliseconds Aug 25 20:42:20 volumio volumio[9745]: info: ------------------------------ 149ms Aug 25 20:42:20 volumio volumio[9745]: info: sendMpdCommand status took 144 milliseconds Aug 25 20:42:20 volumio volumio[9745]: info: ------------------------------ 141ms Aug 25 20:42:20 volumio volumio[9745]: info: sendMpdCommand status took 135 milliseconds Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::parseState Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::parseState Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::parseState Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::parseState Aug 25 20:42:20 volumio volumio[9745]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 20:42:21 volumio volumio[9745]: info: sendMpdCommand playlistinfo took 116 milliseconds Aug 25 20:42:21 volumio volumio[9745]: info: sendMpdCommand playlistinfo took 117 milliseconds Aug 25 20:42:21 volumio volumio[9745]: info: sendMpdCommand playlistinfo took 116 milliseconds Aug 25 20:42:21 volumio volumio[9745]: info: sendMpdCommand playlistinfo took 114 milliseconds Aug 25 20:42:21 volumio volumio[9745]: verbose: ControllerMpd::parseTrackInfo Aug 25 20:42:21 volumio volumio[9745]: verbose: ControllerMpd::parseTrackInfo Aug 25 20:42:21 volumio volumio[9745]: verbose: ControllerMpd::parseTrackInfo Aug 25 20:42:21 volumio volumio[9745]: verbose: ControllerMpd::parseTrackInfo Aug 25 20:42:21 volumio volumio[9745]: info: ControllerMpd::pushState Aug 25 20:42:21 volumio volumio[9745]: info: CoreCommandRouter::servicePushState Aug 25 20:42:21 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:21 volumio volumio[9745]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Aug 25 20:42:21 volumio volumio[9745]: info: ControllerMpd::pushState Aug 25 20:42:21 volumio volumio[9745]: info: CoreCommandRouter::servicePushState Aug 25 20:42:21 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:21 volumio volumio[9745]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Aug 25 20:42:21 volumio volumio[9745]: info: ControllerMpd::pushState Aug 25 20:42:21 volumio volumio[9745]: info: CoreCommandRouter::servicePushState Aug 25 20:42:21 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:21 volumio volumio[9745]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Aug 25 20:42:21 volumio volumio[9745]: info: ControllerMpd::pushState Aug 25 20:42:21 volumio volumio[9745]: info: CoreCommandRouter::servicePushState Aug 25 20:42:21 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:21 volumio volumio[9745]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Aug 25 20:42:21 volumio volumio[9745]: info: ------------------------------ 354ms Aug 25 20:42:21 volumio volumio[9745]: info: ------------------------------ 334ms Aug 25 20:42:21 volumio volumio[9745]: info: ------------------------------ 324ms Aug 25 20:42:21 volumio volumio[9745]: info: ------------------------------ 314ms Aug 25 20:42:21 volumio volumio[9745]: info: Enabling plugin smartremote Aug 25 20:42:21 volumio volumio[9745]: info: Loading plugin "smartremote"... Aug 25 20:42:21 volumio volumio[9745]: info: [SmartRemote] Configurazione caricata Aug 25 20:42:21 volumio volumio[9745]: info: PLUGIN START: smartremote Aug 25 20:42:21 volumio volumio[9745]: info: [SmartRemote] Avvio v0.2 Aug 25 20:42:21 volumio volumio[9745]: info: Done. Aug 25 20:42:21 volumio volumio[9745]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Aug 25 20:42:21 volumio volumio[9745]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 20:42:21 volumio volumio[9745]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 20:42:21 volumio volumio[9745]: info: [SmartRemote] Connesso al socket Volumio Aug 25 20:42:21 volumio volumio[9745]: info: CoreCommandRouter::volumioGetState Aug 25 20:42:21 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:23 volumio volumio[9745]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 20:42:24 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:24 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:29 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:29 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:34 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:34 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:34 volumio volumio[9745]: info: [1787683354812] [80s80s] Pushing the next song state Feargal Sharkey - A Good Heart and getting next track. Aug 25 20:42:34 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:34 volumio volumio[9745]: info: CoreCommandRouter::servicePushState Aug 25 20:42:34 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:34 volumio volumio[9745]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music6/v4/cf/7b/ee/cf7bee93-579c-ba57-f423-b6385214609e/source/600x600bb.jpg","name":"Feargal Sharkey - A Good Heart","title":"A Good Heart","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"268","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Aug 25 20:42:34 volumio volumio[9745]: verbose: CURRENT POSITION 0 Aug 25 20:42:34 volumio volumio[9745]: info: CoreStateMachine::syncState stateService play Aug 25 20:42:34 volumio volumio[9745]: info: CoreStateMachine::syncState currentStatus play Aug 25 20:42:34 volumio volumio[9745]: info: Received an update from plugin. extracting info from payload Aug 25 20:42:34 volumio volumio[9745]: info: CoreStateMachine::pushState Aug 25 20:42:34 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:34 volumio volumio[9745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 20:42:34 volumio volumio[9745]: info: CoreCommandRouter::volumioPushState Aug 25 20:42:34 volumio volumio[9745]: info: CoreStateMachine::pushState Aug 25 20:42:34 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:34 volumio volumio[9745]: info: CoreCommandRouter::volumioPushState Aug 25 20:42:34 volumio volumio[9745]: info: [1787683354965] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=1 Aug 25 20:42:34 volumio volumio[9745]: info: CorePlayQueue::getTrack 0 Aug 25 20:42:34 volumio volumio[9745]: info: CorePlayQueue::getTrack 1 Aug 25 20:42:35 volumio volumio[9745]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 25 20:42:35 volumio volumio[9745]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Aug 25 20:42:39 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:39 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:45 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:45 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:46 volumio volumio[9745]: info: CALLMETHOD: system_controller smartremote startListening undefined Aug 25 20:42:46 volumio volumio[9745]: info: CoreCommandRouter::executeOnPlugin: smartremote , startListening Aug 25 20:42:46 volumio volumio[9745]: info: [SmartRemote] Ascolta musica: accensione e sync ampli Aug 25 20:42:46 volumio volumio[9745]: error: [SmartRemote] Errore avvio ascolto: this.broadlink.sendFrames is not a function Aug 25 20:42:50 volumio volumio[9745]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 25 20:42:50 volumio volumio[9745]: info: Discovery: Restarting Browsing Aug 25 20:42:50 volumio volumio[9745]: info: [1787683370174] [80s80s] Failed to query api, status code: 504 Aug 25 20:42:50 volumio volumio[9745]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 20:42:50 volumio volumio[9745]: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/80s80s/fake-data.json' Aug 25 20:42:50 volumio volumio[9745]: at Object.openSync (fs.js:476:3) Aug 25 20:42:50 volumio volumio[9745]: at Object.readFileSync (fs.js:377:35) Aug 25 20:42:50 volumio volumio[9745]: at ClientRequest. (/data/plugins/music_service/80s80s/index.js:485:23) Aug 25 20:42:50 volumio volumio[9745]: at Object.onceWrapper (events.js:422:26) Aug 25 20:42:50 volumio volumio[9745]: at ClientRequest.emit (events.js:315:20) Aug 25 20:42:50 volumio volumio[9745]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Aug 25 20:42:50 volumio volumio[9745]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Aug 25 20:42:50 volumio volumio[9745]: at Socket.socketOnData (_http_client.js:509:22) Aug 25 20:42:50 volumio volumio[9745]: at Socket.emit (events.js:315:20) Aug 25 20:42:50 volumio volumio[9745]: at addChunk (internal/streams/readable.js:309:12) Aug 25 20:42:50 volumio volumio[9745]: at readableAddChunk (internal/streams/readable.js:284:9) Aug 25 20:42:50 volumio volumio[9745]: at Socket.Readable.push (internal/streams/readable.js:223:10) Aug 25 20:42:50 volumio volumio[9745]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23) { Aug 25 20:42:50 volumio volumio[9745]: errno: -2, Aug 25 20:42:50 volumio volumio[9745]: syscall: 'open', Aug 25 20:42:50 volumio volumio[9745]: code: 'ENOENT', Aug 25 20:42:50 volumio volumio[9745]: path: '/data/plugins/music_service/80s80s/fake-data.json' Aug 25 20:42:50 volumio volumio[9745]: } Aug 25 20:42:50 volumio volumio[9745]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 20:42:52 volumio sudo[10930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-25 20:41 Aug 25 20:42:52 volumio sudo[10930]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"