Oct 13 17:14:03 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7076. Oct 13 17:14:03 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:14:03 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:14:03 volumio upmpdcli[9842]: Could not open config: /tmp/upmpdcli.conf Oct 13 17:14:03 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 17:14:03 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 17:14:18 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7077. Oct 13 17:14:18 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:14:18 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:14:18 volumio upmpdcli[9871]: Could not open config: /tmp/upmpdcli.conf Oct 13 17:14:18 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 17:14:18 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 17:14:34 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7078. Oct 13 17:14:34 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:14:34 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:14:34 volumio upmpdcli[9888]: Could not open config: /tmp/upmpdcli.conf Oct 13 17:14:34 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 17:14:34 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 17:14:49 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7079. Oct 13 17:14:49 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:14:49 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:14:49 volumio upmpdcli[9919]: Could not open config: /tmp/upmpdcli.conf Oct 13 17:14:49 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 17:14:49 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 17:15:04 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7080. Oct 13 17:15:04 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:15:04 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:15:04 volumio upmpdcli[9934]: Could not open config: /tmp/upmpdcli.conf Oct 13 17:15:04 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 17:15:04 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 17:15:19 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7081. Oct 13 17:15:19 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:15:19 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:15:19 volumio upmpdcli[9964]: Could not open config: /tmp/upmpdcli.conf Oct 13 17:15:19 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 17:15:19 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 17:15:35 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7082. Oct 13 17:15:35 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:15:35 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:15:35 volumio upmpdcli[9994]: Could not open config: /tmp/upmpdcli.conf Oct 13 17:15:35 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 17:15:35 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 17:15:38 volumio volumio[1128]: info: Oct 13 17:15:38 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 13 17:15:38 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 13 17:15:38 volumio volumio[1128]: info: Oct 13 17:15:38 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 13 17:15:38 volumio volumio[1128]: info: ControllerMpd::getState Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 13 17:15:38 volumio volumio[1128]: info: Oct 13 17:15:38 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 13 17:15:38 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 13 17:15:38 volumio volumio[1128]: info: Oct 13 17:15:38 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 13 17:15:38 volumio volumio[1128]: info: ControllerMpd::getState Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 13 17:15:38 volumio volumio[1128]: info: Oct 13 17:15:38 volumio volumio[1128]: ---------------------------- MPD announces system playlist update Oct 13 17:15:38 volumio volumio[1128]: info: Ignoring MPD Status Update Oct 13 17:15:38 volumio volumio[1128]: info: Oct 13 17:15:38 volumio volumio[1128]: ---------------------------- MPD announces state update: player Oct 13 17:15:38 volumio volumio[1128]: info: ControllerMpd::getState Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Oct 13 17:15:38 volumio volumio[1128]: info: ------------------------------ 4ms Oct 13 17:15:38 volumio volumio[1128]: info: sendMpdCommand status took 3 milliseconds Oct 13 17:15:38 volumio volumio[1128]: info: ------------------------------ 3ms Oct 13 17:15:38 volumio volumio[1128]: info: sendMpdCommand status took 2 milliseconds Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 17:15:38 volumio volumio[1128]: info: ------------------------------ 4ms Oct 13 17:15:38 volumio volumio[1128]: info: sendMpdCommand status took 3 milliseconds Oct 13 17:15:38 volumio volumio[1128]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 13 17:15:38 volumio volumio[1128]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::parseState Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::parseTrackInfo Oct 13 17:15:38 volumio volumio[1128]: verbose: ControllerMpd::parseTrackInfo Oct 13 17:15:38 volumio volumio[1128]: info: ControllerMpd::pushState Oct 13 17:15:38 volumio volumio[1128]: info: CoreCommandRouter::servicePushState Oct 13 17:15:38 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 13 17:15:38 volumio volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":119997,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Billy Joel - Honesty","artist":"Made in 80","album":null,"uri":"http://162.19.79.231:8002/","trackType":"231:8002/"} Oct 13 17:15:38 volumio volumio[1128]: verbose: CURRENT POSITION 0 Oct 13 17:15:38 volumio volumio[1128]: info: CoreStateMachine::syncState stateService play Oct 13 17:15:38 volumio volumio[1128]: info: CoreStateMachine::syncState currentStatus play Oct 13 17:15:38 volumio volumio[1128]: info: Received an update from plugin. extracting info from payload Oct 13 17:15:38 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 13 17:15:38 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 13 17:15:38 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 17:15:38 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 13 17:15:38 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 13 17:15:38 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 13 17:15:39 volumio volumio[1128]: info: ControllerMpd::pushState Oct 13 17:15:39 volumio volumio[1128]: info: CoreCommandRouter::servicePushState Oct 13 17:15:39 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 13 17:15:39 volumio volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":119997,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Billy Joel - Honesty","artist":"Made in 80","album":null,"uri":"http://162.19.79.231:8002/","trackType":"231:8002/"} Oct 13 17:15:39 volumio volumio[1128]: verbose: CURRENT POSITION 0 Oct 13 17:15:39 volumio volumio[1128]: info: CoreStateMachine::syncState stateService play Oct 13 17:15:39 volumio volumio[1128]: info: CoreStateMachine::syncState currentStatus play Oct 13 17:15:39 volumio volumio[1128]: info: Received an update from plugin. extracting info from payload Oct 13 17:15:39 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 13 17:15:39 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 13 17:15:39 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 13 17:15:39 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 13 17:15:39 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 13 17:15:39 volumio volumio[1128]: info: ------------------------------ 21ms Oct 13 17:15:39 volumio volumio[1128]: info: ------------------------------ 20ms Oct 13 17:15:39 volumio volumio[1128]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 13 17:15:39 volumio volumio[1128]: verbose: ControllerMpd::parseTrackInfo Oct 13 17:15:39 volumio volumio[1128]: info: ControllerMpd::pushState Oct 13 17:15:39 volumio volumio[1128]: info: CoreCommandRouter::servicePushState Oct 13 17:15:39 volumio volumio[1128]: info: CorePlayQueue::getTrack 0 Oct 13 17:15:39 volumio volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":119997,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Billy Joel - Honesty","artist":"Made in 80","album":null,"uri":"http://162.19.79.231:8002/","trackType":"231:8002/"} Oct 13 17:15:39 volumio volumio[1128]: verbose: CURRENT POSITION 0 Oct 13 17:15:39 volumio volumio[1128]: info: CoreStateMachine::syncState stateService play Oct 13 17:15:39 volumio volumio[1128]: info: CoreStateMachine::syncState currentStatus play Oct 13 17:15:39 volumio volumio[1128]: info: Received an update from plugin. extracting info from payload Oct 13 17:15:39 volumio volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 13 17:15:39 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 13 17:15:39 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 13 17:15:39 volumio volumio[1128]: info: CoreStateMachine::pushState Oct 13 17:15:39 volumio volumio[1128]: info: CoreCommandRouter::volumioPushState Oct 13 17:15:39 volumio volumio[1128]: info: ------------------------------ 29ms Oct 13 17:15:50 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7083. Oct 13 17:15:50 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:15:50 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 13 17:15:50 volumio upmpdcli[10010]: Could not open config: /tmp/upmpdcli.conf Oct 13 17:15:50 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 13 17:15:50 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 13 17:15:53 volumio volumio[1128]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 17:15:53 volumio volumio[1128]: Error: connect ETIMEDOUT 146.75.118.53:443 Oct 13 17:15:53 volumio volumio[1128]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 13 17:15:53 volumio volumio[1128]: errno: -110, Oct 13 17:15:53 volumio volumio[1128]: code: 'ETIMEDOUT', Oct 13 17:15:53 volumio volumio[1128]: syscall: 'connect', Oct 13 17:15:53 volumio volumio[1128]: address: '146.75.118.53', Oct 13 17:15:53 volumio volumio[1128]: port: 443 Oct 13 17:15:53 volumio volumio[1128]: } Oct 13 17:15:53 volumio volumio[1128]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 17:15:54 volumio sudo[10025]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 17:14' Oct 13 17:15:54 volumio sudo[10025]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"