May 31 17:31:00 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:01 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:01 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:01 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:01 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:01 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:01 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 23.
May 31 17:31:01 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:31:01 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:31:01 volumio upmpdcli[2718]: Could not open config: /tmp/upmpdcli.conf
May 31 17:31:01 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
May 31 17:31:01 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
May 31 17:31:03 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 31 17:31:03 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 17:31:03 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 31 17:31:03 volumio volumio-remote-updater[652]: Test mode disabled
May 31 17:31:03 volumio volumio-remote-updater[652]: Alpha mode disabled
May 31 17:31:03 volumio volumio-remote-updater[652]: Alpha legacy test mode disabled
May 31 17:31:03 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
May 31 17:31:03 volumio volumio[2299]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
May 31 17:31:03 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 31 17:31:03 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:04 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 31 17:31:04 volumio volumio[2299]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
May 31 17:31:04 volumio volumio[2299]: info: CoreCommandRouter::volumioGetState
May 31 17:31:04 volumio volumio[2299]: info: CorePlayQueue::getTrack 0
May 31 17:31:06 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:06 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:06 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:06 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:06 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:08 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:09 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 17:31:09 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 17:31:09 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 31 17:31:09 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 31 17:31:09 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 31 17:31:09 volumio volumio[2299]: info: CoreCommandRouter::volumioGetBrowseSources
May 31 17:31:09 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 31 17:31:11 volumio volumio[2299]: error: MyVolumio Plugin failed to authenticate in a timely fashion
May 31 17:31:11 volumio volumio[2299]: info: Completed starting MyVolumio Plugin
May 31 17:31:11 volumio volumio[2299]: [Metrics] CommandRouter: 75s 698.63ms
May 31 17:31:11 volumio volumio[2299]: info: CoreCommandRouter::volumiosetStartupVolume
May 31 17:31:11 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 17:31:11 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 17:31:11 volumio volumio[2299]: info: CoreCommandRouter::Close All Modals sent
May 31 17:31:11 volumio volumio[2299]: info: CoreCommandRouter::Close All Modals sent
May 31 17:31:11 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:11 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:11 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:11 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:11 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:12 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 31 17:31:12 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 31 17:31:12 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 31 17:31:12 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:16 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:16 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:16 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:16 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:16 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:16 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:16 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 24.
May 31 17:31:16 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:31:16 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:31:17 volumio upmpdcli[2758]: Could not open config: /tmp/upmpdcli.conf
May 31 17:31:17 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
May 31 17:31:17 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
May 31 17:31:18 volumio volumio[2299]: info: BOOT COMPLETED
May 31 17:31:20 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:21 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:21 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:21 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:21 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:21 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:24 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:27 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:27 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:27 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:27 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:27 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:27 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:31 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:32 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:32 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:32 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:32 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:32 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:32 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 25.
May 31 17:31:32 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:31:32 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:31:32 volumio upmpdcli[2803]: Could not open config: /tmp/upmpdcli.conf
May 31 17:31:32 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
May 31 17:31:32 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
May 31 17:31:33 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare
May 31 17:31:33 volumio volumio[2299]: info: Share Best successfully unmounted
May 31 17:31:33 volumio sudo[2805]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.2.100:Tim\\Music\\best /mnt/NAS/Best
May 31 17:31:33 volumio sudo[2805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 17:31:35 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:37 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:37 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:37 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:37 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:37 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:39 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:42 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:42 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:42 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:42 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:42 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:44 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:47 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 26.
May 31 17:31:47 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:31:47 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:47 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:47 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:47 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:47 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:47 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:31:47 volumio upmpdcli[2835]: Could not open config: /tmp/upmpdcli.conf
May 31 17:31:47 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
May 31 17:31:47 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
May 31 17:31:47 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:51 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:52 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:52 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:52 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:52 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:52 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:55 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:31:57 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:57 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:57 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:31:57 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:31:57 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:31:59 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:32:02 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 27.
May 31 17:32:02 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:32:02 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 17:32:02 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:32:02 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:32:02 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:32:02 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:32:02 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:32:02 volumio upmpdcli[2883]: Could not open config: /tmp/upmpdcli.conf
May 31 17:32:02 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
May 31 17:32:02 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
May 31 17:32:03 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare
May 31 17:32:03 volumio volumio[2299]: info: Share Best successfully unmounted
May 31 17:32:03 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:32:03 volumio sudo[2888]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.2.100:Tim\\Music\\best /mnt/NAS/Best
May 31 17:32:03 volumio sudo[2888]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 17:32:04 volumio sudo[2359]: pam_unix(sudo:session): session closed for user root
May 31 17:32:04 volumio volumio[2299]: info: Cannot mount NAS Best at system boot, trial number 1 ,retrying in 5 seconds
May 31 17:32:07 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:32:07 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:32:07 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:32:07 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:32:07 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:32:07 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:32:09 volumio sudo[2895]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.2.100:Tim\\Music\\best /mnt/NAS/Best
May 31 17:32:09 volumio sudo[2895]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 17:32:11 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 31 17:32:13 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:32:13 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:32:13 volumio volumio[2299]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 31 17:32:13 volumio volumio[2299]: info: Discovery: Restarting Browsing
May 31 17:32:13 volumio volumio[2299]: info: Discovery: Restart already pending, ignoring duplicate call
May 31 17:32:15 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
May 31 17:32:15 volumio volumio[2299]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
May 31 17:32:15 volumio volumio[2299]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 31 17:32:15 volumio volumio[2299]: Error: getaddrinfo -3007
May 31 17:32:15 volumio volumio[2299]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
May 31 17:32:15 volumio volumio[2299]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
May 31 17:32:15 volumio volumio[2299]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
May 31 17:32:15 volumio volumio[2299]: code: -3007,
May 31 17:32:15 volumio volumio[2299]: errno: -3007,
May 31 17:32:15 volumio volumio[2299]: syscall: 'getaddrinfo'
May 31 17:32:15 volumio volumio[2299]: }
May 31 17:32:15 volumio volumio[2299]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 31 17:32:17 volumio sudo[2935]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-31 17:31'
May 31 17:32:17 volumio sudo[2935]: 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"