-- Logs begin at Sun 2025-09-14 11:10:14 CST, end at Sun 2025-09-14 11:38:27 CST. -- Sep 14 11:37:59 volumio volumio[4993]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.49 UA: Mozilla/5.0 (Linux; U; Android 15; zh-cn; 2410DPN6CC Build/AQ3A.240812.002) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.7049.79 Mobile Safari/537.36 XiaoMi/MiuiBrowser/20.0.620901 Engine version: 3 Transport: polling Total Clients: 5 Sep 14 11:37:59 volumio volumio[4993]: info: CoreCommandRouter::volumioGetState Sep 14 11:37:59 volumio volumio[4993]: info: CorePlayQueue::getTrack 0 Sep 14 11:37:59 volumio volumio[4993]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 14 11:37:59 volumio volumio[4993]: info: Listing playlists Sep 14 11:38:01 volumio volumio[4993]: info: CoreCommandRouter::volumioGetQueue Sep 14 11:38:01 volumio volumio[4993]: info: CoreStateMachine::getQueue Sep 14 11:38:01 volumio volumio[4993]: info: CorePlayQueue::getQueue Sep 14 11:38:02 volumio volumio[4993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Twins/Evolution/df65e36f-c4ad-4156-bab8-3cb06dd68313.jpg' Sep 14 11:38:02 volumio volumio[4993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%A8%E5%8D%83%E5%AC%85/a2194d9f-628a-4344-9eba-1875e4f06fa7.jpg' Sep 14 11:38:02 volumio volumio[4993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E8%8C%9C/8efc57e8-c8dc-4e3d-b5e0-5b95a7d2a6f2.jpg' Sep 14 11:38:02 volumio volumio[4993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/%E5%A4%A9%E7%A9%BA/189b888d-d32d-467f-9533-47463205a85c.png' Sep 14 11:38:02 volumio volumio[4993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%8E%E8%8D%A3%E6%B5%A9/%E5%97%AF/328d8a07-46e4-400d-bca3-39ab26a46125.jpg' Sep 14 11:38:02 volumio volumio[4993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%B3%B0/%E6%84%9B%E5%9C%A8%E8%A8%98%E6%86%B6%E4%B8%AD%E6%89%BE%E4%BD%A0/a38161ff-0a92-4575-b29b-8c4f5ba20ef1.jpg' Sep 14 11:38:02 volumio volumio[4993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E5%A5%95%E8%BF%85/%E8%AE%A4%E4%BA%86%E5%90%A7/0ad4bde6-7b60-478a-a2aa-0e90e2e4e53d.jpg' Sep 14 11:38:03 volumio volumio[4993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Twins/Samba/8ebaf5ab-1acd-4c8b-b491-5db538055098.png' Sep 14 11:38:03 volumio volumio[4993]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 11:38:03 volumio volumio[4993]: Error: connect ECONNREFUSED 67.230.169.182:443 Sep 14 11:38:03 volumio volumio[4993]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 14 11:38:03 volumio volumio[4993]: errno: -111, Sep 14 11:38:03 volumio volumio[4993]: code: 'ECONNREFUSED', Sep 14 11:38:03 volumio volumio[4993]: syscall: 'connect', Sep 14 11:38:03 volumio volumio[4993]: address: '67.230.169.182', Sep 14 11:38:03 volumio volumio[4993]: port: 443 Sep 14 11:38:03 volumio volumio[4993]: } Sep 14 11:38:03 volumio volumio[4993]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 11:38:03 volumio sudo[7310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-14 11:37 Sep 14 11:38:03 volumio sudo[7310]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:03 volumio sudo[7310]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:04 volumio volumio-remote-updater[570]: [2025-09-14 11:38:04] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Sep 14 11:38:04 volumio volumio-remote-updater[570]: [2025-09-14 11:38:04] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Sep 14 11:38:04 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Sep 14 11:38:04 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Sep 14 11:38:04 volumio systemd[1]: Started dynamicswap service. Sep 14 11:38:04 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 14 11:38:04 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Sep 14 11:38:04 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. Sep 14 11:38:04 volumio systemd[1]: Started dynamicswap service. Sep 14 11:38:04 volumio systemd[1]: Stopped Volumio Backend Module. Sep 14 11:38:04 volumio systemd[1]: Started Volumio Backend Module. Sep 14 11:38:04 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 14 11:38:06 volumio volumio[7325]: info: ------------------------------------------- Sep 14 11:38:06 volumio volumio[7325]: info: ----- Volumio3 ---- Sep 14 11:38:06 volumio volumio[7325]: info: ------------------------------------------- Sep 14 11:38:06 volumio volumio[7325]: info: ----- System startup ---- Sep 14 11:38:06 volumio volumio[7325]: info: ------------------------------------------- Sep 14 11:38:06 volumio volumio[7325]: info: MYVOLUMIO Environment detected Sep 14 11:38:06 volumio volumio[7325]: info: Plugin folders cleanup Sep 14 11:38:06 volumio volumio[7325]: info: Scanning into folder /volumio/app/plugins/ Sep 14 11:38:06 volumio volumio[7325]: info: Scanning category audio_interface Sep 14 11:38:06 volumio volumio[7325]: info: Scanning category miscellanea Sep 14 11:38:06 volumio volumio[7325]: info: Scanning category music_service Sep 14 11:38:06 volumio volumio[7325]: info: Scanning category plugins.json Sep 14 11:38:06 volumio volumio[7325]: info: Scanning category system_controller Sep 14 11:38:06 volumio volumio[7325]: info: Scanning category user_interface Sep 14 11:38:06 volumio volumio[7325]: info: Scanning into folder /data/plugins/ Sep 14 11:38:06 volumio volumio[7325]: info: Plugin folders cleanup completed Sep 14 11:38:06 volumio volumio[7325]: info: ------------------------------------------- Sep 14 11:38:06 volumio volumio[7325]: info: ----- Core plugins startup ---- Sep 14 11:38:06 volumio volumio[7325]: info: ------------------------------------------- Sep 14 11:38:06 volumio volumio[7325]: info: Loading plugins from folder /volumio/app/plugins/ Sep 14 11:38:06 volumio volumio[7325]: info: Adding plugin upnp to MyMusic Plugins Sep 14 11:38:06 volumio volumio[7325]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 14 11:38:06 volumio volumio[7325]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 14 11:38:06 volumio volumio[7325]: info: Loading plugins from folder /data/plugins/ Sep 14 11:38:06 volumio volumio[7325]: info: Loading plugin "system"... Sep 14 11:38:06 volumio volumio[7325]: info: Loading plugin "appearance"... Sep 14 11:38:07 volumio volumio[7325]: info: Loading plugin "network"... Sep 14 11:38:07 volumio volumio[7325]: info: Refreshing Cached IP Addresses Sep 14 11:38:07 volumio sudo[7353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 14 11:38:07 volumio sudo[7353]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:07 volumio sudo[7353]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:07 volumio sudo[7356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 14 11:38:07 volumio sudo[7356]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:07 volumio sudo[7356]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:07 volumio volumio[7325]: info: Loading plugin "services"... Sep 14 11:38:07 volumio volumio[7325]: info: Loading plugin "alsa_controller"... Sep 14 11:38:07 volumio sudo[7371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 14 11:38:07 volumio sudo[7371]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:08 volumio sudo[7371]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:08 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "wizard"... Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "networkfs"... Sep 14 11:38:08 volumio volumio[7325]: info: Starting Udev Watcher for removable devices Sep 14 11:38:08 volumio volumio[7325]: info: Ignoring mount for partition: boot Sep 14 11:38:08 volumio sudo[7386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=andy,password=888888,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.1.3/samsun（1T） /mnt/NAS/samsun（1T） Sep 14 11:38:08 volumio sudo[7386]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:08 volumio volumio[7325]: info: Ignoring mount for partition: volumio Sep 14 11:38:08 volumio volumio[7325]: info: Ignoring mount for partition: volumio_data Sep 14 11:38:08 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "volumio_command_line_client"... Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "upnp"... Sep 14 11:38:08 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Sep 14 11:38:08 volumio kernel: CIFS: VFS: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Sep 14 11:38:08 volumio kernel: CIFS: Attempting to mount //192.168.1.3/samsun（1T） Sep 14 11:38:08 volumio volumio[7325]: info: [1757821088184] Starting Upmpd Daemon Sep 14 11:38:08 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 14 11:38:08 volumio sudo[7386]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "my_music"... Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "mpd"... Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "upnp_browser"... Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "alarm-clock"... Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "airplay_emulation"... Sep 14 11:38:08 volumio volumio[7325]: info: Starting Shairport Sync Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "last_100"... Sep 14 11:38:08 volumio volumio[7325]: info: Loading plugin "webradio"... Sep 14 11:38:09 volumio volumio[7325]: info: Loading plugin "i2s_dacs"... Sep 14 11:38:09 volumio volumio[7325]: info: I2S DAC not set, start Auto-detection Sep 14 11:38:09 volumio volumio[7325]: info: Loading plugin "volumiodiscovery"... Sep 14 11:38:09 volumio volumio[7325]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 14 11:38:09 volumio volumio[7325]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 14 11:38:09 volumio node[7325]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 14 11:38:09 volumio volumio[7325]: *** WARNING *** For more information see Sep 14 11:38:09 volumio volumio[7325]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 14 11:38:09 volumio volumio[7325]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 14 11:38:09 volumio volumio[7325]: *** WARNING *** For more information see Sep 14 11:38:09 volumio node[7325]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 14 11:38:09 volumio node[7325]: *** WARNING *** For more information see Sep 14 11:38:09 volumio node[7325]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 14 11:38:09 volumio node[7325]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 14 11:38:09 volumio node[7325]: *** WARNING *** For more information see Sep 14 11:38:09 volumio volumio[7325]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 14 11:38:09 volumio volumio[7325]: info: Discovery: Started advertising with name: Volumio Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 14 11:38:09 volumio volumio[7325]: info: Loading plugin "outputs"... Sep 14 11:38:09 volumio volumio[7325]: info: Loading plugin "albumart"... Sep 14 11:38:09 volumio volumio[7325]: info: Plugin example_plugin is not enabled Sep 14 11:38:09 volumio volumio[7325]: info: Loading plugin "inputs"... Sep 14 11:38:09 volumio volumio[7325]: info: Loading plugin "updater_comm"... Sep 14 11:38:09 volumio volumio[7325]: info: Plugin mpdemulation is not enabled Sep 14 11:38:09 volumio volumio[7325]: info: Loading plugin "rest_api"... Sep 14 11:38:09 volumio volumio[7325]: Forking 1 albumart workers Sep 14 11:38:09 volumio volumio[7325]: info: Loading plugin "websocket"... Sep 14 11:38:09 volumio volumio-remote-updater[570]: [2025-09-14 11:38:09] [connect] Successful connection Sep 14 11:38:09 volumio volumio[7325]: info: Starting Socket.io Server version 2.3.0 Sep 14 11:38:09 volumio volumio[7325]: info: Loading i18n strings for locale zh Sep 14 11:38:09 volumio volumio[7325]: Updating browse sources language Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::initPlayerControls Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 11:38:09 volumio volumio[7325]: Express server listening on port 3000 Sep 14 11:38:09 volumio volumio[7325]: [Metrics] WebUI: 4s 258.79ms Sep 14 11:38:09 volumio volumio[7325]: info: Setting Device type: x86 Sep 14 11:38:09 volumio volumio[7325]: info: CoreStateMachine::resetVolumioState Sep 14 11:38:09 volumio volumio[7325]: info: CoreStateMachine::getcurrentVolume Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::volumioRetrievevolume Sep 14 11:38:09 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:09 volumio volumio[7325]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 14 11:38:09 volumio volumio[7325]: info: Completed loading Core Plugins Sep 14 11:38:09 volumio volumio[7325]: info: Preparing to generate the ALSA configuration file Sep 14 11:38:09 volumio volumio[7325]: info: Volumio Network Manager: Network status updated: 1 Sep 14 11:38:09 volumio volumio[7325]: info: Cannot mount NAS samsun（1T） at system boot, trial number 1 ,retrying in 5 seconds Sep 14 11:38:09 volumio volumio[7325]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 14 11:38:09 volumio volumio[7325]: wlan0 Interface doesn't support scanning. Sep 14 11:38:09 volumio volumio[7325]: info: Cannot use regular scanning, forcing with ap-force Sep 14 11:38:10 volumio sudo[7412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 14 11:38:10 volumio sudo[7412]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:10 volumio sudo[7412]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:10 volumio volumio[7325]: command failed: No such device (-19) Sep 14 11:38:10 volumio volumio[7325]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 14 11:38:10 volumio volumio[7325]: command failed: No such device (-19) Sep 14 11:38:10 volumio volumio[7325]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Sep 14 11:38:10 volumio volumio[7325]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Sep 14 11:38:10 volumio volumio[7325]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.49 UA: Mozilla/5.0 (Linux; U; Android 15; zh-cn; 2410DPN6CC Build/AQ3A.240812.002) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.7049.79 Mobile Safari/537.36 XiaoMi/MiuiBrowser/20.0.620901 Engine version: 3 Transport: polling Total Clients: 2 Sep 14 11:38:10 volumio volumio[7325]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Sep 14 11:38:10 volumio volumio-remote-updater[570]: [2025-09-14 11:38:10] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757821089 101 Sep 14 11:38:10 volumio volumio[7325]: Starting albumart workers Sep 14 11:38:10 volumio volumio[7325]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 Sep 14 11:38:10 volumio volumio[7325]: info: Asound.conf file unchanged, so no further update is needed Sep 14 11:38:10 volumio volumio[7325]: info: Output device has changed, restarting MPD Sep 14 11:38:10 volumio sudo[7422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 14 11:38:10 volumio sudo[7422]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:10 volumio volumio[7325]: info: Output device has changed, restarting Shairport Sync Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:10 volumio sudo[7422]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:10 volumio sudo[7425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 14 11:38:10 volumio sudo[7425]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:10 volumio systemd[1]: Stopping Music Player Daemon... Sep 14 11:38:10 volumio volumio[7325]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 14 11:38:10 volumio volumio[7325]: info: ___________ START PLUGINS ___________ Sep 14 11:38:10 volumio systemd[1]: mpd.service: Succeeded. Sep 14 11:38:10 volumio volumio[7325]: info: ControllerMpd::onStart: Initializing MPD Sep 14 11:38:10 volumio volumio[7325]: info: Creating MPD Configuration file Sep 14 11:38:10 volumio systemd[1]: Stopped Music Player Daemon. Sep 14 11:38:10 volumio systemd[1]: Starting Music Player Daemon... Sep 14 11:38:10 volumio sudo[7433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 14 11:38:10 volumio sudo[7433]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 11:38:10 volumio sudo[7433]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 14 11:38:10 volumio volumio[7325]: info: [1757821090545] CoreMusicLibrary::Adding element 媒体服务器 Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:10 volumio sudo[7437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 14 11:38:10 volumio sudo[7437]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:10 volumio sudo[7431]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 14 11:38:10 volumio sudo[7431]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:10 volumio sudo[7431]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:10 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 14 11:38:10 volumio systemd[1]: mpd.service: Succeeded. Sep 14 11:38:10 volumio systemd[1]: Stopped Music Player Daemon. Sep 14 11:38:10 volumio systemd[1]: Starting Music Player Daemon... Sep 14 11:38:10 volumio volumio[7325]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:10 volumio sudo[7444]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 14 11:38:10 volumio sudo[7444]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:10 volumio sudo[7444]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:10 volumio volumio[7325]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 14 11:38:10 volumio volumio[7325]: info: [1757821090844] CoreMusicLibrary::Adding element Last_100 Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 14 11:38:10 volumio volumio[7325]: info: [1757821090850] CoreMusicLibrary::Adding element Webradio Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 11:38:10 volumio volumio[7325]: info: Initializing BBC Radios Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 11:38:10 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:10 volumio volumio[7325]: info: Volumio Calling Home Sep 14 11:38:11 volumio volumio[7325]: info: Reloading queue from file Sep 14 11:38:11 volumio volumio[7325]: info: CoreStateMachine::setRepeat false single undefined Sep 14 11:38:11 volumio volumio[7325]: info: CoreStateMachine::pushState Sep 14 11:38:11 volumio volumio[7325]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::volumioPushState Sep 14 11:38:11 volumio volumio[7325]: info: CoreStateMachine::setRandom true Sep 14 11:38:11 volumio volumio[7325]: info: CoreStateMachine::pushState Sep 14 11:38:11 volumio volumio[7325]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::volumioPushState Sep 14 11:38:11 volumio volumio[7325]: info: VolumeController:: Volume=100 Mute =false Sep 14 11:38:11 volumio volumio[7325]: info: CoreStateMachine::pushState Sep 14 11:38:11 volumio volumio[7325]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::volumioPushState Sep 14 11:38:11 volumio volumio[7325]: info: CoreStateMachine::updateTrackBlock Sep 14 11:38:11 volumio volumio[7325]: info: CorePlayQueue::getTrackBlock Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::volumioRetrievevolume Sep 14 11:38:11 volumio volumio[7325]: info: MPD Permissions set Sep 14 11:38:11 volumio volumio[7325]: info: MPD Permissions set Sep 14 11:38:11 volumio volumio[7325]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:11 volumio volumio[7325]: info: Volumio called home Sep 14 11:38:11 volumio volumio[7325]: info: VolumeController:: Volume=100 Mute =false Sep 14 11:38:11 volumio volumio[7325]: info: CoreStateMachine::pushState Sep 14 11:38:11 volumio volumio[7325]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::volumioPushState Sep 14 11:38:11 volumio volumio[7325]: info: Discovery: adding 00fed490-7a4f-4147-a1e8-7a35d62934bb Sep 14 11:38:11 volumio volumio[7325]: info: Discovery: Found device Volumio Sep 14 11:38:11 volumio volumio[7325]: info: CoreCommandRouter::volumioGetState Sep 14 11:38:11 volumio volumio[7325]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:11 volumio volumio[7325]: info: Starting Shairport Sync Sep 14 11:38:11 volumio volumio[7325]: info: Starting Shairport Sync Sep 14 11:38:11 volumio sudo[7487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 14 11:38:11 volumio sudo[7487]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:11 volumio volumio[7325]: info: Starting Shairport Sync Sep 14 11:38:11 volumio sudo[7490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 14 11:38:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 14 11:38:11 volumio sudo[7490]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:11 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 14 11:38:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:12 volumio sudo[7487]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 14 11:38:12 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 14 11:38:12 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 14 11:38:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:12 volumio sudo[7494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 14 11:38:12 volumio sudo[7494]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:12 volumio sudo[7490]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:12 volumio volumio[7325]: info: CoreCommandRouter::volumioGetState Sep 14 11:38:12 volumio volumio[7325]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 14 11:38:12 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 14 11:38:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:12 volumio sudo[7494]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:12 volumio volumio[7325]: info: Shairport-Sync Started Sep 14 11:38:12 volumio volumio[7325]: Error adding Membership: Error: addMembership EINVAL Sep 14 11:38:12 volumio volumio[7325]: info: Shairport-Sync Started Sep 14 11:38:12 volumio sudo[7501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 14 11:38:12 volumio sudo[7501]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:12 volumio sudo[7501]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:12 volumio volumio[7325]: info: Shairport-Sync Started Sep 14 11:38:12 volumio sudo[7505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 14 11:38:12 volumio sudo[7505]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:12 volumio sudo[7505]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:12 volumio volumio[7325]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.49 UA: Mozilla/5.0 (Linux; U; Android 15; zh-cn; 2410DPN6CC Build/AQ3A.240812.002) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.7049.79 Mobile Safari/537.36 XiaoMi/MiuiBrowser/20.0.620901 Engine version: 3 Transport: polling Total Clients: 6 Sep 14 11:38:12 volumio volumio[7325]: info: CoreCommandRouter::volumioGetState Sep 14 11:38:12 volumio volumio[7325]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:12 volumio volumio[7325]: info: CoreCommandRouter::volumioGetQueue Sep 14 11:38:12 volumio volumio[7325]: info: CoreStateMachine::getQueue Sep 14 11:38:12 volumio volumio[7325]: info: CorePlayQueue::getQueue Sep 14 11:38:12 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 14 11:38:12 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 14 11:38:12 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 14 11:38:12 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 14 11:38:12 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 14 11:38:12 volumio mpd[7449]: Sep 14 11:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 14 11:38:12 volumio systemd[1]: Started Music Player Daemon. Sep 14 11:38:12 volumio sudo[7425]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:12 volumio sudo[7437]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:12 volumio volumio[7325]: info: Completed starting Core Plugins Sep 14 11:38:12 volumio volumio[7325]: info: ------------------------------------------- Sep 14 11:38:12 volumio volumio[7325]: info: ----- MyVolumio plugins startup ---- Sep 14 11:38:12 volumio volumio[7325]: info: ------------------------------------------- Sep 14 11:38:12 volumio volumio[7325]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 14 11:38:12 volumio volumio[7325]: error: MPD error: The expression evaluated to a falsy value: Sep 14 11:38:12 volumio volumio[7325]: assert.ok(self.idling) Sep 14 11:38:12 volumio volumio[7325]: error: The expression evaluated to a falsy value: Sep 14 11:38:12 volumio volumio[7325]: assert.ok(self.idling) Sep 14 11:38:12 volumio volumio[7325]: info: MPD running with PID7449 Sep 14 11:38:12 volumio volumio[7325]: ,establishing connection Sep 14 11:38:12 volumio volumio[7325]: error: updateQueue error: null Sep 14 11:38:12 volumio volumio[7325]: error: updateQueue error: null Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%84%E5%93%81%E6%BA%90/%E6%B5%B7%E6%B5%AA/68de2805-ac7f-43cd-951f-4c4f7a42cd1e.jpg' Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E6%95%AC%E8%BD%A9/Morph/28caa55f-dd06-4c2b-ad8d-612b8bdcc3d7.jpg' Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/%E7%8E%8B%E9%9D%96%E9%9B%AF/4dd6852d-d855-4597-ba52-204b2016b6e0.jpg' Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%87%91%E6%B5%B7%E5%BF%83/e050c5ab-6111-4b19-a36d-56855d8eb90a.jpg' Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%83%AD%E5%AF%8C%E5%9F%8E/%E7%8B%82%E9%87%8E%E4%B9%8B%E5%9F%8E/51502f4d-221f-49ed-8b9e-69b11fa0f537.png' Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/%E5%94%B1%E6%B8%B8/d792667c-286a-42f6-a79a-b9606b7b730f.png' Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Twins/Touch%20Of%20Love/6f164020-1941-43de-b0e0-a67ec36c123d.png' Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%96%B9%E5%A4%A7%E5%90%8C/The%20Soulboy%20Collection/58dd1219-77d6-4370-830a-4c9fc7902966.jpg' Sep 14 11:38:13 volumio volumio[7325]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 14 11:38:13 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%84%E9%9B%85%E8%8E%89/49f588b6-e22b-4b45-a936-75f716600ff6.jpg' Sep 14 11:38:13 volumio volumio[7325]: info: CoreCommandRouter::volumioGetState Sep 14 11:38:13 volumio volumio[7325]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:13 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 14 11:38:13 volumio volumio[7325]: info: CoreCommandRouter::volumioGetVisibleSources Sep 14 11:38:13 volumio volumio[7325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:13 volumio volumio[7325]: info: Listing playlists Sep 14 11:38:14 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E5%A5%95%E8%BF%85/%E4%B8%83/9e19da35-d136-4369-80b0-710329169f71.png' Sep 14 11:38:14 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E4%BF%8A%E6%9D%B0/%E7%AC%AC%E4%BA%8C%E5%A4%A9%E5%A0%82/fdaa21fb-71ab-406a-8f56-6d79d3889b5e.jpg' Sep 14 11:38:14 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%8E%AB%E6%96%87%E8%94%9A/%E8%BF%99%E4%B8%96%E7%95%8C%E9%82%A3%E4%B9%88%E5%A4%9A%E4%BA%BA/314a67bd-71cb-433b-a63c-2a5e45b15e02.jpg' Sep 14 11:38:14 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/%E5%8F%AA%E7%88%B1%E9%99%8C%E7%94%9F%E4%BA%BA/1fc5fe38-fcc4-4ccd-a60a-22ebcf8286ec.jpg' Sep 14 11:38:14 volumio volumio[7325]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E5%A5%95%E8%BF%85/Get%20A%20Life/6228b323-0448-4a3e-a3ac-ff985c23e7f3.jpg' Sep 14 11:38:14 volumio volumio[7325]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 11:38:14 volumio volumio[7325]: Error: connect ECONNREFUSED 67.230.169.182:80 Sep 14 11:38:14 volumio volumio[7325]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 14 11:38:14 volumio volumio[7325]: errno: -111, Sep 14 11:38:14 volumio volumio[7325]: code: 'ECONNREFUSED', Sep 14 11:38:14 volumio volumio[7325]: syscall: 'connect', Sep 14 11:38:14 volumio volumio[7325]: address: '67.230.169.182', Sep 14 11:38:14 volumio volumio[7325]: port: 80 Sep 14 11:38:14 volumio volumio[7325]: } Sep 14 11:38:14 volumio volumio[7325]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 11:38:14 volumio sudo[7524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-14 11:37 Sep 14 11:38:14 volumio sudo[7524]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:14 volumio sudo[7524]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:16 volumio volumio-remote-updater[570]: [2025-09-14 11:38:16] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Sep 14 11:38:16 volumio volumio-remote-updater[570]: [2025-09-14 11:38:16] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Sep 14 11:38:16 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Sep 14 11:38:16 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Sep 14 11:38:16 volumio systemd[1]: Started dynamicswap service. Sep 14 11:38:16 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 14 11:38:16 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Sep 14 11:38:16 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 6. Sep 14 11:38:16 volumio systemd[1]: Started dynamicswap service. Sep 14 11:38:16 volumio systemd[1]: Stopped Volumio Backend Module. Sep 14 11:38:16 volumio systemd[1]: Started Volumio Backend Module. Sep 14 11:38:16 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 14 11:38:18 volumio volumio[7539]: info: ------------------------------------------- Sep 14 11:38:18 volumio volumio[7539]: info: ----- Volumio3 ---- Sep 14 11:38:18 volumio volumio[7539]: info: ------------------------------------------- Sep 14 11:38:18 volumio volumio[7539]: info: ----- System startup ---- Sep 14 11:38:18 volumio volumio[7539]: info: ------------------------------------------- Sep 14 11:38:19 volumio volumio[7539]: info: MYVOLUMIO Environment detected Sep 14 11:38:19 volumio volumio[7539]: info: Plugin folders cleanup Sep 14 11:38:19 volumio volumio[7539]: info: Scanning into folder /volumio/app/plugins/ Sep 14 11:38:19 volumio volumio[7539]: info: Scanning category audio_interface Sep 14 11:38:19 volumio volumio[7539]: info: Scanning category miscellanea Sep 14 11:38:19 volumio volumio[7539]: info: Scanning category music_service Sep 14 11:38:19 volumio volumio[7539]: info: Scanning category plugins.json Sep 14 11:38:19 volumio volumio[7539]: info: Scanning category system_controller Sep 14 11:38:19 volumio volumio[7539]: info: Scanning category user_interface Sep 14 11:38:19 volumio volumio[7539]: info: Scanning into folder /data/plugins/ Sep 14 11:38:19 volumio volumio[7539]: info: Plugin folders cleanup completed Sep 14 11:38:19 volumio volumio[7539]: info: ------------------------------------------- Sep 14 11:38:19 volumio volumio[7539]: info: ----- Core plugins startup ---- Sep 14 11:38:19 volumio volumio[7539]: info: ------------------------------------------- Sep 14 11:38:19 volumio volumio[7539]: info: Loading plugins from folder /volumio/app/plugins/ Sep 14 11:38:19 volumio volumio[7539]: info: Adding plugin upnp to MyMusic Plugins Sep 14 11:38:19 volumio volumio[7539]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 14 11:38:19 volumio volumio[7539]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 14 11:38:19 volumio volumio[7539]: info: Loading plugins from folder /data/plugins/ Sep 14 11:38:19 volumio volumio[7539]: info: Loading plugin "system"... Sep 14 11:38:19 volumio volumio[7539]: info: Loading plugin "appearance"... Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "network"... Sep 14 11:38:20 volumio volumio[7539]: info: Refreshing Cached IP Addresses Sep 14 11:38:20 volumio sudo[7568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 14 11:38:20 volumio sudo[7568]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:20 volumio sudo[7568]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:20 volumio sudo[7570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 14 11:38:20 volumio sudo[7570]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "services"... Sep 14 11:38:20 volumio sudo[7570]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "alsa_controller"... Sep 14 11:38:20 volumio sudo[7583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 14 11:38:20 volumio sudo[7583]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:20 volumio sudo[7583]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:20 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "wizard"... Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "networkfs"... Sep 14 11:38:20 volumio volumio[7539]: info: Starting Udev Watcher for removable devices Sep 14 11:38:20 volumio volumio[7539]: info: Ignoring mount for partition: boot Sep 14 11:38:20 volumio volumio[7539]: info: Ignoring mount for partition: volumio Sep 14 11:38:20 volumio volumio[7539]: info: Ignoring mount for partition: volumio_data Sep 14 11:38:20 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "volumio_command_line_client"... Sep 14 11:38:20 volumio sudo[7600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=andy,password=888888,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.1.3/samsun（1T） /mnt/NAS/samsun（1T） Sep 14 11:38:20 volumio sudo[7600]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "upnp"... Sep 14 11:38:20 volumio volumio[7539]: info: [1757821100443] Starting Upmpd Daemon Sep 14 11:38:20 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "my_music"... Sep 14 11:38:20 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Sep 14 11:38:20 volumio kernel: CIFS: VFS: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Sep 14 11:38:20 volumio kernel: CIFS: Attempting to mount //192.168.1.3/samsun（1T） Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "mpd"... Sep 14 11:38:20 volumio sudo[7600]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:20 volumio volumio[7539]: info: Loading plugin "upnp_browser"... Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "alarm-clock"... Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "airplay_emulation"... Sep 14 11:38:21 volumio volumio[7539]: info: Starting Shairport Sync Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "last_100"... Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "webradio"... Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "i2s_dacs"... Sep 14 11:38:21 volumio volumio[7539]: info: I2S DAC not set, start Auto-detection Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "volumiodiscovery"... Sep 14 11:38:21 volumio volumio[7539]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 14 11:38:21 volumio volumio[7539]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 14 11:38:21 volumio volumio[7539]: *** WARNING *** For more information see Sep 14 11:38:21 volumio node[7539]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 14 11:38:21 volumio volumio[7539]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 14 11:38:21 volumio volumio[7539]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 14 11:38:21 volumio volumio[7539]: *** WARNING *** For more information see Sep 14 11:38:21 volumio node[7539]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 14 11:38:21 volumio node[7539]: *** WARNING *** For more information see Sep 14 11:38:21 volumio node[7539]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 14 11:38:21 volumio node[7539]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 14 11:38:21 volumio node[7539]: *** WARNING *** For more information see Sep 14 11:38:21 volumio volumio[7539]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 14 11:38:21 volumio volumio[7539]: info: Discovery: Started advertising with name: Volumio Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "outputs"... Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "albumart"... Sep 14 11:38:21 volumio volumio[7539]: info: Plugin example_plugin is not enabled Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "inputs"... Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "updater_comm"... Sep 14 11:38:21 volumio volumio-remote-updater[570]: [2025-09-14 11:38:21] [connect] Successful connection Sep 14 11:38:21 volumio volumio[7539]: Forking 1 albumart workers Sep 14 11:38:21 volumio volumio[7539]: info: Plugin mpdemulation is not enabled Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "rest_api"... Sep 14 11:38:21 volumio volumio[7539]: info: Loading plugin "websocket"... Sep 14 11:38:21 volumio volumio[7539]: info: Starting Socket.io Server version 2.3.0 Sep 14 11:38:21 volumio volumio[7539]: info: Loading i18n strings for locale zh Sep 14 11:38:21 volumio volumio[7539]: Updating browse sources language Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::initPlayerControls Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:21 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 11:38:21 volumio volumio[7539]: Express server listening on port 3000 Sep 14 11:38:21 volumio volumio[7539]: [Metrics] WebUI: 4s 177.45ms Sep 14 11:38:22 volumio volumio[7539]: info: Setting Device type: x86 Sep 14 11:38:22 volumio volumio[7539]: info: CoreStateMachine::resetVolumioState Sep 14 11:38:22 volumio volumio[7539]: info: CoreStateMachine::getcurrentVolume Sep 14 11:38:22 volumio volumio[7539]: info: CoreCommandRouter::volumioRetrievevolume Sep 14 11:38:22 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:22 volumio volumio[7539]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 14 11:38:22 volumio volumio[7539]: info: Completed loading Core Plugins Sep 14 11:38:22 volumio volumio[7539]: info: Preparing to generate the ALSA configuration file Sep 14 11:38:22 volumio volumio[7539]: info: Volumio Network Manager: Network status updated: 1 Sep 14 11:38:22 volumio volumio[7539]: info: Cannot mount NAS samsun（1T） at system boot, trial number 1 ,retrying in 5 seconds Sep 14 11:38:22 volumio volumio[7539]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 14 11:38:22 volumio volumio[7539]: wlan0 Interface doesn't support scanning. Sep 14 11:38:22 volumio volumio[7539]: info: Cannot use regular scanning, forcing with ap-force Sep 14 11:38:22 volumio sudo[7622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 14 11:38:22 volumio sudo[7622]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:22 volumio sudo[7622]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:22 volumio volumio[7539]: command failed: No such device (-19) Sep 14 11:38:22 volumio volumio[7539]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 14 11:38:22 volumio volumio[7539]: command failed: No such device (-19) Sep 14 11:38:22 volumio volumio[7539]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Sep 14 11:38:22 volumio volumio[7539]: Starting albumart workers Sep 14 11:38:22 volumio volumio[7539]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.49 UA: Mozilla/5.0 (Linux; U; Android 15; zh-cn; 2410DPN6CC Build/AQ3A.240812.002) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.7049.79 Mobile Safari/537.36 XiaoMi/MiuiBrowser/20.0.620901 Engine version: 3 Transport: polling Total Clients: 1 Sep 14 11:38:22 volumio volumio[7539]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Sep 14 11:38:22 volumio volumio-remote-updater[570]: [2025-09-14 11:38:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757821101 101 Sep 14 11:38:22 volumio volumio[7539]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Sep 14 11:38:22 volumio volumio[7539]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.49 UA: Mozilla/5.0 (Linux; U; Android 15; zh-cn; 2410DPN6CC Build/AQ3A.240812.002) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.7049.79 Mobile Safari/537.36 XiaoMi/MiuiBrowser/20.0.620901 Engine version: 3 Transport: polling Total Clients: 4 Sep 14 11:38:22 volumio volumio[7539]: info: CoreCommandRouter::volumioGetState Sep 14 11:38:22 volumio volumio[7539]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:22 volumio volumio[7539]: info: VolumeController:: Volume=100 Mute =false Sep 14 11:38:22 volumio volumio[7539]: info: CoreStateMachine::pushState Sep 14 11:38:22 volumio volumio[7539]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:22 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 11:38:22 volumio volumio[7539]: info: CoreCommandRouter::volumioPushState Sep 14 11:38:22 volumio volumio[7539]: info: CoreStateMachine::updateTrackBlock Sep 14 11:38:22 volumio volumio[7539]: info: CorePlayQueue::getTrackBlock Sep 14 11:38:22 volumio volumio[7539]: info: CoreCommandRouter::volumioRetrievevolume Sep 14 11:38:22 volumio volumio[7539]: info: Asound.conf file unchanged, so no further update is needed Sep 14 11:38:22 volumio volumio[7539]: info: Output device has changed, restarting MPD Sep 14 11:38:22 volumio sudo[7633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 14 11:38:22 volumio sudo[7633]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:22 volumio volumio[7539]: info: Output device has changed, restarting Shairport Sync Sep 14 11:38:22 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:22 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:22 volumio sudo[7633]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:22 volumio sudo[7636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 14 11:38:22 volumio sudo[7636]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:22 volumio systemd[1]: Stopping Music Player Daemon... Sep 14 11:38:22 volumio systemd[1]: mpd.service: Succeeded. Sep 14 11:38:22 volumio systemd[1]: Stopped Music Player Daemon. Sep 14 11:38:22 volumio systemd[1]: Starting Music Player Daemon... Sep 14 11:38:22 volumio volumio[7539]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 14 11:38:22 volumio volumio[7539]: info: ___________ START PLUGINS ___________ Sep 14 11:38:22 volumio volumio[7539]: info: ControllerMpd::onStart: Initializing MPD Sep 14 11:38:22 volumio volumio[7539]: info: Creating MPD Configuration file Sep 14 11:38:23 volumio sudo[7641]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 14 11:38:23 volumio sudo[7641]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:23 volumio sudo[7641]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:23 volumio sudo[7648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 14 11:38:23 volumio sudo[7648]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 14 11:38:23 volumio volumio[7539]: info: [1757821103047] CoreMusicLibrary::Adding element 媒体服务器 Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:23 volumio sudo[7648]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:23 volumio sudo[7656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 14 11:38:23 volumio sudo[7656]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:23 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 14 11:38:23 volumio systemd[1]: mpd.service: Succeeded. Sep 14 11:38:23 volumio systemd[1]: Stopped Music Player Daemon. Sep 14 11:38:23 volumio systemd[1]: Starting Music Player Daemon... Sep 14 11:38:23 volumio volumio[7539]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 14 11:38:23 volumio volumio[7539]: info: [1757821103297] CoreMusicLibrary::Adding element Last_100 Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 14 11:38:23 volumio volumio[7539]: info: [1757821103300] CoreMusicLibrary::Adding element Webradio Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 11:38:23 volumio sudo[7659]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 14 11:38:23 volumio volumio[7539]: info: Initializing BBC Radios Sep 14 11:38:23 volumio sudo[7659]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:23 volumio sudo[7659]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: Volumio Calling Home Sep 14 11:38:23 volumio volumio[7539]: info: Reloading queue from file Sep 14 11:38:23 volumio volumio[7539]: info: CoreStateMachine::setRepeat false single undefined Sep 14 11:38:23 volumio volumio[7539]: info: CoreStateMachine::pushState Sep 14 11:38:23 volumio volumio[7539]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::volumioPushState Sep 14 11:38:23 volumio volumio[7539]: info: CoreStateMachine::setRandom true Sep 14 11:38:23 volumio volumio[7539]: info: CoreStateMachine::pushState Sep 14 11:38:23 volumio volumio[7539]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::volumioPushState Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::volumioGetQueue Sep 14 11:38:23 volumio volumio[7539]: info: CoreStateMachine::getQueue Sep 14 11:38:23 volumio volumio[7539]: info: CorePlayQueue::getQueue Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 14 11:38:23 volumio volumio[7539]: info: MPD Permissions set Sep 14 11:38:23 volumio volumio[7539]: info: MPD Permissions set Sep 14 11:38:23 volumio volumio[7539]: info: Discovery: adding 00fed490-7a4f-4147-a1e8-7a35d62934bb Sep 14 11:38:23 volumio volumio[7539]: info: Discovery: Found device Volumio Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::volumioGetState Sep 14 11:38:23 volumio volumio[7539]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:23 volumio volumio[7539]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Sep 14 11:38:23 volumio volumio[7539]: info: VolumeController:: Volume=100 Mute =false Sep 14 11:38:23 volumio volumio[7539]: info: CoreStateMachine::pushState Sep 14 11:38:23 volumio volumio[7539]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::volumioPushState Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:23 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 11:38:24 volumio volumio[7539]: info: Volumio called home Sep 14 11:38:24 volumio volumio[7539]: info: Starting Shairport Sync Sep 14 11:38:24 volumio volumio[7539]: info: Starting Shairport Sync Sep 14 11:38:24 volumio volumio[7539]: info: Starting Shairport Sync Sep 14 11:38:24 volumio sudo[7739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 14 11:38:24 volumio sudo[7739]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:24 volumio sudo[7741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 14 11:38:24 volumio sudo[7741]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 14 11:38:24 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 14 11:38:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:24 volumio sudo[7739]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 14 11:38:24 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 14 11:38:24 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 14 11:38:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:24 volumio sudo[7745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 14 11:38:24 volumio sudo[7745]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 11:38:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:24 volumio sudo[7741]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::volumioGetState Sep 14 11:38:24 volumio volumio[7539]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 14 11:38:24 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 14 11:38:24 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 14 11:38:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:24 volumio volumio[7539]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 14 11:38:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 14 11:38:24 volumio sudo[7745]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:24 volumio volumio[7539]: info: Shairport-Sync Started Sep 14 11:38:24 volumio volumio[7539]: Error adding Membership: Error: addMembership EINVAL Sep 14 11:38:24 volumio volumio[7539]: info: Shairport-Sync Started Sep 14 11:38:24 volumio volumio[7539]: info: Shairport-Sync Started Sep 14 11:38:24 volumio volumio[7539]: info: CoreCommandRouter::volumioGetState Sep 14 11:38:24 volumio volumio[7539]: info: CorePlayQueue::getTrack 0 Sep 14 11:38:25 volumio volumio[7539]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%8F%B6%E5%80%A9%E6%96%87/576fc6fd-a6bc-4199-be31-ffdf83ec7970.jpg' Sep 14 11:38:25 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 14 11:38:25 volumio volumio[7539]: info: CoreCommandRouter::volumioGetVisibleSources Sep 14 11:38:25 volumio volumio[7539]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 11:38:25 volumio volumio[7539]: info: Listing playlists Sep 14 11:38:25 volumio volumio[7539]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E5%A5%95%E8%BF%85/Get%20A%20Life/6228b323-0448-4a3e-a3ac-ff985c23e7f3.jpg' Sep 14 11:38:25 volumio mpd[7667]: Sep 14 11:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 14 11:38:25 volumio systemd[1]: Started Music Player Daemon. Sep 14 11:38:25 volumio sudo[7656]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:25 volumio sudo[7636]: pam_unix(sudo:session): session closed for user root Sep 14 11:38:25 volumio volumio[7539]: info: Completed starting Core Plugins Sep 14 11:38:25 volumio volumio[7539]: info: ------------------------------------------- Sep 14 11:38:25 volumio volumio[7539]: info: ----- MyVolumio plugins startup ---- Sep 14 11:38:25 volumio volumio[7539]: info: ------------------------------------------- Sep 14 11:38:25 volumio volumio[7539]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 14 11:38:25 volumio volumio[7539]: error: MPD error: The expression evaluated to a falsy value: Sep 14 11:38:25 volumio volumio[7539]: assert.ok(self.idling) Sep 14 11:38:25 volumio volumio[7539]: error: The expression evaluated to a falsy value: Sep 14 11:38:25 volumio volumio[7539]: assert.ok(self.idling) Sep 14 11:38:25 volumio volumio[7539]: info: MPD running with PID7667 Sep 14 11:38:25 volumio volumio[7539]: ,establishing connection Sep 14 11:38:25 volumio volumio[7539]: error: MPD error: The expression evaluated to a falsy value: Sep 14 11:38:25 volumio volumio[7539]: assert.ok(self.idling) Sep 14 11:38:25 volumio volumio[7539]: error: The expression evaluated to a falsy value: Sep 14 11:38:25 volumio volumio[7539]: assert.ok(self.idling) Sep 14 11:38:25 volumio volumio[7539]: error: updateQueue error: null Sep 14 11:38:25 volumio volumio[7539]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E4%BC%A0%E9%9B%84/%E8%93%9D%E8%89%B2%E5%9C%9F%E8%80%B3%E5%85%B6/c2b8e992-581c-49c4-954f-77d92aabc630.jpg' Sep 14 11:38:27 volumio volumio[7539]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 11:38:27 volumio volumio[7539]: Error: connect ECONNREFUSED 67.230.169.182:443 Sep 14 11:38:27 volumio volumio[7539]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 14 11:38:27 volumio volumio[7539]: errno: -111, Sep 14 11:38:27 volumio volumio[7539]: code: 'ECONNREFUSED', Sep 14 11:38:27 volumio volumio[7539]: syscall: 'connect', Sep 14 11:38:27 volumio volumio[7539]: address: '67.230.169.182', Sep 14 11:38:27 volumio volumio[7539]: port: 443 Sep 14 11:38:27 volumio volumio[7539]: } Sep 14 11:38:27 volumio volumio[7539]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 11:38:27 volumio sudo[7766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-14 11:37 Sep 14 11:38:27 volumio sudo[7766]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"