-- Logs begin at Sat 2025-09-06 16:03:52 CST, end at Sat 2025-09-06 16:06:43 CST. -- Sep 06 16:05:02 volumio sudo[2046]: pam_unix(sudo:session): session closed for user root Sep 06 16:05:02 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 06 16:05:02 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 06 16:05:02 volumio kernel: CIFS: Attempting to mount //192.168.31.30/MUSIC Sep 06 16:05:02 volumio volumio[1047]: info: An error occurred mounting the new share. Rolling back configuration Sep 06 16:05:03 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 06 16:05:03 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:11 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:12 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Sep 06 16:05:12 volumio volumio[1047]: info: Share MUSIC successfully unmounted Sep 06 16:05:12 volumio sudo[2135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=administrator,password=xfcbjy,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.31.30/MUSIC /mnt/NAS/MUSIC Sep 06 16:05:12 volumio sudo[2135]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:05:12 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Sep 06 16:05:12 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 06 16:05:12 volumio sudo[2109]: pam_unix(sudo:session): session closed for user root Sep 06 16:05:12 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 06 16:05:12 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 06 16:05:12 volumio kernel: CIFS: Attempting to mount //192.168.31.30/MUSIC Sep 06 16:05:12 volumio volumio[1047]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Sep 06 16:05:15 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:19 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:22 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 06 16:05:22 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 06 16:05:22 volumio sudo[2135]: pam_unix(sudo:session): session closed for user root Sep 06 16:05:22 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 06 16:05:22 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 06 16:05:22 volumio volumio[1047]: info: An error occurred mounting the new share. Rolling back configuration Sep 06 16:05:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 06 16:05:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:23 volumio volumio[1047]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L t5r.local. -m SMB3_11 Sep 06 16:05:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:29 volumio volumio[1047]: info: Error browsing device t5r : T5R for shares: Command failed: smbclient --no-pass --debuglevel=0 -L t5r.local. -m SMB3_11 Sep 06 16:05:29 volumio volumio[1047]: Unable to initialize messaging context Sep 06 16:05:31 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:35 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:39 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:43 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:05:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 06 16:05:50 volumio volumio[1047]: info: CURURI: music-library Sep 06 16:05:50 volumio volumio[1047]: info: Preload queue cleared Sep 06 16:05:51 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 06 16:05:51 volumio volumio[1047]: info: CURURI: music-library/NAS Sep 06 16:05:51 volumio volumio[1047]: info: Preload queue cleared Sep 06 16:05:52 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 06 16:05:52 volumio volumio[1047]: info: CURURI: music-library/NAS/MUSIC Sep 06 16:05:52 volumio volumio[1047]: error: Failed LSINFO: null Sep 06 16:05:52 volumio volumio[1047]: info: Preload queue cleared Sep 06 16:05:56 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 16:05:56 volumio volumio[1047]: info: Preload queue cleared Sep 06 16:05:56 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 16:05:57 volumio volumio[1047]: info: Preload queue cleared Sep 06 16:05:57 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 16:05:58 volumio volumio[1047]: info: Preload queue cleared Sep 06 16:05:58 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 16:05:58 volumio volumio[1047]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 16:05:58 volumio volumio[1047]: TypeError: Cannot read property 'length' of undefined Sep 06 16:05:58 volumio volumio[1047]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Sep 06 16:05:58 volumio volumio[1047]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Sep 06 16:05:58 volumio volumio[1047]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Sep 06 16:05:58 volumio volumio[1047]: at Parser.emit (events.js:400:28) Sep 06 16:05:58 volumio volumio[1047]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Sep 06 16:05:58 volumio volumio[1047]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Sep 06 16:05:58 volumio volumio[1047]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Sep 06 16:05:58 volumio volumio[1047]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Sep 06 16:05:58 volumio volumio[1047]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Sep 06 16:05:58 volumio volumio[1047]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Sep 06 16:05:58 volumio volumio[1047]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Sep 06 16:05:58 volumio volumio[1047]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Sep 06 16:05:58 volumio volumio[1047]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Sep 06 16:05:58 volumio volumio[1047]: at IncomingMessage.emit (events.js:412:35) Sep 06 16:05:58 volumio volumio[1047]: at endReadableNT (internal/streams/readable.js:1333:12) Sep 06 16:05:58 volumio volumio[1047]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Sep 06 16:05:58 volumio volumio[1047]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 16:05:59 volumio sudo[2277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-06 16:04 Sep 06 16:05:59 volumio sudo[2277]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:05:59 volumio sudo[2277]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:00 volumio volumio-remote-updater[761]: [2025-09-06 16:06:00] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Sep 06 16:06:00 volumio volumio-remote-updater[761]: [2025-09-06 16:06:00] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Sep 06 16:06:00 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Sep 06 16:06:00 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Sep 06 16:06:00 volumio systemd[1]: Started dynamicswap service. Sep 06 16:06:00 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 06 16:06:00 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Sep 06 16:06:00 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Sep 06 16:06:00 volumio systemd[1]: Stopped Volumio Backend Module. Sep 06 16:06:00 volumio systemd[1]: Started Volumio Backend Module. Sep 06 16:06:00 volumio systemd[1]: Started dynamicswap service. Sep 06 16:06:00 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 06 16:06:01 volumio volumio[2293]: info: ------------------------------------------- Sep 06 16:06:01 volumio volumio[2293]: info: ----- Volumio3 ---- Sep 06 16:06:01 volumio volumio[2293]: info: ------------------------------------------- Sep 06 16:06:01 volumio volumio[2293]: info: ----- System startup ---- Sep 06 16:06:01 volumio volumio[2293]: info: ------------------------------------------- Sep 06 16:06:01 volumio volumio[2293]: info: MYVOLUMIO Environment detected Sep 06 16:06:01 volumio volumio[2293]: info: Plugin folders cleanup Sep 06 16:06:01 volumio volumio[2293]: info: Scanning into folder /volumio/app/plugins/ Sep 06 16:06:01 volumio volumio[2293]: info: Scanning category audio_interface Sep 06 16:06:01 volumio volumio[2293]: info: Scanning category miscellanea Sep 06 16:06:01 volumio volumio[2293]: info: Scanning category music_service Sep 06 16:06:01 volumio volumio[2293]: info: Scanning category plugins.json Sep 06 16:06:01 volumio volumio[2293]: info: Scanning category system_controller Sep 06 16:06:01 volumio volumio[2293]: info: Scanning category user_interface Sep 06 16:06:01 volumio volumio[2293]: info: Scanning into folder /data/plugins/ Sep 06 16:06:01 volumio volumio[2293]: info: Plugin folders cleanup completed Sep 06 16:06:01 volumio volumio[2293]: info: ------------------------------------------- Sep 06 16:06:01 volumio volumio[2293]: info: ----- Core plugins startup ---- Sep 06 16:06:01 volumio volumio[2293]: info: ------------------------------------------- Sep 06 16:06:01 volumio volumio[2293]: info: Loading plugins from folder /volumio/app/plugins/ Sep 06 16:06:01 volumio volumio[2293]: info: Adding plugin upnp to MyMusic Plugins Sep 06 16:06:01 volumio volumio[2293]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 06 16:06:01 volumio volumio[2293]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 06 16:06:01 volumio volumio[2293]: info: Loading plugins from folder /data/plugins/ Sep 06 16:06:01 volumio volumio[2293]: info: Loading plugin "system"... Sep 06 16:06:01 volumio volumio[2293]: info: Loading plugin "appearance"... Sep 06 16:06:01 volumio volumio[2293]: info: Loading plugin "network"... Sep 06 16:06:01 volumio volumio[2293]: info: Refreshing Cached IP Addresses Sep 06 16:06:01 volumio sudo[2323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 06 16:06:01 volumio sudo[2323]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:01 volumio sudo[2323]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:01 volumio sudo[2325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 06 16:06:01 volumio sudo[2325]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:01 volumio volumio[2293]: info: Loading plugin "services"... Sep 06 16:06:02 volumio sudo[2325]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "alsa_controller"... Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "wizard"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "networkfs"... Sep 06 16:06:02 volumio volumio[2293]: info: Starting Udev Watcher for removable devices Sep 06 16:06:02 volumio sudo[2348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=administrator,password=xfcbjy,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.31.30/MUSIC /mnt/NAS/MUSIC Sep 06 16:06:02 volumio volumio[2293]: info: Ignoring mount for partition: boot Sep 06 16:06:02 volumio sudo[2348]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:02 volumio volumio[2293]: info: Ignoring mount for partition: volumio Sep 06 16:06:02 volumio volumio[2293]: info: Ignoring mount for partition: volumio_data Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "volumio_command_line_client"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "upnp"... Sep 06 16:06:02 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Sep 06 16:06:02 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 06 16:06:02 volumio kernel: CIFS: Attempting to mount //192.168.31.30/MUSIC Sep 06 16:06:02 volumio volumio[2293]: info: [1757145962109] Starting Upmpd Daemon Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "my_music"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "mpd"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "upnp_browser"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "alarm-clock"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "airplay_emulation"... Sep 06 16:06:02 volumio volumio[2293]: info: Starting Shairport Sync Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "last_100"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "webradio"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "i2s_dacs"... Sep 06 16:06:02 volumio volumio[2293]: info: I2S DAC not set, start Auto-detection Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "volumiodiscovery"... Sep 06 16:06:02 volumio volumio[2293]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 06 16:06:02 volumio volumio[2293]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 06 16:06:02 volumio volumio[2293]: *** WARNING *** For more information see Sep 06 16:06:02 volumio volumio[2293]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 06 16:06:02 volumio volumio[2293]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 06 16:06:02 volumio node[2293]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 06 16:06:02 volumio volumio[2293]: *** WARNING *** For more information see Sep 06 16:06:02 volumio node[2293]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 06 16:06:02 volumio node[2293]: *** WARNING *** For more information see Sep 06 16:06:02 volumio node[2293]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 06 16:06:02 volumio node[2293]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 06 16:06:02 volumio node[2293]: *** WARNING *** For more information see Sep 06 16:06:02 volumio volumio[2293]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 06 16:06:02 volumio volumio[2293]: info: Discovery: Started advertising with name: Volumio Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "outputs"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "albumart"... Sep 06 16:06:02 volumio volumio[2293]: info: Plugin example_plugin is not enabled Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "inputs"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "updater_comm"... Sep 06 16:06:02 volumio volumio[2293]: Forking 3 albumart workers Sep 06 16:06:02 volumio volumio[2293]: info: Plugin mpdemulation is not enabled Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "rest_api"... Sep 06 16:06:02 volumio volumio[2293]: info: Loading plugin "websocket"... Sep 06 16:06:02 volumio volumio[2293]: info: Starting Socket.io Server version 2.3.0 Sep 06 16:06:02 volumio volumio[2293]: info: Loading i18n strings for locale zh Sep 06 16:06:02 volumio volumio[2293]: Updating browse sources language Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::initPlayerControls Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: Express server listening on port 3000 Sep 06 16:06:02 volumio volumio[2293]: [Metrics] WebUI: 1s 944.74ms Sep 06 16:06:02 volumio volumio[2293]: info: Setting Device type: x86 Sep 06 16:06:02 volumio volumio[2293]: info: CoreStateMachine::resetVolumioState Sep 06 16:06:02 volumio volumio[2293]: info: CoreStateMachine::getcurrentVolume Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::volumioRetrievevolume Sep 06 16:06:02 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:02 volumio volumio[2293]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 06 16:06:02 volumio volumio[2293]: info: Completed loading Core Plugins Sep 06 16:06:02 volumio volumio[2293]: info: Preparing to generate the ALSA configuration file Sep 06 16:06:03 volumio volumio[2293]: info: Volumio Network Manager: Network status updated: 1 Sep 06 16:06:03 volumio volumio[2293]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Sep 06 16:06:03 volumio volumio[2293]: 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 06 16:06:03 volumio volumio[2293]: Starting albumart workers Sep 06 16:06:03 volumio volumio[2293]: verbose: New Socket.io Connection to 192.168.31.169 from 192.168.31.88 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 2 Sep 06 16:06:03 volumio volumio[2293]: Starting albumart workers Sep 06 16:06:03 volumio volumio[2293]: Starting albumart workers Sep 06 16:06:03 volumio volumio[2293]: verbose: New Socket.io Connection to 192.168.31.169 from 192.168.31.88 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 3 Sep 06 16:06:03 volumio volumio[2293]: verbose: New Socket.io Connection to 192.168.31.169 from 192.168.31.88 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 4 Sep 06 16:06:03 volumio volumio[2293]: info: Reloading queue from file Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:03 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 06 16:06:03 volumio volumio[2293]: info: Asound.conf file unchanged, so no further update is needed Sep 06 16:06:03 volumio volumio[2293]: info: Output device has changed, restarting MPD Sep 06 16:06:03 volumio sudo[2389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 06 16:06:03 volumio volumio[2293]: info: Output device has changed, restarting Shairport Sync Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:03 volumio sudo[2389]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:03 volumio sudo[2389]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:03 volumio sudo[2391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 06 16:06:03 volumio sudo[2391]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:03 volumio systemd[1]: Stopping Music Player Daemon... Sep 06 16:06:03 volumio systemd[1]: mpd.service: Succeeded. Sep 06 16:06:03 volumio volumio[2293]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 06 16:06:03 volumio volumio[2293]: info: ___________ START PLUGINS ___________ Sep 06 16:06:03 volumio systemd[1]: Stopped Music Player Daemon. Sep 06 16:06:03 volumio volumio[2293]: info: ControllerMpd::onStart: Initializing MPD Sep 06 16:06:03 volumio volumio[2293]: info: Creating MPD Configuration file Sep 06 16:06:03 volumio systemd[1]: Starting Music Player Daemon... Sep 06 16:06:03 volumio sudo[2400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 06 16:06:03 volumio sudo[2400]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:03 volumio sudo[2400]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:03 volumio sudo[2398]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 06 16:06:03 volumio sudo[2398]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:03 volumio sudo[2398]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 06 16:06:03 volumio volumio[2293]: info: [1757145963509] CoreMusicLibrary::Adding element 媒体服务器 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:03 volumio sudo[2405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 06 16:06:03 volumio sudo[2405]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:03 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 06 16:06:03 volumio systemd[1]: mpd.service: Succeeded. Sep 06 16:06:03 volumio systemd[1]: Stopped Music Player Daemon. Sep 06 16:06:03 volumio systemd[1]: Starting Music Player Daemon... Sep 06 16:06:03 volumio volumio[2293]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:03 volumio sudo[2416]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 06 16:06:03 volumio sudo[2416]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:03 volumio sudo[2416]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:03 volumio volumio[2293]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 06 16:06:03 volumio volumio[2293]: info: [1757145963655] CoreMusicLibrary::Adding element Last_100 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 06 16:06:03 volumio volumio[2293]: info: [1757145963656] CoreMusicLibrary::Adding element Webradio Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 06 16:06:03 volumio volumio[2293]: info: Initializing BBC Radios Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: Volumio Calling Home Sep 06 16:06:03 volumio volumio[2293]: info: CoreStateMachine::setRepeat null single undefined Sep 06 16:06:03 volumio volumio[2293]: info: CoreStateMachine::pushState Sep 06 16:06:03 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::volumioPushState Sep 06 16:06:03 volumio volumio[2293]: info: CoreStateMachine::setRandom null Sep 06 16:06:03 volumio volumio[2293]: info: CoreStateMachine::pushState Sep 06 16:06:03 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::volumioPushState Sep 06 16:06:03 volumio volumio[2293]: info: VolumeController:: Volume=0 Mute =false Sep 06 16:06:03 volumio volumio[2293]: info: CoreStateMachine::pushState Sep 06 16:06:03 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::volumioPushState Sep 06 16:06:03 volumio volumio[2293]: info: CoreStateMachine::updateTrackBlock Sep 06 16:06:03 volumio volumio[2293]: info: CorePlayQueue::getTrackBlock Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::volumioRetrievevolume Sep 06 16:06:03 volumio volumio[2293]: 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: 5 Sep 06 16:06:03 volumio volumio[2293]: info: MPD Permissions set Sep 06 16:06:03 volumio volumio[2293]: info: MPD Permissions set Sep 06 16:06:03 volumio volumio[2293]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:03 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:04 volumio volumio[2293]: info: VolumeController:: Volume=0 Mute =false Sep 06 16:06:04 volumio volumio[2293]: info: CoreStateMachine::pushState Sep 06 16:06:04 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::volumioPushState Sep 06 16:06:04 volumio volumio[2293]: info: Starting Shairport Sync Sep 06 16:06:04 volumio volumio[2293]: info: Starting Shairport Sync Sep 06 16:06:04 volumio sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 06 16:06:04 volumio sudo[2469]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:04 volumio volumio[2293]: info: Starting Shairport Sync Sep 06 16:06:04 volumio sudo[2472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 06 16:06:04 volumio sudo[2472]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 06 16:06:04 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 06 16:06:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:04 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:04 volumio sudo[2475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 06 16:06:04 volumio sudo[2475]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 06 16:06:04 volumio volumio[2293]: info: Discovery: adding 1d006cda-9491-4972-8a34-f6ba1a6dc767 Sep 06 16:06:04 volumio volumio[2293]: info: Discovery: Found device Volumio Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:04 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:04 volumio sudo[2469]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:04 volumio volumio[2293]: info: Shairport-Sync Started Sep 06 16:06:04 volumio volumio[2293]: Error adding Membership: Error: addMembership EINVAL Sep 06 16:06:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 06 16:06:04 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 06 16:06:04 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 06 16:06:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 06 16:06:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 06 16:06:04 volumio sudo[2472]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:04 volumio volumio[2293]: info: Shairport-Sync Started Sep 06 16:06:04 volumio sudo[2475]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:04 volumio volumio[2293]: info: Shairport-Sync Started Sep 06 16:06:04 volumio mpd[2437]: Sep 06 16:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 06 16:06:04 volumio systemd[1]: Started Music Player Daemon. Sep 06 16:06:04 volumio sudo[2405]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:04 volumio sudo[2391]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:04 volumio volumio[2293]: info: Completed starting Core Plugins Sep 06 16:06:04 volumio volumio[2293]: info: ------------------------------------------- Sep 06 16:06:04 volumio volumio[2293]: info: ----- MyVolumio plugins startup ---- Sep 06 16:06:04 volumio volumio[2293]: info: ------------------------------------------- Sep 06 16:06:04 volumio volumio[2293]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 06 16:06:04 volumio volumio[2293]: error: MPD error: The expression evaluated to a falsy value: Sep 06 16:06:04 volumio volumio[2293]: assert.ok(self.idling) Sep 06 16:06:04 volumio volumio[2293]: error: The expression evaluated to a falsy value: Sep 06 16:06:04 volumio volumio[2293]: assert.ok(self.idling) Sep 06 16:06:04 volumio volumio[2293]: info: MPD running with PID2437 Sep 06 16:06:04 volumio volumio[2293]: ,establishing connection Sep 06 16:06:04 volumio volumio[2293]: info: Volumio called home Sep 06 16:06:04 volumio volumio[2293]: error: updateQueue error: null Sep 06 16:06:04 volumio volumio[2293]: error: updateQueue error: null Sep 06 16:06:04 volumio volumio[2293]: verbose: New Socket.io Connection to 192.168.31.169 from 192.168.31.88 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 7 Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::volumioGetVisibleSources Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:04 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 06 16:06:04 volumio volumio[2293]: info: Received Get System Info Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 16:06:04 volumio volumio[2293]: info: Discovery: Getting this device information Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:04 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:04 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:04 volumio volumio[2293]: info: Listing playlists Sep 06 16:06:04 volumio volumio[2293]: info: CoreCommandRouter::volumioGetQueue Sep 06 16:06:04 volumio volumio[2293]: info: CoreStateMachine::getQueue Sep 06 16:06:04 volumio volumio[2293]: info: CorePlayQueue::getQueue Sep 06 16:06:05 volumio volumio-remote-updater[761]: [2025-09-06 16:06:05] [connect] Successful connection Sep 06 16:06:05 volumio volumio-remote-updater[761]: [2025-09-06 16:06:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757145965 101 Sep 06 16:06:05 volumio volumio[2293]: 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: 8 Sep 06 16:06:07 volumio volumio[2293]: 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: 9 Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::volumioGetVisibleSources Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:07 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:07 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 06 16:06:07 volumio volumio[2293]: info: Received Get System Info Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 16:06:07 volumio volumio[2293]: info: Discovery: Getting this device information Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:07 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 16:06:07 volumio volumio[2293]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:07 volumio volumio[2293]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:07 volumio volumio[2293]: info: Listing playlists Sep 06 16:06:09 volumio volumio[2293]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 06 16:06:09 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 16:06:10 volumio volumio[2293]: info: Preload queue cleared Sep 06 16:06:12 volumio sudo[2502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 06 16:06:12 volumio sudo[2502]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:12 volumio sudo[2502]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:12 volumio sudo[2505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 06 16:06:12 volumio sudo[2505]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:12 volumio sudo[2505]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:12 volumio sudo[2508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 06 16:06:12 volumio sudo[2508]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:12 volumio sudo[2508]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:12 volumio volumio[2293]: info: Upmpdcli Daemon Started Sep 06 16:06:12 volumio sudo[2348]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:12 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 06 16:06:12 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 06 16:06:12 volumio volumio[2293]: info: Cannot mount NAS MUSIC at system boot, trial number 1 ,retrying in 5 seconds Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 06 16:06:13 volumio volumio[2293]: info: Adding plugin bluetooth to MyMusic Plugins Sep 06 16:06:13 volumio volumio[2293]: info: Adding plugin multiroom to MyMusic Plugins Sep 06 16:06:13 volumio volumio[2293]: info: Adding plugin metavolumio to MyMusic Plugins Sep 06 16:06:13 volumio volumio[2293]: info: Adding plugin cd_controller to MyMusic Plugins Sep 06 16:06:13 volumio volumio[2293]: info: Adding plugin qobuzconnect to MyMusic Plugins Sep 06 16:06:13 volumio volumio[2293]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 06 16:06:13 volumio volumio[2293]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 06 16:06:13 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:13 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:13 volumio volumio[2293]: info: Starting MyVolumio Remote Streaming Endpoints Sep 06 16:06:13 volumio volumio[2293]: info: MyVolumio not started Sep 06 16:06:13 volumio volumio[2293]: info: Initializing device activation check Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 06 16:06:13 volumio volumio[2293]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 06 16:06:13 volumio volumio[2293]: info: Starting Streaming Service Transparent Proxy Sep 06 16:06:14 volumio volumio[2293]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 06 16:06:14 volumio volumio[2293]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 06 16:06:14 volumio volumio[2293]: info: Streaming services startup Sep 06 16:06:14 volumio volumio[2293]: info: Starting Streaming Daemon Sep 06 16:06:14 volumio sudo[2518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 06 16:06:14 volumio sudo[2518]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:14 volumio sudo[2518]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:14 volumio volumio[2293]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 06 16:06:14 volumio volumio[2293]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 16:06:14 volumio volumio[2293]: error: Cannot start Volumio Streaming Daemon Sep 06 16:06:14 volumio volumio[2293]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 06 16:06:14 volumio volumio[2293]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 06 16:06:14 volumio volumio[2293]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 16:06:14 volumio volumio[2293]: TypeError: Cannot read property 'length' of undefined Sep 06 16:06:14 volumio volumio[2293]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Sep 06 16:06:14 volumio volumio[2293]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Sep 06 16:06:14 volumio volumio[2293]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Sep 06 16:06:14 volumio volumio[2293]: at Parser.emit (events.js:400:28) Sep 06 16:06:14 volumio volumio[2293]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Sep 06 16:06:14 volumio volumio[2293]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Sep 06 16:06:14 volumio volumio[2293]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Sep 06 16:06:14 volumio volumio[2293]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Sep 06 16:06:14 volumio volumio[2293]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Sep 06 16:06:14 volumio volumio[2293]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Sep 06 16:06:14 volumio volumio[2293]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Sep 06 16:06:14 volumio volumio[2293]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Sep 06 16:06:14 volumio volumio[2293]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Sep 06 16:06:14 volumio volumio[2293]: at IncomingMessage.emit (events.js:412:35) Sep 06 16:06:14 volumio volumio[2293]: at endReadableNT (internal/streams/readable.js:1333:12) Sep 06 16:06:14 volumio volumio[2293]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Sep 06 16:06:14 volumio volumio[2293]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 16:06:14 volumio sudo[2533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-06 16:05 Sep 06 16:06:14 volumio sudo[2533]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:14 volumio sudo[2533]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:14 volumio volumio-remote-updater[761]: [2025-09-06 16:06:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Sep 06 16:06:14 volumio volumio-remote-updater[761]: [2025-09-06 16:06:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Sep 06 16:06:14 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Sep 06 16:06:14 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Sep 06 16:06:14 volumio systemd[1]: Started dynamicswap service. Sep 06 16:06:14 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 06 16:06:14 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Sep 06 16:06:14 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Sep 06 16:06:14 volumio systemd[1]: Stopped Volumio Backend Module. Sep 06 16:06:14 volumio systemd[1]: Started Volumio Backend Module. Sep 06 16:06:14 volumio systemd[1]: Started dynamicswap service. Sep 06 16:06:14 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 06 16:06:15 volumio volumio[2543]: info: ------------------------------------------- Sep 06 16:06:15 volumio volumio[2543]: info: ----- Volumio3 ---- Sep 06 16:06:15 volumio volumio[2543]: info: ------------------------------------------- Sep 06 16:06:15 volumio volumio[2543]: info: ----- System startup ---- Sep 06 16:06:15 volumio volumio[2543]: info: ------------------------------------------- Sep 06 16:06:15 volumio volumio[2543]: info: MYVOLUMIO Environment detected Sep 06 16:06:15 volumio volumio[2543]: info: Plugin folders cleanup Sep 06 16:06:15 volumio volumio[2543]: info: Scanning into folder /volumio/app/plugins/ Sep 06 16:06:15 volumio volumio[2543]: info: Scanning category audio_interface Sep 06 16:06:15 volumio volumio[2543]: info: Scanning category miscellanea Sep 06 16:06:15 volumio volumio[2543]: info: Scanning category music_service Sep 06 16:06:15 volumio volumio[2543]: info: Scanning category plugins.json Sep 06 16:06:15 volumio volumio[2543]: info: Scanning category system_controller Sep 06 16:06:15 volumio volumio[2543]: info: Scanning category user_interface Sep 06 16:06:15 volumio volumio[2543]: info: Scanning into folder /data/plugins/ Sep 06 16:06:15 volumio volumio[2543]: info: Plugin folders cleanup completed Sep 06 16:06:15 volumio volumio[2543]: info: ------------------------------------------- Sep 06 16:06:15 volumio volumio[2543]: info: ----- Core plugins startup ---- Sep 06 16:06:15 volumio volumio[2543]: info: ------------------------------------------- Sep 06 16:06:15 volumio volumio[2543]: info: Loading plugins from folder /volumio/app/plugins/ Sep 06 16:06:15 volumio volumio[2543]: info: Adding plugin upnp to MyMusic Plugins Sep 06 16:06:15 volumio volumio[2543]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 06 16:06:15 volumio volumio[2543]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 06 16:06:15 volumio volumio[2543]: info: Loading plugins from folder /data/plugins/ Sep 06 16:06:15 volumio volumio[2543]: info: Loading plugin "system"... Sep 06 16:06:15 volumio volumio[2543]: info: Loading plugin "appearance"... Sep 06 16:06:15 volumio volumio[2543]: info: Loading plugin "network"... Sep 06 16:06:15 volumio volumio[2543]: info: Refreshing Cached IP Addresses Sep 06 16:06:15 volumio sudo[2570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 06 16:06:15 volumio sudo[2570]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:15 volumio sudo[2570]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:15 volumio sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 06 16:06:15 volumio sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:15 volumio volumio[2543]: info: Loading plugin "services"... Sep 06 16:06:15 volumio volumio[2543]: info: Loading plugin "alsa_controller"... Sep 06 16:06:15 volumio sudo[2572]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "wizard"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "networkfs"... Sep 06 16:06:16 volumio volumio[2543]: info: Starting Udev Watcher for removable devices Sep 06 16:06:16 volumio sudo[2595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=administrator,password=xfcbjy,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.31.30/MUSIC /mnt/NAS/MUSIC Sep 06 16:06:16 volumio sudo[2595]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:16 volumio volumio[2543]: info: Ignoring mount for partition: boot Sep 06 16:06:16 volumio volumio[2543]: info: Ignoring mount for partition: volumio Sep 06 16:06:16 volumio volumio[2543]: info: Ignoring mount for partition: volumio_data Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "volumio_command_line_client"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "upnp"... Sep 06 16:06:16 volumio volumio[2543]: info: [1757145976091] Starting Upmpd Daemon Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 06 16:06:16 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Sep 06 16:06:16 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 06 16:06:16 volumio kernel: CIFS: Attempting to mount //192.168.31.30/MUSIC Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "my_music"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "mpd"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "upnp_browser"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "alarm-clock"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "airplay_emulation"... Sep 06 16:06:16 volumio volumio[2543]: info: Starting Shairport Sync Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "last_100"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "webradio"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "i2s_dacs"... Sep 06 16:06:16 volumio volumio[2543]: info: I2S DAC not set, start Auto-detection Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "volumiodiscovery"... Sep 06 16:06:16 volumio volumio[2543]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 06 16:06:16 volumio volumio[2543]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 06 16:06:16 volumio volumio[2543]: *** WARNING *** For more information see Sep 06 16:06:16 volumio volumio[2543]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 06 16:06:16 volumio node[2543]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 06 16:06:16 volumio volumio[2543]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 06 16:06:16 volumio volumio[2543]: *** WARNING *** For more information see Sep 06 16:06:16 volumio node[2543]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 06 16:06:16 volumio node[2543]: *** WARNING *** For more information see Sep 06 16:06:16 volumio node[2543]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 06 16:06:16 volumio node[2543]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 06 16:06:16 volumio node[2543]: *** WARNING *** For more information see Sep 06 16:06:16 volumio volumio[2543]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 06 16:06:16 volumio volumio[2543]: info: Discovery: Started advertising with name: Volumio Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "outputs"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "albumart"... Sep 06 16:06:16 volumio volumio[2543]: info: Plugin example_plugin is not enabled Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "inputs"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "updater_comm"... Sep 06 16:06:16 volumio volumio[2543]: Forking 3 albumart workers Sep 06 16:06:16 volumio volumio[2543]: info: Plugin mpdemulation is not enabled Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "rest_api"... Sep 06 16:06:16 volumio volumio[2543]: info: Loading plugin "websocket"... Sep 06 16:06:16 volumio volumio[2543]: info: Starting Socket.io Server version 2.3.0 Sep 06 16:06:16 volumio volumio[2543]: info: Loading i18n strings for locale zh Sep 06 16:06:16 volumio volumio[2543]: Updating browse sources language Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::initPlayerControls Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: Express server listening on port 3000 Sep 06 16:06:16 volumio volumio[2543]: [Metrics] WebUI: 1s 907.28ms Sep 06 16:06:16 volumio volumio[2543]: info: Setting Device type: x86 Sep 06 16:06:16 volumio volumio[2543]: info: CoreStateMachine::resetVolumioState Sep 06 16:06:16 volumio volumio[2543]: info: CoreStateMachine::getcurrentVolume Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::volumioRetrievevolume Sep 06 16:06:16 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:16 volumio volumio[2543]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 06 16:06:16 volumio volumio[2543]: info: Completed loading Core Plugins Sep 06 16:06:16 volumio volumio[2543]: info: Preparing to generate the ALSA configuration file Sep 06 16:06:16 volumio volumio[2543]: info: Volumio Network Manager: Network status updated: 1 Sep 06 16:06:17 volumio volumio[2543]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Sep 06 16:06:17 volumio volumio[2543]: Starting albumart workers Sep 06 16:06:17 volumio volumio[2543]: Starting albumart workers Sep 06 16:06:17 volumio volumio[2543]: 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 06 16:06:17 volumio volumio[2543]: verbose: New Socket.io Connection to 192.168.31.169 from 192.168.31.88 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 2 Sep 06 16:06:17 volumio volumio[2543]: Starting albumart workers Sep 06 16:06:17 volumio volumio[2543]: verbose: New Socket.io Connection to 192.168.31.169 from 192.168.31.88 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 3 Sep 06 16:06:17 volumio volumio[2543]: info: VolumeController:: Volume=0 Mute =false Sep 06 16:06:17 volumio volumio[2543]: info: CoreStateMachine::pushState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioPushState Sep 06 16:06:17 volumio volumio[2543]: info: CoreStateMachine::updateTrackBlock Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrackBlock Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioRetrievevolume Sep 06 16:06:17 volumio volumio[2543]: info: Reloading queue from file Sep 06 16:06:17 volumio volumio[2543]: info: Asound.conf file unchanged, so no further update is needed Sep 06 16:06:17 volumio volumio[2543]: info: Output device has changed, restarting MPD Sep 06 16:06:17 volumio volumio[2543]: info: Output device has changed, restarting Shairport Sync Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:17 volumio sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 06 16:06:17 volumio sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:17 volumio sudo[2639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 06 16:06:17 volumio sudo[2637]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:17 volumio sudo[2639]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:17 volumio systemd[1]: Stopping Music Player Daemon... Sep 06 16:06:17 volumio volumio[2543]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 06 16:06:17 volumio volumio[2543]: info: ___________ START PLUGINS ___________ Sep 06 16:06:17 volumio systemd[1]: mpd.service: Succeeded. Sep 06 16:06:17 volumio systemd[1]: Stopped Music Player Daemon. Sep 06 16:06:17 volumio volumio[2543]: info: ControllerMpd::onStart: Initializing MPD Sep 06 16:06:17 volumio volumio[2543]: info: Creating MPD Configuration file Sep 06 16:06:17 volumio systemd[1]: Starting Music Player Daemon... Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 06 16:06:17 volumio volumio[2543]: info: [1757145977356] CoreMusicLibrary::Adding element 媒体服务器 Sep 06 16:06:17 volumio sudo[2647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 06 16:06:17 volumio sudo[2647]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:17 volumio sudo[2649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 06 16:06:17 volumio sudo[2649]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:17 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Sep 06 16:06:17 volumio systemd[1]: mpd.service: Succeeded. Sep 06 16:06:17 volumio sudo[2647]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:17 volumio systemd[1]: Stopped Music Player Daemon. Sep 06 16:06:17 volumio systemd[1]: Starting Music Player Daemon... Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:17 volumio sudo[2652]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 06 16:06:17 volumio sudo[2652]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:17 volumio sudo[2652]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:17 volumio volumio[2543]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 06 16:06:17 volumio volumio[2543]: info: [1757145977504] CoreMusicLibrary::Adding element Last_100 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 06 16:06:17 volumio volumio[2543]: info: [1757145977507] CoreMusicLibrary::Adding element Webradio Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 06 16:06:17 volumio volumio[2543]: info: Initializing BBC Radios Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: Volumio Calling Home Sep 06 16:06:17 volumio volumio[2543]: info: CoreStateMachine::setRepeat null single undefined Sep 06 16:06:17 volumio volumio[2543]: info: CoreStateMachine::pushState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioPushState Sep 06 16:06:17 volumio volumio[2543]: info: CoreStateMachine::setRandom null Sep 06 16:06:17 volumio volumio[2543]: info: CoreStateMachine::pushState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioPushState Sep 06 16:06:17 volumio volumio[2543]: 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: 4 Sep 06 16:06:17 volumio volumio[2543]: info: MPD Permissions set Sep 06 16:06:17 volumio volumio[2543]: info: MPD Permissions set Sep 06 16:06:17 volumio volumio[2543]: info: VolumeController:: Volume=0 Mute =false Sep 06 16:06:17 volumio volumio[2543]: info: CoreStateMachine::pushState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioPushState Sep 06 16:06:17 volumio volumio[2543]: 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 06 16:06:17 volumio volumio[2543]: verbose: New Socket.io Connection to 192.168.31.169 from 192.168.31.88 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 6 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 06 16:06:17 volumio volumio[2543]: verbose: New Socket.io Connection to 192.168.31.169 from 192.168.31.88 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 7 Sep 06 16:06:17 volumio volumio[2543]: info: Discovery: adding 1d006cda-9491-4972-8a34-f6ba1a6dc767 Sep 06 16:06:17 volumio volumio[2543]: info: Discovery: Found device Volumio Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioGetVisibleSources Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 06 16:06:17 volumio volumio[2543]: info: Received Get System Info Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 16:06:17 volumio volumio[2543]: info: Discovery: Getting this device information Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 16:06:17 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:17 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:17 volumio volumio[2543]: info: Listing playlists Sep 06 16:06:17 volumio volumio[2543]: info: Starting Shairport Sync Sep 06 16:06:17 volumio volumio[2543]: info: Starting Shairport Sync Sep 06 16:06:18 volumio sudo[2713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 06 16:06:18 volumio sudo[2713]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:18 volumio volumio[2543]: info: Starting Shairport Sync Sep 06 16:06:18 volumio sudo[2716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 06 16:06:18 volumio sudo[2716]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 06 16:06:18 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 06 16:06:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 06 16:06:18 volumio sudo[2719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 06 16:06:18 volumio sudo[2719]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:18 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:18 volumio sudo[2713]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 06 16:06:18 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 06 16:06:18 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 06 16:06:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 06 16:06:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 06 16:06:18 volumio sudo[2716]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:18 volumio sudo[2719]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 06 16:06:18 volumio volumio[2543]: info: Shairport-Sync Started Sep 06 16:06:18 volumio volumio[2543]: Error adding Membership: Error: addMembership EINVAL Sep 06 16:06:18 volumio volumio[2543]: info: Shairport-Sync Started Sep 06 16:06:18 volumio volumio[2543]: info: Shairport-Sync Started Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::volumioGetVisibleSources Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:18 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 06 16:06:18 volumio volumio[2543]: info: Received Get System Info Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 16:06:18 volumio volumio[2543]: info: Discovery: Getting this device information Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:18 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:18 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:18 volumio mpd[2660]: Sep 06 16:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 06 16:06:18 volumio systemd[1]: Started Music Player Daemon. Sep 06 16:06:18 volumio sudo[2649]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:18 volumio volumio[2543]: info: Listing playlists Sep 06 16:06:18 volumio sudo[2639]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:18 volumio volumio[2543]: info: CoreCommandRouter::volumioGetQueue Sep 06 16:06:18 volumio volumio[2543]: info: CoreStateMachine::getQueue Sep 06 16:06:18 volumio volumio[2543]: info: CorePlayQueue::getQueue Sep 06 16:06:18 volumio volumio[2543]: info: Completed starting Core Plugins Sep 06 16:06:18 volumio volumio[2543]: info: ------------------------------------------- Sep 06 16:06:18 volumio volumio[2543]: info: ----- MyVolumio plugins startup ---- Sep 06 16:06:18 volumio volumio[2543]: info: ------------------------------------------- Sep 06 16:06:18 volumio volumio[2543]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 06 16:06:18 volumio volumio[2543]: info: Volumio called home Sep 06 16:06:18 volumio volumio[2543]: error: MPD error: The expression evaluated to a falsy value: Sep 06 16:06:18 volumio volumio[2543]: assert.ok(self.idling) Sep 06 16:06:18 volumio volumio[2543]: error: The expression evaluated to a falsy value: Sep 06 16:06:18 volumio volumio[2543]: assert.ok(self.idling) Sep 06 16:06:18 volumio volumio[2543]: info: MPD running with PID2660 Sep 06 16:06:18 volumio volumio[2543]: ,establishing connection Sep 06 16:06:18 volumio volumio[2543]: error: updateQueue error: null Sep 06 16:06:18 volumio volumio[2543]: error: updateQueue error: null Sep 06 16:06:19 volumio volumio-remote-updater[761]: [2025-09-06 16:06:19] [connect] Successful connection Sep 06 16:06:19 volumio volumio-remote-updater[761]: [2025-09-06 16:06:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757145979 101 Sep 06 16:06:19 volumio volumio[2543]: 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: 8 Sep 06 16:06:23 volumio volumio[2543]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 06 16:06:23 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 06 16:06:23 volumio volumio[2543]: info: CURURI: music-library Sep 06 16:06:23 volumio volumio[2543]: error: Failed LSINFO: null Sep 06 16:06:23 volumio volumio[2543]: info: Preload queue cleared Sep 06 16:06:26 volumio sudo[2748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 06 16:06:26 volumio sudo[2748]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:26 volumio sudo[2748]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:26 volumio sudo[2751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 06 16:06:26 volumio sudo[2751]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:26 volumio sudo[2751]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:26 volumio sudo[2754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 06 16:06:26 volumio sudo[2754]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:26 volumio sudo[2754]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:26 volumio volumio[2543]: info: Upmpdcli Daemon Started Sep 06 16:06:26 volumio sudo[2595]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:26 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 06 16:06:26 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 06 16:06:26 volumio volumio[2543]: info: Cannot mount NAS MUSIC at system boot, trial number 1 ,retrying in 5 seconds Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 06 16:06:27 volumio volumio[2543]: info: Adding plugin bluetooth to MyMusic Plugins Sep 06 16:06:27 volumio volumio[2543]: info: Adding plugin multiroom to MyMusic Plugins Sep 06 16:06:27 volumio volumio[2543]: info: Adding plugin metavolumio to MyMusic Plugins Sep 06 16:06:27 volumio volumio[2543]: info: Adding plugin cd_controller to MyMusic Plugins Sep 06 16:06:27 volumio volumio[2543]: info: Adding plugin qobuzconnect to MyMusic Plugins Sep 06 16:06:27 volumio volumio[2543]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 06 16:06:27 volumio volumio[2543]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 06 16:06:27 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:27 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 06 16:06:27 volumio volumio[2543]: info: Starting MyVolumio Remote Streaming Endpoints Sep 06 16:06:27 volumio volumio[2543]: info: MyVolumio not started Sep 06 16:06:27 volumio volumio[2543]: info: Initializing device activation check Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 06 16:06:27 volumio volumio[2543]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 06 16:06:27 volumio volumio[2543]: info: Starting Streaming Service Transparent Proxy Sep 06 16:06:28 volumio volumio[2543]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 06 16:06:28 volumio volumio[2543]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 06 16:06:28 volumio volumio[2543]: info: Streaming services startup Sep 06 16:06:28 volumio volumio[2543]: info: Starting Streaming Daemon Sep 06 16:06:28 volumio sudo[2764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 06 16:06:28 volumio sudo[2764]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:28 volumio sudo[2764]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:28 volumio volumio[2543]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 06 16:06:28 volumio volumio[2543]: error: Cannot start Volumio Streaming Daemon Sep 06 16:06:28 volumio volumio[2543]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 06 16:06:28 volumio volumio[2543]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 06 16:06:28 volumio volumio[2543]: STREAMING PROXY: Starting server on port 3245 Sep 06 16:06:28 volumio volumio[2543]: Node JS runtime: 14 Sep 06 16:06:31 volumio volumio[2543]: info: CoreCommandRouter::volumioPlay Sep 06 16:06:31 volumio volumio[2543]: info: CoreStateMachine::play index undefined Sep 06 16:06:31 volumio volumio[2543]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 16:06:31 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:31 volumio sudo[2771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=administrator,password=xfcbjy,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.31.30/MUSIC /mnt/NAS/MUSIC Sep 06 16:06:31 volumio sudo[2771]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 16:06:31 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Sep 06 16:06:31 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 06 16:06:31 volumio kernel: CIFS: Attempting to mount //192.168.31.30/MUSIC Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 06 16:06:35 volumio volumio[2543]: info: Retrieving Cloud Streaming UI Sep 06 16:06:35 volumio volumio[2543]: info: Getting Tidal Cloud Configuration Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 06 16:06:35 volumio volumio[2543]: info: Getting Qobuz Cloud Configuration Sep 06 16:06:35 volumio volumio[2543]: info: Asking plugin for UI Config Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 06 16:06:35 volumio volumio[2543]: info: Getting Spotify Cloud Configuration Sep 06 16:06:35 volumio volumio[2543]: info: Asking plugin for UI Config Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 06 16:06:35 volumio volumio[2543]: info: Saving Spotify Acccount Sep 06 16:06:35 volumio volumio[2543]: info: Got Tidal Cloud Configuration Sep 06 16:06:35 volumio volumio[2543]: info: Got it Sep 06 16:06:35 volumio volumio[2543]: info: Got it Sep 06 16:06:35 volumio volumio[2543]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 06 16:06:35 volumio volumio[2543]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::volumioGetBrowseSources Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::volumioGetBrowseSources Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::volumioGetBrowseSources Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:06:35 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 06 16:06:38 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 06 16:06:38 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 06 16:06:39 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 06 16:06:41 volumio sudo[2771]: pam_unix(sudo:session): session closed for user root Sep 06 16:06:41 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 06 16:06:41 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 06 16:06:41 volumio volumio[2543]: info: Cannot mount NAS MUSIC at system boot, trial number 2 ,retrying in 5 seconds Sep 06 16:06:41 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 06 16:06:41 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 06 16:06:42 volumio volumio[2543]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 06 16:06:42 volumio volumio[2543]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Sep 06 16:06:42 volumio volumio[2543]: info: CoreCommandRouter::volumioGetState Sep 06 16:06:42 volumio volumio[2543]: info: CorePlayQueue::getTrack 0 Sep 06 16:06:43 volumio volumio[2543]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 16:06:43 volumio volumio[2543]: Error: dns service error: unknown Sep 06 16:06:43 volumio volumio[2543]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Sep 06 16:06:43 volumio volumio[2543]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Sep 06 16:06:43 volumio volumio[2543]: errorCode: -65537 Sep 06 16:06:43 volumio volumio[2543]: } Sep 06 16:06:43 volumio volumio[2543]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 16:06:43 volumio sudo[2810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-06 16:05 Sep 06 16:06:43 volumio sudo[2810]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"