-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Tue 2025-04-29 21:09:08 CST. -- Apr 29 21:08:01 volumio kernel: hwmon hwmon1: Voltage normalised Apr 29 21:08:03 volumio sudo[4942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 21:08:03 volumio sudo[4942]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:08:03 volumio sudo[4942]: pam_unix(sudo:session): session closed for user root Apr 29 21:08:03 volumio sudo[4944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 21:08:03 volumio sudo[4944]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:08:03 volumio sudo[4944]: pam_unix(sudo:session): session closed for user root Apr 29 21:08:03 volumio volumio[984]: verbose: New Socket.io Connection to 192.168.10.115 from 192.168.10.105 UA: Mozilla/5.0 (Linux; U; Android 15; zh-cn; PHZ110 Build/AP3A.240617.008) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/121.0.6167.71 MQQBrowser/16.1 Mobile Safari/537.36 COVC/047707 Engine version: 3 Transport: polling Total Clients: 5 Apr 29 21:08:03 volumio volumio[984]: info: Received Get System Info Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:08:03 volumio volumio[984]: info: Discovery: Getting this device information Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 21:08:03 volumio volumio[984]: info: Received Get System Info Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:08:03 volumio volumio[984]: info: Discovery: Getting this device information Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 29 21:08:03 volumio volumio[984]: info: Listing playlists Apr 29 21:08:03 volumio volumio[984]: info: Received Get System Info Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:08:03 volumio volumio[984]: info: Discovery: Getting this device information Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:08:03 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 29 21:08:04 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 29 21:08:05 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 21:08:10 volumio volumio[984]: info: Retrieving Cloud Streaming UI Apr 29 21:08:10 volumio volumio[984]: info: Getting Tidal Cloud Configuration Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 21:08:10 volumio volumio[984]: info: Getting Qobuz Cloud Configuration Apr 29 21:08:10 volumio volumio[984]: info: Asking plugin for UI Config Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 21:08:10 volumio volumio[984]: info: Getting Spotify Cloud Configuration Apr 29 21:08:10 volumio volumio[984]: info: Asking plugin for UI Config Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 21:08:10 volumio volumio[984]: info: Saving Spotify Acccount Apr 29 21:08:10 volumio volumio[984]: info: Got Tidal Cloud Configuration Apr 29 21:08:10 volumio volumio[984]: info: Got it Apr 29 21:08:10 volumio volumio[984]: info: Got it Apr 29 21:08:10 volumio volumio[984]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 21:08:10 volumio volumio[984]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::volumioGetBrowseSources Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::volumioGetBrowseSources Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::volumioGetBrowseSources Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:10 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 29 21:08:13 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 29 21:08:14 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:15 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 29 21:08:15 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 29 21:08:17 volumio volumio[984]: info: Error browsing device ATAO3622xs for shares : Error: Command failed: echo volumio | smbclient -L ATAO3622xs.local. Apr 29 21:08:17 volumio volumio[984]: Unable to initialize messaging context Apr 29 21:08:18 volumio volumio[984]: info: Error browsing device ATAO for shares : Error: Command failed: echo volumio | smbclient -L ATAO.local. Apr 29 21:08:18 volumio volumio[984]: Unable to initialize messaging context Apr 29 21:08:18 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:21 volumio kernel: hwmon hwmon1: Voltage normalised Apr 29 21:08:22 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:25 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 29 21:08:26 volumio volumio[984]: info: Enabling MyMusic plugin upnp Apr 29 21:08:26 volumio volumio[984]: info: Enabling plugin upnp Apr 29 21:08:26 volumio volumio[984]: info: Loading plugin "upnp"... Apr 29 21:08:26 volumio volumio[984]: info: [1745932106707] Starting Upmpd Daemon Apr 29 21:08:26 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:08:26 volumio volumio[984]: info: Done. Apr 29 21:08:26 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:30 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:32 volumio kernel: hwmon hwmon1: Voltage normalised Apr 29 21:08:34 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:35 volumio volumio[984]: info: Enabling MyMusic plugin cd_controller Apr 29 21:08:35 volumio volumio[984]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service cd_controller Apr 29 21:08:35 volumio volumio[984]: info: [MyVolumio PluginManager] Plugin music_service cd_controller not in user plan, not enabling Apr 29 21:08:35 volumio volumio[984]: info: Error: Plugin music_service cd_controller not in user plan, not enabling Apr 29 21:08:35 volumio volumio[984]: error: Could not Enable MyMusic Plugin: Error Apr 29 21:08:36 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 29 21:08:36 volumio sudo[5029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 21:08:36 volumio sudo[5029]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:08:36 volumio sudo[5029]: pam_unix(sudo:session): session closed for user root Apr 29 21:08:36 volumio sudo[5031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 21:08:36 volumio sudo[5031]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:08:36 volumio sudo[5031]: pam_unix(sudo:session): session closed for user root Apr 29 21:08:36 volumio sudo[5035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 29 21:08:36 volumio sudo[5035]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:08:36 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 29 21:08:36 volumio sudo[5035]: pam_unix(sudo:session): session closed for user root Apr 29 21:08:37 volumio volumio[984]: info: Upmpdcli Daemon Started Apr 29 21:08:37 volumio ntpd[789]: Soliciting pool server 193.182.111.143 Apr 29 21:08:37 volumio volumio[5037]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 29 21:08:38 volumio ntpd[789]: Soliciting pool server 2a01:4f8:c2c:477d::2 Apr 29 21:08:38 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:39 volumio volumio[5037]: ..........++++ Apr 29 21:08:42 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:43 volumio ntpd[789]: Soliciting pool server 84.16.73.33 Apr 29 21:08:46 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:50 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:54 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:08:57 volumio volumio[984]: info: Disabling MyMusic plugin upnp Apr 29 21:08:57 volumio sudo[5165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 29 21:08:57 volumio sudo[5165]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:08:57 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 29 21:08:58 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:09:02 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:09:05 volumio kernel: hwmon hwmon1: Voltage normalised Apr 29 21:09:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 21:09:07 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 29 21:09:07 volumio volumio[984]: info: Enabling MyMusic plugin upnp Apr 29 21:09:07 volumio volumio[984]: info: Enabling plugin upnp Apr 29 21:09:07 volumio volumio[984]: info: Loading plugin "upnp"... Apr 29 21:09:07 volumio volumio[984]: info: [1745932147826] Starting Upmpd Daemon Apr 29 21:09:07 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:09:07 volumio volumio[984]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 21:09:07 volumio volumio[984]: Error: listen EADDRINUSE: address already in use :::6599 Apr 29 21:09:07 volumio volumio[984]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Apr 29 21:09:07 volumio volumio[984]: at listenInCluster (net.js:1366:12) Apr 29 21:09:07 volumio volumio[984]: at Server.listen (net.js:1452:7) Apr 29 21:09:07 volumio volumio[984]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 29 21:09:07 volumio volumio[984]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 29 21:09:07 volumio volumio[984]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 29 21:09:07 volumio volumio[984]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 29 21:09:07 volumio volumio[984]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 29 21:09:07 volumio volumio[984]: code: 'EADDRINUSE', Apr 29 21:09:07 volumio volumio[984]: errno: -98, Apr 29 21:09:07 volumio volumio[984]: syscall: 'listen', Apr 29 21:09:07 volumio volumio[984]: address: '::', Apr 29 21:09:07 volumio volumio[984]: port: 6599 Apr 29 21:09:07 volumio volumio[984]: } Apr 29 21:09:07 volumio volumio[984]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 21:09:08 volumio sudo[5224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-29 21:08 Apr 29 21:09:08 volumio sudo[5224]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"