-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Mon 2026-01-26 08:22:30 +07. -- Jan 26 08:21:00 volumio9 go-librespot[1213]: time="2026-01-26T08:21:00+07:00" level=trace msg="sent dealer ping" Jan 26 08:21:00 volumio9 go-librespot[1213]: time="2026-01-26T08:21:00+07:00" level=trace msg="received dealer pong" Jan 26 08:21:02 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:02 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:02 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:06 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:07 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:07 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:12 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:12 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:14 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:17 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:17 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:18 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:22 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:22 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:22 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:26 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:27 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:27 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:30 volumio9 go-librespot[1213]: time="2026-01-26T08:21:30+07:00" level=trace msg="sent dealer ping" Jan 26 08:21:30 volumio9 go-librespot[1213]: time="2026-01-26T08:21:30+07:00" level=trace msg="received dealer pong" Jan 26 08:21:30 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:32 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:32 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:34 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:36 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 08:21:36 volumio9 volumio[825]: info: Received Get System Info Jan 26 08:21:36 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 08:21:36 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 08:21:36 volumio9 volumio[825]: info: Discovery: Getting this device information Jan 26 08:21:36 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jan 26 08:21:36 volumio9 volumio[825]: info: CorePlayQueue::getTrack 0 Jan 26 08:21:36 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 08:21:37 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:37 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:38 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:42 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:42 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:42 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:46 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:47 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:47 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:52 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:52 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:54 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:56 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jan 26 08:21:56 volumio9 volumio[825]: verbose: ControllerMpd::sendMpdCommand update Jan 26 08:21:56 volumio9 volumio[825]: info: sendMpdCommand update took 3 milliseconds Jan 26 08:21:57 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:21:57 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:21:58 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:21:59 volumio9 go-librespot[1213]: time="2026-01-26T08:21:59+07:00" level=trace msg="received accesspoint ping" Jan 26 08:22:00 volumio9 go-librespot[1213]: time="2026-01-26T08:22:00+07:00" level=trace msg="received accesspoint pong ack" Jan 26 08:22:00 volumio9 go-librespot[1213]: time="2026-01-26T08:22:00+07:00" level=trace msg="sent dealer ping" Jan 26 08:22:00 volumio9 go-librespot[1213]: time="2026-01-26T08:22:00+07:00" level=trace msg="received dealer pong" Jan 26 08:22:02 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:22:02 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:22:02 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:22:06 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:22:07 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:22:07 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:22:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:22:12 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:22:12 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:22:14 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:22:17 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:22:17 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:22:18 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:22:19 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jan 26 08:22:19 volumio9 sudo[10575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/NAS3 Jan 26 08:22:19 volumio9 sudo[10575]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 08:22:19 volumio9 systemd[1]: mnt-NAS-NAS3.mount: Succeeded. Jan 26 08:22:19 volumio9 sudo[10575]: pam_unix(sudo:session): session closed for user root Jan 26 08:22:19 volumio9 volumio[825]: info: Share NAS3 successfully unmounted Jan 26 08:22:20 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 26 08:22:22 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:22:22 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:22:22 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:22:22 volumio9 volumio[825]: info: [1769390542971] Database update started Jan 26 08:22:23 volumio9 sudo[10587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 26 08:22:23 volumio9 sudo[10587]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 08:22:23 volumio9 sudo[10587]: pam_unix(sudo:session): session closed for user root Jan 26 08:22:23 volumio9 sudo[10590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 26 08:22:23 volumio9 sudo[10590]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 08:22:23 volumio9 sudo[10590]: pam_unix(sudo:session): session closed for user root Jan 26 08:22:23 volumio9 volumio[825]: verbose: New Socket.io Connection to 192.168.1.80 from 192.168.1.85 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Edg/144.0.0.0 Engine version: 3 Transport: polling Total Clients: 8 Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jan 26 08:22:23 volumio9 volumio[825]: info: CorePlayQueue::getTrack 0 Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 08:22:23 volumio9 volumio[825]: info: Retrieving Cloud Streaming UI Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 26 08:22:23 volumio9 volumio[825]: info: Received Get System Info Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 08:22:23 volumio9 volumio[825]: info: Discovery: Getting this device information Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jan 26 08:22:23 volumio9 volumio[825]: info: CorePlayQueue::getTrack 0 Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jan 26 08:22:23 volumio9 volumio[825]: info: CorePlayQueue::getTrack 0 Jan 26 08:22:23 volumio9 volumio[825]: info: Listing playlists Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 26 08:22:23 volumio9 volumio[825]: info: Getting Tidal Cloud Configuration Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 08:22:23 volumio9 volumio[825]: info: Getting Qobuz Cloud Configuration Jan 26 08:22:23 volumio9 volumio[825]: info: Asking plugin for UI Config Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 08:22:23 volumio9 volumio[825]: info: Getting Spotify Cloud Configuration Jan 26 08:22:23 volumio9 volumio[825]: info: Asking plugin for UI Config Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 08:22:23 volumio9 volumio[825]: info: Saving Spotify Acccount Jan 26 08:22:23 volumio9 volumio[825]: info: Got Tidal Cloud Configuration Jan 26 08:22:23 volumio9 volumio[825]: info: Got it Jan 26 08:22:23 volumio9 volumio[825]: info: Got it Jan 26 08:22:23 volumio9 volumio[825]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 08:22:23 volumio9 volumio[825]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 26 08:22:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 26 08:22:25 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 26 08:22:25 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 08:22:25 volumio9 volumio[825]: info: Received Get System Info Jan 26 08:22:25 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 08:22:25 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 08:22:25 volumio9 volumio[825]: info: Discovery: Getting this device information Jan 26 08:22:25 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jan 26 08:22:25 volumio9 volumio[825]: info: CorePlayQueue::getTrack 0 Jan 26 08:22:25 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 08:22:26 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 08:22:26 volumio9 volumio[825]: info: Received Get System Info Jan 26 08:22:26 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 08:22:26 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 08:22:26 volumio9 volumio[825]: info: Discovery: Getting this device information Jan 26 08:22:26 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jan 26 08:22:26 volumio9 volumio[825]: info: CorePlayQueue::getTrack 0 Jan 26 08:22:26 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 08:22:27 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:22:27 volumio9 volumio[825]: info: Discovery: Restarting Browsing Jan 26 08:22:27 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 08:22:29 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jan 26 08:22:29 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jan 26 08:22:29 volumio9 dbus-daemon[627]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Jan 26 08:22:29 volumio9 volumio[825]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 08:22:29 volumio9 volumio[825]: Error: dns service error: refused Jan 26 08:22:29 volumio9 volumio[825]: at new Browser (/volumio/node_modules/mdns/lib/browser.js:88:10) Jan 26 08:22:29 volumio9 volumio[825]: at Object.create [as createBrowser] (/volumio/node_modules/mdns/lib/browser.js:116:10) Jan 26 08:22:29 volumio9 volumio[825]: at ControllerVolumioDiscovery.browseForService (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:718:32) Jan 26 08:22:29 volumio9 volumio[825]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Jan 26 08:22:29 volumio9 volumio[825]: at ControllerNetworkfs.discoverShares (/volumio/app/plugins/system_controller/networkfs/index.js:826:36) Jan 26 08:22:29 volumio9 volumio[825]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Jan 26 08:22:29 volumio9 volumio[825]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1614:45) Jan 26 08:22:29 volumio9 volumio[825]: at Socket.emit (events.js:315:20) Jan 26 08:22:29 volumio9 volumio[825]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jan 26 08:22:29 volumio9 volumio[825]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jan 26 08:22:29 volumio9 volumio[825]: errorCode: -65553 Jan 26 08:22:29 volumio9 volumio[825]: } Jan 26 08:22:29 volumio9 volumio[825]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 08:22:30 volumio9 sudo[10621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-26 08:21 Jan 26 08:22:30 volumio9 sudo[10621]: 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="58e9bc1d7073d86e583c7b0145c7ac1a2c50cfc4" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 16 Jan 2026 05:27:05 PM CET" VOLUMIO_VERSION="3.896" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="9f05a678eae13e5c68af025eb981dc26"