May 25 23:29:37 volumio ntpd[939]: CLOCK: time stepped by 172403.414119 May 25 23:29:37 volumio ntpd[939]: CLOCK: time changed from 2026-05-23 to 2026-05-25 May 25 23:29:37 volumio ntpd[939]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes May 25 23:29:37 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... May 25 23:29:38 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... May 25 23:29:38 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. May 25 23:29:38 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. May 25 23:29:38 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. May 25 23:29:38 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. May 25 23:29:38 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:29:38 volumio volumio[1023]: info: Reloading queue from file May 25 23:29:38 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. May 25 23:29:38 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. May 25 23:29:38 volumio volumio[1023]: info: CoreStateMachine::setRepeat null single undefined May 25 23:29:38 volumio volumio[1023]: info: CoreStateMachine::pushState May 25 23:29:38 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:38 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 23:29:38 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState May 25 23:29:38 volumio volumio[1023]: info: CoreStateMachine::setRandom null May 25 23:29:38 volumio volumio[1023]: info: CoreStateMachine::pushState May 25 23:29:38 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:38 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState May 25 23:29:38 volumio volumio[1023]: info: Setting Device type: Raspberry PI May 25 23:29:38 volumio volumio[1023]: verbose: New Socket.io Connection to 192.168.50.174 from 192.168.50.219 UA: Mozilla/5.0 (Linux; U; Android 16; zh-cn; PGU110 Build/BP2A.250605.015) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/115.0.5790.168 Mobile Safari/537.36 HeyTapBrowser/40.10.16.1 Engine version: 3 Transport: polling Total Clients: 2 May 25 23:29:38 volumio volumio[1023]: info: Completed loading Core Plugins May 25 23:29:38 volumio volumio[1023]: info: Preparing to generate the ALSA configuration file May 25 23:29:38 volumio volumio[1023]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 25 23:29:38 volumio volumio[1023]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03140 May 25 23:29:38 volumio volumio[1023]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 25 23:29:38 volumio volumio[1023]: info: Discovery: A device disappeared from network May 25 23:29:38 volumio volumio[1023]: info: Discovery: A device disappeared from network May 25 23:29:38 volumio volumio[1023]: info: Discovery: adding 79c42b01-dcd6-4e96-a390-f3abaa5fd694 May 25 23:29:38 volumio volumio[1023]: info: Discovery: Found device Volumio May 25 23:29:38 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:38 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:38 volumio volumio[1023]: info: Asound.conf file unchanged, so no further update is needed May 25 23:29:38 volumio volumio[1023]: info: Output device has changed, restarting MPD May 25 23:29:39 volumio volumio[1023]: info: Output device has changed, restarting Shairport Sync May 25 23:29:39 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:39 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:29:39 volumio sudo[1338]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 25 23:29:39 volumio sudo[1338]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:39 volumio sudo[1340]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 25 23:29:39 volumio sudo[1340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:39 volumio sudo[1338]: pam_unix(sudo:session): session closed for user root May 25 23:29:39 volumio volumio[1023]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 23:29:39 volumio volumio[1023]: info: ___________ START PLUGINS ___________ May 25 23:29:39 volumio volumio[1023]: info: ControllerMpd::onStart: Initializing MPD May 25 23:29:39 volumio volumio[1023]: info: Creating MPD Configuration file May 25 23:29:39 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 25 23:29:39 volumio systemd[1]: Starting mpd.service - Music Player Daemon... May 25 23:29:39 volumio sudo[1348]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service May 25 23:29:39 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 23:29:39 volumio volumio[1023]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 23:29:39 volumio volumio[1023]: info: [1779722979554] CoreMusicLibrary::Adding element 媒体服务器 May 25 23:29:39 volumio sudo[1348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:39 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 23:29:39 volumio sudo[1351]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 25 23:29:39 volumio volumio[1023]: info: UPNP Browser: Client initialized successfully May 25 23:29:39 volumio sudo[1351]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:39 volumio sudo[1352]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 25 23:29:39 volumio sudo[1352]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 25 23:29:39 volumio sudo[1354]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 25 23:29:39 volumio sudo[1352]: pam_unix(sudo:session): session closed for user root May 25 23:29:39 volumio sudo[1358]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 25 23:29:39 volumio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. May 25 23:29:39 volumio sudo[1351]: pam_unix(sudo:session): session closed for user root May 25 23:29:39 volumio sudo[1348]: pam_unix(sudo:session): session closed for user root May 25 23:29:39 volumio sudo[1354]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:39 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:39 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:29:40 volumio volumio[1023]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:29:40 volumio volumio[1023]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 23:29:40 volumio volumio[1023]: info: [1779722980209] CoreMusicLibrary::Adding element Last_100 May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 23:29:40 volumio volumio[1023]: info: [1779722980219] CoreMusicLibrary::Adding element Webradio May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 23:29:40 volumio systemd[1]: mpd.service: Deactivated successfully. May 25 23:29:40 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. May 25 23:29:40 volumio systemd[1]: mpd.socket: Deactivated successfully. May 25 23:29:40 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 25 23:29:40 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 23:29:40 volumio volumio[1023]: info: Initializing BBC Radios May 25 23:29:40 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 25 23:29:40 volumio systemd[1]: Starting mpd.service - Music Player Daemon... May 25 23:29:40 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:40.499+08:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 25 23:29:40 volumio sudo[1377]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 25 23:29:40 volumio sudo[1377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 25 23:29:40 volumio sudo[1386]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 25 23:29:40 volumio sudo[1377]: pam_unix(sudo:session): session closed for user root May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 23:29:40 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:29:40 volumio volumio[1023]: info: Volumio Calling Home May 25 23:29:44 volumio volumio[1023]: info: Discovery: this is already registered, 79c42b01-dcd6-4e96-a390-f3abaa5fd694 May 25 23:29:44 volumio volumio[1023]: info: Discovery: Found device Volumio May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:44 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:44 volumio sudo[1415]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 23:29:44 volumio sudo[1415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:44 volumio volumio[1023]: info: MPD Permissions set May 25 23:29:44 volumio volumio[1023]: info: MPD Permissions set May 25 23:29:44 volumio sudo[1415]: pam_unix(sudo:session): session closed for user root May 25 23:29:44 volumio sudo[1412]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 23:29:44 volumio sudo[1412]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:44 volumio volumio[1023]: info: Volumio called home May 25 23:29:44 volumio sudo[1412]: pam_unix(sudo:session): session closed for user root May 25 23:29:44 volumio volumio[1023]: info: Discovery: this is already registered, 79c42b01-dcd6-4e96-a390-f3abaa5fd694 May 25 23:29:44 volumio volumio[1023]: info: Discovery: Found device Volumio May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:44 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:44 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully. May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 23:29:45 volumio volumio[1023]: info: Discovery: this is already registered, 79c42b01-dcd6-4e96-a390-f3abaa5fd694 May 25 23:29:45 volumio volumio[1023]: info: Discovery: Found device Volumio May 25 23:29:45 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:45 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:45 volumio volumio[1289]: Starting albumart workers May 25 23:29:45 volumio volumio[1288]: Starting albumart workers May 25 23:29:46 volumio volumio-remote-updater[737]: [2026-05-25 23:29:46] [connect] Successful connection May 25 23:29:46 volumio sudo[1435]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 25 23:29:46 volumio sudo[1435]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:46 volumio volumio[1023]: info: Starting Shairport Sync May 25 23:29:46 volumio sudo[1438]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 23:29:46 volumio sudo[1438]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:46 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 25 23:29:46 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 25 23:29:46 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 25 23:29:46 volumio systemd[1]: shairport-sync.service: Consumed 1.826s CPU time. May 25 23:29:46 volumio volumio[1023]: info: Starting Shairport Sync May 25 23:29:46 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 25 23:29:46 volumio sudo[1438]: pam_unix(sudo:session): session closed for user root May 25 23:29:46 volumio volumio[1023]: info: Starting Shairport Sync May 25 23:29:46 volumio sudo[1442]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 23:29:46 volumio sudo[1442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:46 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 May 25 23:29:47 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:47.025+08:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci0 error="bluetooth: adapter /org/bluez/hci0 does not exist" May 25 23:29:47 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:47.031+08:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci1 error="bluetooth: adapter /org/bluez/hci1 does not exist" May 25 23:29:47 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 25 23:29:47 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:47.039+08:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci2 error="bluetooth: adapter /org/bluez/hci2 does not exist" May 25 23:29:47 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:47.041+08:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci3 error="bluetooth: adapter /org/bluez/hci3 does not exist" May 25 23:29:47 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:47.046+08:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci4 error="bluetooth: adapter /org/bluez/hci4 does not exist" May 25 23:29:47 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:47.046+08:00 level=WARN msg="no Bluetooth adapter found, BLE discovery disabled" May 25 23:29:47 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 25 23:29:47 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 25 23:29:47 volumio volumio[1023]: info: Shairport-Sync Started May 25 23:29:47 volumio volumio[1023]: Error adding Membership: Error: addMembership EINVAL May 25 23:29:47 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 25 23:29:47 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 May 25 23:29:47 volumio sudo[1458]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 23:29:47 volumio sudo[1458]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:47 volumio sudo[1442]: pam_unix(sudo:session): session closed for user root May 25 23:29:47 volumio volumio[1023]: info: Received Get System Info May 25 23:29:47 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 25 23:29:47 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 23:29:47 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 23:29:47 volumio volumio[1023]: info: Discovery: Getting this device information May 25 23:29:47 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 25 23:29:47 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 25 23:29:47 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:47 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:47 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 23:29:47 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:47.370+08:00 level=INFO msg="system info for 112a0063cebe35d0d74f7bcba30d01e7" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=4.119 May 25 23:29:47 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 25 23:29:47 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 25 23:29:47 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:47.446+08:00 level=INFO msg="bootstrapping state" hasInternet=true May 25 23:29:47 volumio volumio[1023]: info: Received Get System Info May 25 23:29:47 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 23:29:47 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 23:29:47 volumio volumio[1023]: info: Discovery: Getting this device information May 25 23:29:47 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:47 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:47 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 23:29:47 volumio sudo[1458]: pam_unix(sudo:session): session closed for user root May 25 23:29:47 volumio volumio-remote-updater[737]: [2026-05-25 23:29:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1779722986 101 May 25 23:29:47 volumio volumio[1023]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 5 May 25 23:29:47 volumio volumio[1023]: info: Shairport-Sync Started May 25 23:29:48 volumio volumio-remote-updater[737]: Test mode disabled May 25 23:29:48 volumio volumio-remote-updater[737]: Alpha mode disabled May 25 23:29:48 volumio volumio-remote-updater[737]: Alpha legacy test mode disabled May 25 23:29:48 volumio volumio[1023]: info: Shairport-Sync Started May 25 23:29:48 volumio mpd[1387]: 2026-05-25T23:29:48 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 25 23:29:48 volumio systemd[1]: Started mpd.service - Music Player Daemon. May 25 23:29:48 volumio sudo[1354]: pam_unix(sudo:session): session closed for user root May 25 23:29:48 volumio sudo[1340]: pam_unix(sudo:session): session closed for user root May 25 23:29:48 volumio volumio[1023]: info: Completed starting Core Plugins May 25 23:29:48 volumio volumio[1023]: info: ------------------------------------------- May 25 23:29:48 volumio volumio[1023]: info: ----- MyVolumio plugins startup ---- May 25 23:29:48 volumio volumio[1023]: info: ------------------------------------------- May 25 23:29:48 volumio volumio[1023]: info: [MyVolumio PluginManager] Fetching plans data.... May 25 23:29:48 volumio volumio[1023]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 25 23:29:48 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 25 23:29:49 volumio volumio[1290]: Starting albumart workers May 25 23:29:49 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. May 25 23:29:49 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 25 23:29:49 volumio volumio[1023]: error: MPD error: The expression evaluated to a falsy value: May 25 23:29:49 volumio volumio[1023]: assert.ok(self.idling) May 25 23:29:49 volumio volumio[1023]: error: The expression evaluated to a falsy value: May 25 23:29:49 volumio volumio[1023]: assert.ok(self.idling) May 25 23:29:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 25 23:29:49 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:49.457+08:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" May 25 23:29:49 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:49.459+08:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" May 25 23:29:49 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:49.460+08:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" May 25 23:29:49 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 25 23:29:49 volumio sudo[1435]: pam_unix(sudo:session): session closed for user root May 25 23:29:49 volumio volumio[1023]: error: updateQueue error: null May 25 23:29:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 25 23:29:49 volumio volumio[1023]: info: MPD running with PID1387 May 25 23:29:49 volumio volumio[1023]: ,establishing connection May 25 23:29:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 25 23:29:49 volumio volumio[1023]: info: Upmpdcli Daemon Started May 25 23:29:49 volumio volumio[1023]: info: Received Get System Info May 25 23:29:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 23:29:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 23:29:49 volumio volumio[1023]: info: Discovery: Getting this device information May 25 23:29:49 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:49 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 23:29:50 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 25 23:29:50 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 25 23:29:50 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:50.095+08:00 level=INFO msg="enabling local network discovery" May 25 23:29:50 volumio volumio[1023]: error: updateQueue error: null May 25 23:29:50 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:50 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:51 volumio volumio5-onboarding[1356]: time=2026-05-25T23:29:51.114+08:00 level=INFO msg="service successfully established" component=discovery/localnet May 25 23:29:51 volumio sudo[1531]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 23:29:51 volumio sudo[1531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:51 volumio sudo[1531]: pam_unix(sudo:session): session closed for user root May 25 23:29:51 volumio sudo[1533]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 23:29:51 volumio sudo[1533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:51 volumio sudo[1533]: pam_unix(sudo:session): session closed for user root May 25 23:29:51 volumio volumio[1023]: verbose: New Socket.io Connection to 192.168.50.174 from 192.168.50.219 UA: Mozilla/5.0 (Linux; U; Android 16; zh-cn; PGU110 Build/BP2A.250605.015) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/115.0.5790.168 Mobile Safari/537.36 HeyTapBrowser/40.10.16.1 Engine version: 3 Transport: polling Total Clients: 6 May 25 23:29:52 volumio sudo[1546]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 23:29:52 volumio sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:52 volumio sudo[1546]: pam_unix(sudo:session): session closed for user root May 25 23:29:52 volumio sudo[1547]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 23:29:52 volumio sudo[1547]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:29:52 volumio sudo[1547]: pam_unix(sudo:session): session closed for user root May 25 23:29:52 volumio volumio[1023]: verbose: New Socket.io Connection to 192.168.50.174 from 192.168.50.219 UA: Mozilla/5.0 (Linux; U; Android 16; zh-cn; PGU110 Build/BP2A.250605.015) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/115.0.5790.168 Mobile Safari/537.36 HeyTapBrowser/40.10.16.1 Engine version: 3 Transport: polling Total Clients: 7 May 25 23:29:52 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 23:29:53 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::volumioGetVisibleSources May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:53 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 23:29:53 volumio volumio[1023]: info: Received Get System Info May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 23:29:53 volumio volumio[1023]: info: Discovery: Getting this device information May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:53 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:53 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:53 volumio volumio[1023]: info: Listing playlists May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 25 23:29:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 25 23:29:54 volumio volumio[1023]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 25 23:29:55 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 25 23:29:55 volumio volumio[1023]: info: Received Get System Info May 25 23:29:55 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 23:29:55 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 23:29:55 volumio volumio[1023]: info: Discovery: Getting this device information May 25 23:29:55 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState May 25 23:29:55 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:29:55 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 23:29:55 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 25 23:29:56 volumio volumio[1023]: info: CoreCommandRouter::volumioGetQueue May 25 23:29:56 volumio volumio[1023]: info: CoreStateMachine::getQueue May 25 23:29:56 volumio volumio[1023]: info: CorePlayQueue::getQueue May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 25 23:29:58 volumio volumio[1023]: info: Adding plugin bluetooth to MyMusic Plugins May 25 23:29:58 volumio volumio[1023]: info: Adding plugin multiroom to MyMusic Plugins May 25 23:29:58 volumio volumio[1023]: info: Adding plugin metavolumio to MyMusic Plugins May 25 23:29:58 volumio volumio[1023]: info: Adding plugin cd_controller to MyMusic Plugins May 25 23:29:58 volumio volumio[1023]: info: Adding plugin qobuzconnect to MyMusic Plugins May 25 23:29:58 volumio volumio[1023]: info: Adding plugin smart_inputs to MyMusic Plugins May 25 23:29:58 volumio volumio[1023]: info: Adding plugin tidalconnect to MyMusic Plugins May 25 23:29:58 volumio volumio[1023]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 25 23:30:00 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... May 25 23:30:00 volumio upmpdcli[1583]: writing RSA key May 25 23:30:03 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. May 25 23:30:03 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. May 25 23:30:03 volumio systemd[1]: setdatetime-helper.service: Consumed 1.709s CPU time. May 25 23:30:03 volumio volumio[1023]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 25 23:30:03 volumio volumio[1023]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 25 23:30:03 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:30:03 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:30:03 volumio volumio[1023]: info: Starting MyVolumio Remote Streaming Endpoints May 25 23:30:03 volumio volumio[1023]: info: MyVolumio not started May 25 23:30:03 volumio volumio[1023]: info: Initializing device activation check May 25 23:30:04 volumio volumio[1023]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 25 23:30:04 volumio volumio[1023]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 25 23:30:05 volumio volumio[1023]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 25 23:30:05 volumio volumio[1023]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 25 23:30:05 volumio volumio[1023]: info: Streaming services startup May 25 23:30:05 volumio volumio[1023]: info: Starting Streaming Daemon May 25 23:30:05 volumio volumio[1023]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 25 23:30:05 volumio sudo[1615]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 25 23:30:05 volumio sudo[1615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 25 23:30:06 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 25 23:30:06 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 23:30:06 volumio volumio[1023]: info: CURURI: music-library May 25 23:30:06 volumio sudo[1615]: pam_unix(sudo:session): session closed for user root May 25 23:30:06 volumio volumio[1023]: error: Cannot start Volumio Streaming Daemon May 25 23:30:06 volumio volumio[1023]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 25 23:30:06 volumio volumio[1023]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 25 23:30:06 volumio volumio[1023]: info: Preload queue cleared May 25 23:30:07 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 23:30:07 volumio volumio[1023]: info: CURURI: music-library/NAS May 25 23:30:07 volumio volumio[1023]: info: Preload queue cleared May 25 23:30:08 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 23:30:08 volumio volumio[1023]: info: CURURI: music-library/NAS/music May 25 23:30:08 volumio volumio[1023]: info: Preload queue cleared May 25 23:30:09 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 23:30:09 volumio volumio[1023]: info: CURURI: music-library/NAS/music/Music May 25 23:30:10 volumio volumio[1023]: error: Cue Parser - Cannot parse NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).cue May 25 23:30:10 volumio volumio[1023]: info: Preload queue cleared May 25 23:30:10 volumio volumio[1023]: info: Preloading song: music-library/NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).ape May 25 23:30:10 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).ape in service mpd May 25 23:30:10 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=437&web=//extralarge&path=%2Fmnt%2FNAS%2Fmusic%2FMusic%2F%E5%8C%BA%E7%91%9E%E5%BC%BA.-.%5B%E6%B0%91%E6%AD%8C%E5%91%B3%E9%81%93IV%5D.%E4%B8%93%E8%BE%91.(APE).ape&metadata=false May 25 23:30:10 volumio volumio[1023]: info: URI /mnt/NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).ape May 25 23:30:10 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 23:30:10 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 23:30:10 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 23:30:11 volumio volumio-remote-updater[737]: Test mode disabled May 25 23:30:11 volumio volumio-remote-updater[737]: Alpha mode disabled May 25 23:30:11 volumio volumio-remote-updater[737]: Alpha legacy test mode disabled May 25 23:30:11 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 25 23:30:11 volumio volumio[1023]: info: Preload queue cleared May 25 23:30:11 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems May 25 23:30:11 volumio volumio[1023]: info: CoreStateMachine::ClearQueue May 25 23:30:11 volumio volumio[1023]: info: CoreStateMachine::stop May 25 23:30:11 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 23:30:11 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue May 25 23:30:11 volumio volumio[1023]: info: CorePlayQueue::saveQueue May 25 23:30:11 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue May 25 23:30:11 volumio volumio[1023]: info: CoreStateMachine::addQueueItems May 25 23:30:11 volumio volumio[1023]: info: CorePlayQueue::addQueueItems May 25 23:30:11 volumio volumio[1023]: info: Preload queue cleared May 25 23:30:11 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).ape May 25 23:30:11 volumio volumio[1023]: info: Using cached record of: music-library/NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).ape May 25 23:30:11 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue May 25 23:30:11 volumio volumio[1023]: info: CorePlayQueue::saveQueue May 25 23:30:11 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock May 25 23:30:11 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock May 25 23:30:11 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay May 25 23:30:11 volumio volumio[1023]: info: CoreStateMachine::play index 0 May 25 23:30:11 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 23:30:11 volumio volumio[1023]: info: CoreStateMachine::addQueueItems May 25 23:30:11 volumio volumio[1023]: info: CorePlayQueue::addQueueItems May 25 23:30:11 volumio volumio[1023]: info: Preload queue cleared May 25 23:30:11 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/《2008留声机古典百大系列》APE整轨 May 25 23:30:11 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/《2008留声机古典百大系列》APE整轨 in service mpd May 25 23:30:11 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/《监听发烧人声·磁性女声 DSD》【WAV】 May 25 23:30:11 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/《监听发烧人声·磁性女声 DSD》【WAV】 in service mpd May 25 23:30:12 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/006 久石让(Joe Hisaishi).-.[Piano.Stories.III-Nostalgia].专辑.(APE) May 25 23:30:12 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/006 久石让(Joe Hisaishi).-.[Piano.Stories.III-Nostalgia].专辑.(APE) in service mpd May 25 23:30:12 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/1834 首 无损单曲 -www.cdbao.net May 25 23:30:12 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/1834 首 无损单曲 -www.cdbao.net in service mpd May 25 23:30:16 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/2013-SIAV第21届上海国际高级HIFI演示会纪念CD May 25 23:30:16 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/2013-SIAV第21届上海国际高级HIFI演示会纪念CD in service mpd May 25 23:30:16 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/Disney May 25 23:30:16 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/Disney in service mpd May 25 23:30:16 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/zhubinjie-[试音宝典 试机三十三号][WAV] May 25 23:30:16 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/zhubinjie-[试音宝典 试机三十三号][WAV] in service mpd May 25 23:30:16 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/中国最爱儿歌经典(三) May 25 23:30:16 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/中国最爱儿歌经典(三) in service mpd May 25 23:30:16 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/中国最爱儿歌经典(二) May 25 23:30:16 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/中国最爱儿歌经典(二) in service mpd May 25 23:30:16 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/北京天使合唱团12CD May 25 23:30:16 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/北京天使合唱团12CD in service mpd May 25 23:30:16 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/区瑞强民歌味道 May 25 23:30:16 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/区瑞强民歌味道 in service mpd May 25 23:30:16 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/周华健 周而复始 iTunes Plus AAC May 25 23:30:16 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/周华健 周而复始 iTunes Plus AAC in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/喜欢盘01 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/喜欢盘01 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/天乐唱片《扣人心弦怀旧心曲》 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/天乐唱片《扣人心弦怀旧心曲》 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/张国荣.-.[告别当年情珍藏版CD1].专辑.(APE) May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/张国荣.-.[告别当年情珍藏版CD1].专辑.(APE) in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/张学友《历年获奖金曲》[WAV] May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/张学友《历年获奖金曲》[WAV] in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/张学友《友情翻唱》 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/张学友《友情翻唱》 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/惠威试音天碟Ⅰ-人声试音 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/惠威试音天碟Ⅰ-人声试音 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/惠威试音天碟Ⅱ-惠威综合试音1 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/惠威试音天碟Ⅱ-惠威综合试音1 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/惠威试音天碟Ⅲ-惠威综合试音2 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/惠威试音天碟Ⅲ-惠威综合试音2 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/惠威试音天碟Ⅳ-惠威综合试音3 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/惠威试音天碟Ⅳ-惠威综合试音3 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/惠威试音天碟Ⅴ-惠威综合试音4 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/惠威试音天碟Ⅴ-惠威综合试音4 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/李健 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/李健 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/李健《温暖嗓音 DSD》 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/李健《温暖嗓音 DSD》 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/李星儿.-.[童声监听王.DTS-ES].专辑 WAV分轨 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/李星儿.-.[童声监听王.DTS-ES].专辑 WAV分轨 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd1 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd1 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd2 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd2 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd3 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd3 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd4 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd4 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd5 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/民歌100-校园民歌经典珍藏cd5 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/港囧 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/港囧 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/美国乡村-经典民谣22首 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/美国乡村-经典民谣22首 in service mpd May 25 23:30:17 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/music/Music/群星《 美妙的天籁之音-中外童声合唱经典（3CD）》 May 25 23:30:17 volumio volumio[1023]: info: Exploding uri music-library/NAS/music/Music/群星《 美妙的天籁之音-中外童声合唱经典（3CD）》 in service mpd May 25 23:30:17 volumio volumio[1023]: info: CoreStateMachine::stop May 25 23:30:17 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::play index undefined May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 23:30:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::startPlaybackTimer May 25 23:30:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:30:18 volumio volumio[1023]: verbose: ControllerMpd::clearAddPlayTracks NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).ape May 25 23:30:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop May 25 23:30:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::play index undefined May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 23:30:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::play index undefined May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 23:30:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::startPlaybackTimer May 25 23:30:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:30:18 volumio volumio[1023]: verbose: ControllerMpd::clearAddPlayTracks NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).ape May 25 23:30:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop May 25 23:30:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:30:18 volumio volumio[1023]: info: CoreStateMachine::startPlaybackTimer May 25 23:30:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 May 25 23:30:18 volumio volumio[1023]: verbose: ControllerMpd::clearAddPlayTracks NAS/music/Music/区瑞强.-.[民歌味道IV].专辑.(APE).ape May 25 23:30:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop May 25 23:30:18 volumio volumio[1023]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 25 23:30:18 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 25 23:30:18 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=437&web=//extralarge&path=%2Fmnt%2FNAS%2Fmusic%2FMusic%2F%E3%80%8A2008%E7%95%99%E5%A3%B0%E6%9C%BA%E5%8F%A4%E5%85%B8%E7%99%BE%E5%A4%A7%E7%B3%BB%E5%88%97%E3%80%8BAPE%E6%95%B4%E8%BD%A8%2F76-80%2F%E8%8B%B1%E5%9B%BD%E7%95%99%E5%A3%B0%E6%9C%BA%E6%9D%82%E5%BF%97%E6%8E%A8%E8%8D%90%E5%8E%86%E5%8F%B2100%E6%9C%80%E4%BD%B3%E5%BD%95%E9%9F%B3_100_GREAT_RECORDINGS76-80%2F76%20%5BShostakovich%5D%20String%20Quartets%20%5BDG%20463%20284-2%5D%20Emerson%20Quartets%2FCD1%2FCDImage.ape&metadata=false May 25 23:30:18 volumio volumio[1023]: info: URI /mnt/NAS/music/Music/《2008留声机古典百大系列》APE整轨/76-80/英国留声机杂志推荐历史100最佳录音_100_GREAT_RECORDINGS76-80/76 [Shostakovich] String Quartets [DG 463 284-2] Emerson Quartets/CD1/CDImage.ape May 25 23:30:18 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=437&web=Emerson%20String%20Quartet/Shostakovich%3A%20The%20String%20Quartets%20(CD%201_Nos.%201-3)/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2FMusic%2F%E3%80%8A2008%E7%95%99%E5%A3%B0%E6%9C%BA%E5%8F%A4%E5%85%B8%E7%99%BE%E5%A4%A7%E7%B3%BB%E5%88%97%E3%80%8BAPE%E6%95%B4%E8%BD%A8%2F76-80%2F%E8%8B%B1%E5%9B%BD%E7%95%99%E5%A3%B0%E6%9C%BA%E6%9D%82%E5%BF%97%E6%8E%A8%E8%8D%90%E5%8E%86%E5%8F%B2100%E6%9C%80%E4%BD%B3%E5%BD%95%E9%9F%B3_100_GREAT_RECORDINGS76-80%2F76%20%5BShostakovich%5D%20String%20Quartets%20%5BDG%20463%20284-2%5D%20Emerson%20Quartets%2FCD1%2FCDImage.cue&metadata=false May 25 23:30:18 volumio volumio[1023]: info: URI /mnt/NAS/music/Music/《2008留声机古典百大系列》APE整轨/76-80/英国留声机杂志推荐历史100最佳录音_100_GREAT_RECORDINGS76-80/76 [Shostakovich] String Quartets [DG 463 284-2] Emerson Quartets/CD1/CDImage.cue May 25 23:30:18 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=437&web=Emerson%20String%20Quartet/Shostakovich%3A%20The%20String%20Quartets%20(CD%201_Nos.%201-3)/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2FMusic%2F%E3%80%8A2008%E7%95%99%E5%A3%B0%E6%9C%BA%E5%8F%A4%E5%85%B8%E7%99%BE%E5%A4%A7%E7%B3%BB%E5%88%97%E3%80%8BAPE%E6%95%B4%E8%BD%A8%2F76-80%2F%E8%8B%B1%E5%9B%BD%E7%95%99%E5%A3%B0%E6%9C%BA%E6%9D%82%E5%BF%97%E6%8E%A8%E8%8D%90%E5%8E%86%E5%8F%B2100%E6%9C%80%E4%BD%B3%E5%BD%95%E9%9F%B3_100_GREAT_RECORDINGS76-80%2F76%20%5BShostakovich%5D%20String%20Quartets%20%5BDG%20463%20284-2%5D%20Emerson%20Quartets%2FCD1%2FCDImage.cue&metadata=false May 25 23:30:18 volumio volumio[1023]: info: URI /mnt/NAS/music/Music/《2008留声机古典百大系列》APE整轨/76-80/英国留声机杂志推荐历史100最佳录音_100_GREAT_RECORDINGS76-80/76 [Shostakovich] String Quartets [DG 463 284-2] Emerson Quartets/CD1/CDImage.cue May 25 23:30:18 volumio volumio[1023]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 23:30:18 volumio volumio[1023]: Error: Unable to resolve or reject the same promise twice May 25 23:30:18 volumio volumio[1023]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) May 25 23:30:18 volumio volumio[1023]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 May 25 23:30:18 volumio volumio[1023]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) May 25 23:30:18 volumio volumio[1023]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) May 25 23:30:18 volumio volumio[1023]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) May 25 23:30:18 volumio volumio[1023]: at Socket.emit (node:events:514:28) May 25 23:30:18 volumio volumio[1023]: at addChunk (node:internal/streams/readable:343:12) May 25 23:30:18 volumio volumio[1023]: at readableAddChunk (node:internal/streams/readable:312:11) May 25 23:30:18 volumio volumio[1023]: at Readable.push (node:internal/streams/readable:253:10) May 25 23:30:18 volumio volumio[1023]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) May 25 23:30:18 volumio volumio[1023]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 23:30:22 volumio sudo[1653]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-25 23:29' May 25 23:30:22 volumio sudo[1653]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"