-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Mon 2025-05-26 12:15:43 CST. -- May 26 12:14:32 volumio systemd-timedated[985]: Changed local time to Mon May 26 12:14:32 2025 May 26 12:14:32 volumio sudo[983]: pam_unix(sudo:session): session closed for user root May 26 12:14:32 volumio volumio-time-update[621]: volumio-time-update-util: System time updated successfully. May 26 12:14:32 volumio systemd[1]: Starting Daily apt download activities... May 26 12:14:32 volumio systemd[1]: Started Volumio Time Update Utility. May 26 12:14:32 volumio wireless.js[624]: trying... May 26 12:14:32 volumio volumio-remote-updater[633]: [2025-05-26 12:14:32] [info] asio async_connect error: system:111 (Connection refused) May 26 12:14:32 volumio volumio-remote-updater[633]: [2025-05-26 12:14:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 26 12:14:32 volumio volumio-remote-updater[633]: [2025-05-26 12:14:32] [error] handle_connect error: Underlying Transport Error May 26 12:14:33 volumio sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:33 volumio sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:33 volumio sudo[998]: pam_unix(sudo:session): session closed for user root May 26 12:14:33 volumio smbd[981]: [2025/05/26 12:14:33.801331, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 26 12:14:33 volumio systemd[1]: Started Samba SMB Daemon. May 26 12:14:33 volumio smbd[981]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 26 12:14:33 volumio wireless.js[624]: trying... May 26 12:14:33 volumio sudo[1005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:33 volumio sudo[1005]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:33 volumio sudo[1005]: pam_unix(sudo:session): session closed for user root May 26 12:14:34 volumio wireless.js[624]: trying... May 26 12:14:34 volumio sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:34 volumio sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:34 volumio sudo[1028]: pam_unix(sudo:session): session closed for user root May 26 12:14:35 volumio wireless.js[624]: trying... May 26 12:14:35 volumio sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:35 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:35 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root May 26 12:14:36 volumio wireless.js[624]: trying... May 26 12:14:36 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:36 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:36 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root May 26 12:14:37 volumio wireless.js[624]: trying... May 26 12:14:37 volumio systemd[1]: apt-daily.service: Succeeded. May 26 12:14:37 volumio systemd[1]: Started Daily apt download activities. May 26 12:14:37 volumio sudo[1066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:37 volumio sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:37 volumio sudo[1066]: pam_unix(sudo:session): session closed for user root May 26 12:14:37 volumio systemd[1]: Starting Daily apt upgrade and clean activities... May 26 12:14:38 volumio wireless.js[624]: trying... May 26 12:14:38 volumio sudo[1088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:38 volumio sudo[1088]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:38 volumio sudo[1088]: pam_unix(sudo:session): session closed for user root May 26 12:14:39 volumio wireless.js[624]: trying... May 26 12:14:39 volumio sudo[1094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:39 volumio sudo[1094]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:39 volumio sudo[1094]: pam_unix(sudo:session): session closed for user root May 26 12:14:40 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. May 26 12:14:40 volumio systemd[1]: Started Daily apt upgrade and clean activities. May 26 12:14:40 volumio wireless.js[624]: trying... May 26 12:14:40 volumio sudo[1127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:40 volumio sudo[1127]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:40 volumio sudo[1127]: pam_unix(sudo:session): session closed for user root May 26 12:14:40 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:14:41 volumio wireless.js[624]: trying... May 26 12:14:41 volumio sudo[1130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:41 volumio sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:41 volumio sudo[1130]: pam_unix(sudo:session): session closed for user root May 26 12:14:42 volumio wireless.js[624]: trying... May 26 12:14:42 volumio volumio-remote-updater[633]: [2025-05-26 12:14:42] [info] asio async_connect error: system:111 (Connection refused) May 26 12:14:42 volumio volumio-remote-updater[633]: [2025-05-26 12:14:42] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 26 12:14:42 volumio volumio-remote-updater[633]: [2025-05-26 12:14:42] [error] handle_connect error: Underlying Transport Error May 26 12:14:42 volumio sudo[1133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:42 volumio sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:42 volumio sudo[1133]: pam_unix(sudo:session): session closed for user root May 26 12:14:43 volumio wireless.js[624]: trying... May 26 12:14:43 volumio sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:43 volumio sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:43 volumio sudo[1136]: pam_unix(sudo:session): session closed for user root May 26 12:14:44 volumio wireless.js[624]: trying... May 26 12:14:44 volumio sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:44 volumio sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:44 volumio sudo[1139]: pam_unix(sudo:session): session closed for user root May 26 12:14:45 volumio wireless.js[624]: trying... May 26 12:14:45 volumio sudo[1142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:45 volumio sudo[1142]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:45 volumio sudo[1142]: pam_unix(sudo:session): session closed for user root May 26 12:14:46 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:14:46 volumio wireless.js[624]: trying... May 26 12:14:46 volumio sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:46 volumio sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:46 volumio sudo[1145]: pam_unix(sudo:session): session closed for user root May 26 12:14:47 volumio wireless.js[624]: trying... May 26 12:14:47 volumio sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:47 volumio sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:47 volumio sudo[1148]: pam_unix(sudo:session): session closed for user root May 26 12:14:48 volumio systemd[1]: systemd-fsckd.service: Succeeded. May 26 12:14:48 volumio wireless.js[624]: trying... May 26 12:14:48 volumio sudo[1151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 26 12:14:48 volumio sudo[1151]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:14:48 volumio sudo[1151]: pam_unix(sudo:session): session closed for user root May 26 12:14:49 volumio wireless.js[624]: Overtime, starting plan B May 26 12:14:50 volumio systemd[1]: Started Wireless Services. May 26 12:14:50 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 26 12:14:50 volumio systemd[1]: Started Volumio Backend Module. May 26 12:14:50 volumio systemd[1]: Started Volumio Cpu Tweaker. May 26 12:14:50 volumio systemd[1]: Reached target Multi-User System. May 26 12:14:50 volumio systemd[1]: Reached target Graphical Interface. May 26 12:14:50 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 26 12:14:50 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 26 12:14:50 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 26 12:14:50 volumio systemd[1]: Startup finished in 19.795s (kernel) + 39.594s (userspace) = 59.390s. May 26 12:14:50 volumio volumio-cpu-tweak[1157]: Setting RT Priority for mpd May 26 12:14:50 volumio volumio-cpu-tweak[1157]: Setting MPD Affinity May 26 12:14:50 volumio volumio-cpu-tweak[1157]: pid 804's current affinity mask: f May 26 12:14:50 volumio volumio-cpu-tweak[1157]: pid 804's new affinity mask: 3 May 26 12:14:50 volumio volumio-cpu-tweak[1157]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 26 12:14:50 volumio volumio-cpu-tweak[1157]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 26 12:14:50 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. May 26 12:14:52 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:14:52 volumio volumio-remote-updater[633]: [2025-05-26 12:14:52] [info] asio async_connect error: system:111 (Connection refused) May 26 12:14:52 volumio volumio-remote-updater[633]: [2025-05-26 12:14:52] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 26 12:14:52 volumio volumio-remote-updater[633]: [2025-05-26 12:14:52] [error] handle_connect error: Underlying Transport Error May 26 12:14:54 volumio systemd[1]: systemd-hostnamed.service: Succeeded. May 26 12:14:57 volumio volumio[1156]: info: ------------------------------------------- May 26 12:14:57 volumio volumio[1156]: info: ----- Volumio3 ---- May 26 12:14:57 volumio volumio[1156]: info: ------------------------------------------- May 26 12:14:57 volumio volumio[1156]: info: ----- System startup ---- May 26 12:14:57 volumio volumio[1156]: info: ------------------------------------------- May 26 12:14:57 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:14:59 volumio volumio[1156]: info: MYVOLUMIO Environment detected May 26 12:15:00 volumio volumio[1156]: info: Plugin folders cleanup May 26 12:15:00 volumio volumio[1156]: info: Scanning into folder /volumio/app/plugins/ May 26 12:15:00 volumio volumio[1156]: info: Scanning category audio_interface May 26 12:15:00 volumio volumio[1156]: info: Scanning category miscellanea May 26 12:15:00 volumio volumio[1156]: info: Scanning category music_service May 26 12:15:00 volumio volumio[1156]: info: Scanning category plugins.json May 26 12:15:00 volumio volumio[1156]: info: Scanning category system_controller May 26 12:15:00 volumio volumio[1156]: info: Scanning category user_interface May 26 12:15:00 volumio volumio[1156]: info: Scanning into folder /data/plugins/ May 26 12:15:00 volumio volumio[1156]: info: Plugin folders cleanup completed May 26 12:15:00 volumio volumio[1156]: info: ------------------------------------------- May 26 12:15:00 volumio volumio[1156]: info: ----- Core plugins startup ---- May 26 12:15:00 volumio volumio[1156]: info: ------------------------------------------- May 26 12:15:00 volumio volumio[1156]: info: Loading plugins from folder /volumio/app/plugins/ May 26 12:15:00 volumio volumio[1156]: info: Adding plugin upnp to MyMusic Plugins May 26 12:15:00 volumio volumio[1156]: info: Adding plugin airplay_emulation to MyMusic Plugins May 26 12:15:00 volumio volumio[1156]: info: Adding plugin upnp_browser to MyMusic Plugins May 26 12:15:00 volumio volumio[1156]: info: Loading plugins from folder /data/plugins/ May 26 12:15:00 volumio volumio[1156]: info: Loading plugin "system"... May 26 12:15:00 volumio volumio[1156]: info: Loading plugin "appearance"... May 26 12:15:02 volumio systemd[1]: systemd-timedated.service: Succeeded. May 26 12:15:02 volumio volumio-remote-updater[633]: [2025-05-26 12:15:02] [connect] Successful connection May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "network"... May 26 12:15:03 volumio volumio[1156]: info: Refreshing Cached IP Addresses May 26 12:15:03 volumio sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 12:15:03 volumio sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:03 volumio sudo[1200]: pam_unix(sudo:session): session closed for user root May 26 12:15:03 volumio sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 12:15:03 volumio sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:03 volumio sudo[1202]: pam_unix(sudo:session): session closed for user root May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "services"... May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "alsa_controller"... May 26 12:15:03 volumio sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 26 12:15:03 volumio sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:03 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:15:03 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "wizard"... May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "networkfs"... May 26 12:15:03 volumio volumio[1156]: info: Starting Udev Watcher for removable devices May 26 12:15:03 volumio sudo[1228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.145/音乐1 /mnt/NAS/音乐1 May 26 12:15:03 volumio sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:03 volumio volumio[1156]: info: Ignoring mount for partition: boot May 26 12:15:03 volumio volumio[1156]: info: Ignoring mount for partition: volumio May 26 12:15:03 volumio volumio[1156]: info: Ignoring mount for partition: volumio_data May 26 12:15:03 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "volumio_command_line_client"... May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "upnp"... May 26 12:15:03 volumio volumio[1156]: info: [1748232903945] Starting Upmpd Daemon May 26 12:15:03 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "my_music"... May 26 12:15:03 volumio volumio[1156]: info: Loading plugin "mpd"... May 26 12:15:04 volumio sudo[1211]: pam_unix(sudo:session): session closed for user root May 26 12:15:04 volumio kernel: Key type cifs.spnego registered May 26 12:15:04 volumio kernel: Key type cifs.idmap registered May 26 12:15:04 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. May 26 12:15:04 volumio kernel: CIFS: Attempting to mount //192.168.3.145/音乐1 May 26 12:15:04 volumio volumio[1156]: info: Loading plugin "upnp_browser"... May 26 12:15:06 volumio volumio[1156]: info: Loading plugin "alarm-clock"... May 26 12:15:06 volumio volumio[1156]: info: Loading plugin "airplay_emulation"... May 26 12:15:06 volumio volumio[1156]: info: Starting Shairport Sync May 26 12:15:06 volumio volumio[1156]: info: Loading plugin "last_100"... May 26 12:15:06 volumio volumio[1156]: info: Loading plugin "webradio"... May 26 12:15:07 volumio volumio[1156]: info: Loading plugin "i2s_dacs"... May 26 12:15:07 volumio volumio[1156]: info: I2S DAC not set, start Auto-detection May 26 12:15:07 volumio volumio[1156]: info: Loading plugin "volumiodiscovery"... May 26 12:15:07 volumio volumio[1156]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 26 12:15:07 volumio volumio[1156]: *** WARNING *** Please fix your application to use the native API of Avahi! May 26 12:15:07 volumio volumio[1156]: *** WARNING *** For more information see May 26 12:15:07 volumio volumio[1156]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 26 12:15:07 volumio volumio[1156]: *** WARNING *** Please fix your application to use the native API of Avahi! May 26 12:15:07 volumio volumio[1156]: *** WARNING *** For more information see May 26 12:15:07 volumio node[1156]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 26 12:15:07 volumio node[1156]: *** WARNING *** Please fix your application to use the native API of Avahi! May 26 12:15:07 volumio node[1156]: *** WARNING *** For more information see May 26 12:15:07 volumio node[1156]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 26 12:15:07 volumio node[1156]: *** WARNING *** Please fix your application to use the native API of Avahi! May 26 12:15:07 volumio node[1156]: *** WARNING *** For more information see May 26 12:15:07 volumio volumio[1156]: info: Applying required configuration parameters for plugin volumiodiscovery May 26 12:15:07 volumio volumio[1156]: info: Discovery: Started advertising with name: Volumio May 26 12:15:07 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 26 12:15:07 volumio volumio[1156]: info: Loading plugin "outputs"... May 26 12:15:07 volumio volumio[1156]: info: Loading plugin "albumart"... May 26 12:15:07 volumio volumio[1156]: info: Plugin example_plugin is not enabled May 26 12:15:07 volumio volumio[1156]: info: Loading plugin "inputs"... May 26 12:15:07 volumio volumio[1156]: info: Loading plugin "updater_comm"... May 26 12:15:07 volumio volumio[1156]: info: Plugin mpdemulation is not enabled May 26 12:15:07 volumio volumio[1156]: info: Loading plugin "rest_api"... May 26 12:15:07 volumio volumio[1156]: info: Loading plugin "websocket"... May 26 12:15:08 volumio volumio[1156]: info: Starting Socket.io Server version 2.3.0 May 26 12:15:08 volumio volumio[1156]: info: Loading i18n strings for locale zh May 26 12:15:08 volumio volumio[1156]: Updating browse sources language May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 12:15:08 volumio volumio[1156]: Forking 3 albumart workers May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::initPlayerControls May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:08 volumio volumio[1156]: Express server listening on port 3000 May 26 12:15:08 volumio volumio[1156]: [Metrics] WebUI: 12s 855.97ms May 26 12:15:08 volumio volumio[1156]: info: CoreStateMachine::resetVolumioState May 26 12:15:08 volumio volumio[1156]: info: CoreStateMachine::getcurrentVolume May 26 12:15:08 volumio volumio[1156]: info: CoreCommandRouter::volumioRetrievevolume May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:09 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:15:09 volumio volumio[1156]: info: Volumio Network Manager: Network status updated: 1 May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 12:15:09 volumio volumio[1156]: info: Discovery: Getting this device information May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:09 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 12:15:09 volumio volumio[1156]: info: Reloading queue from file May 26 12:15:09 volumio volumio[1156]: info: VolumeController:: Volume=86 Mute =false May 26 12:15:09 volumio volumio[1156]: info: CoreStateMachine::pushState May 26 12:15:09 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::volumioPushState May 26 12:15:09 volumio volumio[1156]: info: CoreStateMachine::updateTrackBlock May 26 12:15:09 volumio volumio[1156]: info: CorePlayQueue::getTrackBlock May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::volumioRetrievevolume May 26 12:15:09 volumio volumio[1156]: info: CoreStateMachine::setRepeat null single undefined May 26 12:15:09 volumio volumio[1156]: info: CoreStateMachine::pushState May 26 12:15:09 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::volumioPushState May 26 12:15:09 volumio volumio[1156]: info: CoreStateMachine::setRandom null May 26 12:15:09 volumio volumio[1156]: info: CoreStateMachine::pushState May 26 12:15:09 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:09 volumio volumio[1156]: info: CoreCommandRouter::volumioPushState May 26 12:15:09 volumio volumio[1156]: info: Setting Device type: Raspberry PI May 26 12:15:09 volumio volumio[1156]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 26 12:15:09 volumio volumio[1156]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 May 26 12:15:09 volumio volumio[1156]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 26 12:15:09 volumio volumio[1156]: verbose: New Socket.io Connection to 192.168.3.158 from 192.168.3.111 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 1 May 26 12:15:09 volumio volumio[1156]: Starting albumart workers May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:10 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 12:15:10 volumio volumio[1156]: info: VolumeController:: Volume=86 Mute =false May 26 12:15:10 volumio volumio[1156]: info: CoreStateMachine::pushState May 26 12:15:10 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:10 volumio volumio[1156]: Starting albumart workers May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::volumioPushState May 26 12:15:10 volumio volumio[1156]: Starting albumart workers May 26 12:15:10 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 26 12:15:10 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 26 12:15:10 volumio sudo[1228]: pam_unix(sudo:session): session closed for user root May 26 12:15:10 volumio volumio[1156]: info: Cannot mount NAS 音乐1 at system boot, trial number 1 ,retrying in 5 seconds May 26 12:15:10 volumio volumio[1156]: info: Completed loading Core Plugins May 26 12:15:10 volumio volumio[1156]: info: Preparing to generate the ALSA configuration file May 26 12:15:10 volumio volumio[1156]: info: Asound.conf file unchanged, so no further update is needed May 26 12:15:10 volumio volumio[1156]: info: Output device has changed, restarting MPD May 26 12:15:10 volumio volumio[1156]: info: Output device has changed, restarting Shairport Sync May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:10 volumio sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 26 12:15:10 volumio sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:10 volumio sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 26 12:15:10 volumio sudo[1289]: pam_unix(sudo:session): session closed for user root May 26 12:15:10 volumio sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:10 volumio volumio[1156]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 12:15:10 volumio volumio[1156]: info: ___________ START PLUGINS ___________ May 26 12:15:10 volumio volumio[1156]: info: ControllerMpd::onStart: Initializing MPD May 26 12:15:10 volumio volumio[1156]: info: Creating MPD Configuration file May 26 12:15:10 volumio systemd[1]: Stopping Music Player Daemon... May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 26 12:15:10 volumio volumio[1156]: info: [1748232910954] CoreMusicLibrary::Adding element 媒体服务器 May 26 12:15:10 volumio sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 26 12:15:10 volumio sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:10 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 12:15:10 volumio sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 26 12:15:11 volumio sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:11 volumio sudo[1298]: pam_unix(sudo:session): session closed for user root May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:11 volumio systemd[1]: mpd.service: Succeeded. May 26 12:15:11 volumio systemd[1]: Stopped Music Player Daemon. May 26 12:15:11 volumio volumio[1156]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:11 volumio systemd[1]: Starting Music Player Daemon... May 26 12:15:11 volumio volumio[1156]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 26 12:15:11 volumio volumio[1156]: info: [1748232911471] CoreMusicLibrary::Adding element Last_100 May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 26 12:15:11 volumio volumio[1156]: info: [1748232911482] CoreMusicLibrary::Adding element Webradio May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 12:15:11 volumio volumio[1156]: info: Initializing BBC Radios May 26 12:15:11 volumio sudo[1306]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 26 12:15:11 volumio sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:11 volumio sudo[1306]: pam_unix(sudo:session): session closed for user root May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 12:15:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:11 volumio volumio[1156]: info: Volumio Calling Home May 26 12:15:12 volumio volumio[1156]: info: Discovery: adding fb7eeb56-4e5c-4504-b0d9-c67d2160178e May 26 12:15:12 volumio volumio[1156]: info: Discovery: Found device Volumio May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:12 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:12 volumio volumio[1156]: info: MPD Permissions set May 26 12:15:12 volumio volumio[1156]: info: MPD Permissions set May 26 12:15:12 volumio volumio[1156]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 12:15:12 volumio volumio[1156]: info: Starting Shairport Sync May 26 12:15:12 volumio volumio[1156]: info: Starting Shairport Sync May 26 12:15:12 volumio volumio[1156]: info: Starting Shairport Sync May 26 12:15:12 volumio sudo[1358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 12:15:12 volumio sudo[1358]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:12 volumio sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 12:15:12 volumio sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:12 volumio sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 12:15:12 volumio sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:12 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:12 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 26 12:15:12 volumio systemd[1]: shairport-sync.service: Succeeded. May 26 12:15:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 26 12:15:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 26 12:15:12 volumio sudo[1358]: pam_unix(sudo:session): session closed for user root May 26 12:15:12 volumio sudo[1360]: pam_unix(sudo:session): session closed for user root May 26 12:15:12 volumio volumio[1156]: info: Volumio called home May 26 12:15:12 volumio sudo[1363]: pam_unix(sudo:session): session closed for user root May 26 12:15:12 volumio volumio[1156]: info: Shairport-Sync Started May 26 12:15:12 volumio volumio[1156]: Error adding Membership: Error: addMembership EINVAL May 26 12:15:12 volumio volumio[1156]: info: Shairport-Sync Started May 26 12:15:12 volumio volumio[1156]: info: Shairport-Sync Started May 26 12:15:14 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 12:15:14 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:14 volumio sudo[1385]: pam_unix(sudo:session): session closed for user root May 26 12:15:14 volumio sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 12:15:14 volumio sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:14 volumio sudo[1387]: pam_unix(sudo:session): session closed for user root May 26 12:15:14 volumio sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 26 12:15:14 volumio sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:14 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 26 12:15:14 volumio sudo[1391]: pam_unix(sudo:session): session closed for user root May 26 12:15:14 volumio volumio[1156]: info: Upmpdcli Daemon Started May 26 12:15:14 volumio mpd[1341]: May 26 12:15 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 26 12:15:14 volumio systemd[1]: Started Music Player Daemon. May 26 12:15:14 volumio sudo[1291]: pam_unix(sudo:session): session closed for user root May 26 12:15:14 volumio sudo[1300]: pam_unix(sudo:session): session closed for user root May 26 12:15:14 volumio volumio[1156]: info: Completed starting Core Plugins May 26 12:15:14 volumio volumio[1156]: info: ------------------------------------------- May 26 12:15:14 volumio volumio[1156]: info: ----- MyVolumio plugins startup ---- May 26 12:15:14 volumio volumio[1156]: info: ------------------------------------------- May 26 12:15:14 volumio volumio[1156]: info: [MyVolumio PluginManager] Fetching plans data.... May 26 12:15:14 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:15:14 volumio volumio[1156]: error: MPD error: The expression evaluated to a falsy value: May 26 12:15:14 volumio volumio[1156]: assert.ok(self.idling) May 26 12:15:14 volumio volumio[1156]: error: The expression evaluated to a falsy value: May 26 12:15:14 volumio volumio[1156]: assert.ok(self.idling) May 26 12:15:14 volumio volumio[1156]: info: MPD running with PID1341 May 26 12:15:14 volumio volumio[1156]: ,establishing connection May 26 12:15:14 volumio volumio[1156]: error: updateQueue error: null May 26 12:15:14 volumio volumio[1156]: error: updateQueue error: null May 26 12:15:14 volumio volumio[1393]: Generating RSA private key, 4096 bit long modulus (2 primes) May 26 12:15:15 volumio sudo[1414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.145/音乐1 /mnt/NAS/音乐1 May 26 12:15:15 volumio sudo[1414]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:15 volumio kernel: CIFS: Attempting to mount //192.168.3.145/音乐1 May 26 12:15:16 volumio sudo[1419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 12:15:16 volumio sudo[1419]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:16 volumio sudo[1419]: pam_unix(sudo:session): session closed for user root May 26 12:15:16 volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 12:15:16 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:16 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root May 26 12:15:16 volumio volumio[1156]: verbose: New Socket.io Connection to 192.168.3.158 from 192.168.3.111 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 3 May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::volumioGetVisibleSources May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:16 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 12:15:16 volumio volumio[1156]: info: Received Get System Info May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 12:15:16 volumio volumio[1156]: info: Discovery: Getting this device information May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:16 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:16 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:16 volumio volumio[1156]: info: Listing playlists May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 12:15:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 12:15:17 volumio volumio-remote-updater[633]: [2025-05-26 12:15:17] [connect] Successful connection May 26 12:15:17 volumio volumio-remote-updater[633]: [2025-05-26 12:15:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748232917 101 May 26 12:15:17 volumio volumio[1156]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 May 26 12:15:18 volumio volumio[1393]: ..........++++ May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 12:15:18 volumio volumio[1156]: info: Received Get System Info May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 12:15:18 volumio volumio[1156]: info: Discovery: Getting this device information May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:18 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 12:15:18 volumio volumio[1156]: info: Discovery: Getting this device information May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState May 26 12:15:18 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 May 26 12:15:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 12:15:19 volumio volumio[1156]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 26 12:15:20 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:15:21 volumio sudo[1414]: pam_unix(sudo:session): session closed for user root May 26 12:15:21 volumio volumio[1156]: info: Cannot mount NAS 音乐1 at system boot, trial number 2 ,retrying in 5 seconds May 26 12:15:21 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 26 12:15:21 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 26 12:15:24 volumio volumio[1156]: info: Adding plugin bluetooth to MyMusic Plugins May 26 12:15:24 volumio volumio[1156]: info: Adding plugin multiroom to MyMusic Plugins May 26 12:15:24 volumio volumio[1156]: info: Adding plugin metavolumio to MyMusic Plugins May 26 12:15:24 volumio volumio[1156]: info: Adding plugin cd_controller to MyMusic Plugins May 26 12:15:24 volumio volumio[1156]: info: Adding plugin smart_inputs to MyMusic Plugins May 26 12:15:24 volumio volumio[1156]: info: Adding plugin tidalconnect to MyMusic Plugins May 26 12:15:24 volumio volumio[1156]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 26 12:15:25 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:15:26 volumio volumio[1156]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 26 12:15:26 volumio volumio[1156]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 26 12:15:26 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:26 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:26 volumio volumio[1156]: info: Starting MyVolumio Remote Streaming Endpoints May 26 12:15:26 volumio volumio[1156]: info: MyVolumio not started May 26 12:15:26 volumio volumio[1156]: info: Initializing device activation check May 26 12:15:26 volumio volumio[1156]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 26 12:15:26 volumio volumio[1156]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 26 12:15:29 volumio ntpd[780]: Soliciting pool server 193.182.111.14 May 26 12:15:29 volumio volumio[1156]: info: Starting Streaming Service Transparent Proxy May 26 12:15:29 volumio volumio[1156]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 26 12:15:29 volumio volumio[1156]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 26 12:15:29 volumio volumio[1156]: info: Streaming services startup May 26 12:15:29 volumio volumio[1156]: info: Starting Streaming Daemon May 26 12:15:29 volumio sudo[1486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 26 12:15:29 volumio sudo[1486]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:29 volumio volumio[1156]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 26 12:15:29 volumio sudo[1486]: pam_unix(sudo:session): session closed for user root May 26 12:15:30 volumio sudo[1494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.145/音乐1 /mnt/NAS/音乐1 May 26 12:15:30 volumio sudo[1494]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 12:15:30 volumio kernel: CIFS: Attempting to mount //192.168.3.145/音乐1 May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 26 12:15:30 volumio volumio[1156]: error: Cannot start Volumio Streaming Daemon May 26 12:15:30 volumio volumio[1156]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 26 12:15:30 volumio volumio[1156]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 26 12:15:30 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 26 12:15:31 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:15:31 volumio ntpd[780]: Soliciting pool server 193.182.111.141 May 26 12:15:32 volumio volumio[1156]: STREAMING PROXY: Starting server on port 3245 May 26 12:15:32 volumio volumio[1156]: Node JS runtime: 14 May 26 12:15:32 volumio ntpd[780]: Soliciting pool server 211.68.71.26 May 26 12:15:32 volumio ntpd[780]: Soliciting pool server 193.182.111.12 May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 12:15:33 volumio volumio[1156]: info: Retrieving Cloud Streaming UI May 26 12:15:33 volumio volumio[1156]: info: Getting Tidal Cloud Configuration May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 12:15:33 volumio volumio[1156]: info: Getting Qobuz Cloud Configuration May 26 12:15:33 volumio volumio[1156]: info: Asking plugin for UI Config May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 12:15:33 volumio volumio[1156]: info: Getting Spotify Cloud Configuration May 26 12:15:33 volumio volumio[1156]: info: Asking plugin for UI Config May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 12:15:33 volumio volumio[1156]: info: Saving Spotify Acccount May 26 12:15:33 volumio volumio[1156]: info: Got Tidal Cloud Configuration May 26 12:15:33 volumio volumio[1156]: info: Got it May 26 12:15:33 volumio volumio[1156]: info: Got it May 26 12:15:33 volumio volumio[1156]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 12:15:33 volumio volumio[1156]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::volumioGetBrowseSources May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::volumioGetBrowseSources May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::volumioGetBrowseSources May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 12:15:33 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 26 12:15:33 volumio ntpd[780]: Soliciting pool server 202.118.1.81 May 26 12:15:33 volumio ntpd[780]: Soliciting pool server 84.16.67.12 May 26 12:15:33 volumio ntpd[780]: Soliciting pool server 162.159.200.1 May 26 12:15:34 volumio ntpd[780]: Soliciting pool server 162.159.200.123 May 26 12:15:34 volumio ntpd[780]: Soliciting pool server 108.59.2.24 May 26 12:15:34 volumio ntpd[780]: Soliciting pool server 108.59.2.24 May 26 12:15:35 volumio ntpd[780]: Soliciting pool server 119.28.206.193 May 26 12:15:35 volumio ntpd[780]: Soliciting pool server 116.203.151.74 May 26 12:15:36 volumio sudo[1494]: pam_unix(sudo:session): session closed for user root May 26 12:15:36 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 26 12:15:36 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 26 12:15:36 volumio volumio[1156]: info: Cannot mount NAS 音乐1 at system boot, trial number 3 ,retrying in 5 seconds May 26 12:15:36 volumio ntpd[780]: Soliciting pool server 240e:982:27b:9500:dd8d:c509:b2e3:9ffa May 26 12:15:36 volumio ntpd[780]: Soliciting pool server 193.182.111.143 May 26 12:15:37 volumio wpa_supplicant[923]: wlan0: Failed to initiate sched scan May 26 12:15:37 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 12:15:37 volumio ntpd[780]: Soliciting pool server 193.182.111.14 May 26 12:15:38 volumio ntpd[780]: Soliciting pool server 139.199.214.202 May 26 12:15:39 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 26 12:15:41 volumio ntpd[780]: receive: Unexpected origin timestamp 0xebde696b.9837ea5c does not match aorg 0000000000.00000000 from server@193.182.111.14 xmt 0xebde696d.310c1dfd May 26 12:15:41 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 26 12:15:42 volumio volumio[1156]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 12:15:42 volumio volumio[1156]: TypeError: Cannot read property 'replace' of undefined May 26 12:15:42 volumio volumio[1156]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) May 26 12:15:42 volumio volumio[1156]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) May 26 12:15:42 volumio volumio[1156]: at listOnTimeout (internal/timers.js:554:17) May 26 12:15:42 volumio volumio[1156]: at processTimers (internal/timers.js:497:7) May 26 12:15:42 volumio volumio[1156]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 12:15:43 volumio sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-26 12:14 May 26 12:15:43 volumio sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"