-- Logs begin at Sun 2024-10-20 02:24:12 UTC, end at Sun 2024-10-20 02:26:55 UTC. -- Oct 20 02:25:09 volumio systemd[1]: Time has been changed Oct 20 02:25:10 volumio bluetoothd[892]: Bluetooth daemon 5.23 Oct 20 02:25:10 volumio bluetoothd[892]: Starting SDP server Oct 20 02:25:10 volumio bluetoothd[892]: Excluding (cli) sap Oct 20 02:25:10 volumio systemd[1]: Started Bluetooth service. Oct 20 02:25:10 volumio systemd[1]: Starting Bluetooth. Oct 20 02:25:10 volumio systemd[1]: Reached target Bluetooth. Oct 20 02:25:10 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Oct 20 02:25:10 volumio kernel: Bluetooth: BNEP filters: protocol multicast Oct 20 02:25:10 volumio kernel: Bluetooth: BNEP socket layer initialized Oct 20 02:25:10 volumio dbus[729]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Oct 20 02:25:10 volumio bluetoothd[892]: Bluetooth management interface 1.14 initialized Oct 20 02:25:10 volumio systemd[1]: Starting Hostname Service... Oct 20 02:25:10 volumio volumio[701]: Could not open config: /tmp/upmpdcli.conf Oct 20 02:25:10 volumio systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Oct 20 02:25:10 volumio systemd[1]: Unit upmpdcli.service entered failed state. Oct 20 02:25:10 volumio systemd-hostnamed[895]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Oct 20 02:25:10 volumio dbus[729]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 20 02:25:10 volumio systemd[1]: Started Hostname Service. Oct 20 02:25:13 volumio volumio-remote-updater[702]: [2024-10-20 02:25:13] [info] asio async_connect error: system:111 (Connection refused) Oct 20 02:25:13 volumio volumio-remote-updater[702]: [2024-10-20 02:25:13] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 20 02:25:13 volumio volumio-remote-updater[702]: [2024-10-20 02:25:13] [error] handle_connect error: Underlying Transport Error Oct 20 02:25:20 volumio wireless.js[873]: Cleaning previous... Oct 20 02:25:20 volumio systemd[1]: Stopped hotspot.service. Oct 20 02:25:20 volumio sudo[915]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 20 02:25:20 volumio sudo[915]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:20 volumio sudo[915]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:20 volumio sudo[923]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 20 02:25:20 volumio sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:21 volumio sudo[923]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:21 volumio volumio-remote-updater[702]: [2024-10-20 02:25:21] [info] asio async_connect error: system:111 (Connection refused) Oct 20 02:25:21 volumio volumio-remote-updater[702]: [2024-10-20 02:25:21] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 20 02:25:21 volumio volumio-remote-updater[702]: [2024-10-20 02:25:21] [error] handle_connect error: Underlying Transport Error Oct 20 02:25:21 volumio wireless.js[873]: Stopped aP Oct 20 02:25:21 volumio wireless.js[873]: Wireless Networking DISABLED, not starting wireless flow Oct 20 02:25:21 volumio systemd[1]: Started Wireless Services. Oct 20 02:25:21 volumio systemd[1]: Starting Volumio Backend Module... Oct 20 02:25:21 volumio systemd[1]: Started Volumio Backend Module. Oct 20 02:25:21 volumio systemd[1]: Starting Volumio Streaming Daemon... Oct 20 02:25:21 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 20 02:25:22 volumio systemd[1]: Started Music Player Daemon. Oct 20 02:25:22 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. Oct 20 02:25:22 volumio kernel: Voltage normalised (0x00000000) Oct 20 02:25:23 volumio nmbd[713]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Oct 20 02:25:23 volumio nmbd[713]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 20 02:25:23 volumio nmbd[713]: Unable to setup corepath for nmbd: No such file or directory Oct 20 02:25:23 volumio nmbd[962]: [2024/10/20 02:25:23.233117, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio nmbd[962]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 20 02:25:23 volumio nmbd[713]: [2024/10/20 02:25:23, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio nmbd[713]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 20 02:25:23 volumio nmbd[713]: [2024/10/20 02:25:23, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio nmbd[713]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 20 02:25:23 volumio nmbd[713]: [2024/10/20 02:25:23, 0] ../source3/nmbd/nmbd.c:908(main) Oct 20 02:25:23 volumio nmbd[713]: nmbd version 4.2.14-Debian started. Oct 20 02:25:23 volumio nmbd[713]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 20 02:25:23 volumio nmbd[713]: [2024/10/20 02:25:23.233117, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio nmbd[713]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 20 02:25:23 volumio nmbd[962]: [2024/10/20 02:25:23.253728, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio nmbd[962]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 20 02:25:23 volumio nmbd[963]: [2024/10/20 02:25:23.257226, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Oct 20 02:25:23 volumio nmbd[963]: started asyncdns process 964 Oct 20 02:25:23 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Oct 20 02:25:23 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Oct 20 02:25:23 volumio nmbd[713]: [2024/10/20 02:25:23.253728, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio nmbd[713]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 20 02:25:23 volumio nmbd[713]: . Oct 20 02:25:23 volumio nmbd[963]: [2024/10/20 02:25:23.299213, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 20 02:25:23 volumio nmbd[963]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 20 02:25:23 volumio winbind[708]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Oct 20 02:25:23 volumio winbind[708]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 20 02:25:23 volumio winbind[708]: Unable to setup corepath for winbindd: No such file or directory Oct 20 02:25:23 volumio winbind[708]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 20 02:25:23 volumio winbind[708]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 20 02:25:23 volumio winbind[708]: Unable to setup corepath for winbindd: No such file or directory Oct 20 02:25:23 volumio winbind[708]: [2024/10/20 02:25:23, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio winbind[708]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 20 02:25:23 volumio winbind[708]: [2024/10/20 02:25:23, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio winbind[708]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 20 02:25:23 volumio winbind[708]: [2024/10/20 02:25:23, 0] ../source3/winbindd/winbindd.c:1549(main) Oct 20 02:25:23 volumio winbind[708]: winbindd version 4.2.14-Debian started. Oct 20 02:25:23 volumio winbind[708]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 20 02:25:23 volumio winbind[708]: [2024/10/20 02:25:23, 0] ../lib/util/util.c:220(directory_create_or_exist) Oct 20 02:25:23 volumio winbind[708]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 20 02:25:23 volumio winbind[708]: [2024/10/20 02:25:23, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Oct 20 02:25:23 volumio winbind[708]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 20 02:25:23 volumio winbind[708]: [2024/10/20 02:25:23, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Oct 20 02:25:23 volumio winbind[708]: Unable to setup corepath for winbindd: No such file or directory Oct 20 02:25:23 volumio winbindd[959]: [2024/10/20 02:25:23.505729, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio winbind[708]: [2024/10/20 02:25:23.505729, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio winbindd[959]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 20 02:25:23 volumio winbindd[959]: [2024/10/20 02:25:23.509137, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio winbindd[959]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 20 02:25:23 volumio winbind[708]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 20 02:25:23 volumio winbind[708]: [2024/10/20 02:25:23.509137, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio winbind[708]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 20 02:25:23 volumio winbindd[974]: [2024/10/20 02:25:23.622088, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Oct 20 02:25:23 volumio winbindd[974]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 20 02:25:23 volumio winbind[708]: . Oct 20 02:25:23 volumio systemd[1]: Started LSB: start Winbind daemon. Oct 20 02:25:23 volumio winbindd[974]: [2024/10/20 02:25:23.878267, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 20 02:25:23 volumio winbindd[974]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 20 02:25:23 volumio winbindd[975]: [2024/10/20 02:25:23.883179, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:23 volumio winbindd[975]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 20 02:25:23 volumio volumio-streaming-daemon[941]: ############################ Oct 20 02:25:23 volumio volumio-streaming-daemon[941]: # Volumio Streaming Daemon # Oct 20 02:25:23 volumio volumio-streaming-daemon[941]: # Running on port 7777 # Oct 20 02:25:23 volumio volumio-streaming-daemon[941]: ############################ Oct 20 02:25:23 volumio volumio-streaming-daemon[941]: Environment: production Oct 20 02:25:24 volumio smbd[965]: Starting SMB/CIFS daemon: smbd[2024/10/20 02:25:24, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[965]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:24 volumio smbd[965]: [2024/10/20 02:25:24, 0] ../lib/util/util.c:220(directory_create_or_exist) Oct 20 02:25:24 volumio smbd[965]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 20 02:25:24 volumio smbd[965]: [2024/10/20 02:25:24, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Oct 20 02:25:24 volumio smbd[965]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 20 02:25:24 volumio smbd[965]: [2024/10/20 02:25:24, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Oct 20 02:25:24 volumio smbd[965]: Unable to setup corepath for smbd: No such file or directory Oct 20 02:25:24 volumio smbd[965]: [2024/10/20 02:25:24, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[965]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:24 volumio smbd[965]: [2024/10/20 02:25:24, 0] ../source3/smbd/server.c:1241(main) Oct 20 02:25:24 volumio smbd[965]: smbd version 4.2.14-Debian started. Oct 20 02:25:24 volumio smbd[965]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 20 02:25:24 volumio smbd[977]: [2024/10/20 02:25:24.461263, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[977]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:24 volumio smbd[977]: [2024/10/20 02:25:24.462609, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[977]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:24 volumio smbd[977]: [2024/10/20 02:25:24.462747, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[977]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:24 volumio smbd[965]: [2024/10/20 02:25:24.461263, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[965]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:24 volumio smbd[965]: [2024/10/20 02:25:24.462609, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[965]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:24 volumio smbd[965]: [2024/10/20 02:25:24.462747, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[965]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:24 volumio smbd[965]: . Oct 20 02:25:24 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Oct 20 02:25:24 volumio systemd[1]: Starting Multi-User System. Oct 20 02:25:24 volumio systemd[1]: Reached target Multi-User System. Oct 20 02:25:24 volumio systemd[1]: Starting Graphical Interface. Oct 20 02:25:24 volumio systemd[1]: Reached target Graphical Interface. Oct 20 02:25:24 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 20 02:25:24 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 20 02:25:24 volumio systemd[1]: Startup finished in 10.655s (kernel) + 51.425s (userspace) = 1min 2.081s. Oct 20 02:25:24 volumio winbindd[984]: [2024/10/20 02:25:24.525090, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio winbindd[984]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Oct 20 02:25:24 volumio winbindd[985]: [2024/10/20 02:25:24.614864, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio winbindd[985]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Oct 20 02:25:24 volumio smbd[978]: [2024/10/20 02:25:24.806191, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 20 02:25:24 volumio smbd[978]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 20 02:25:24 volumio smbd[986]: [2024/10/20 02:25:24.810475, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 20 02:25:24 volumio smbd[986]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 20 02:25:27 volumio volumio[936]: info: ------------------------------------------- Oct 20 02:25:27 volumio volumio[936]: info: ----- Volumio2 ---- Oct 20 02:25:27 volumio volumio[936]: info: ------------------------------------------- Oct 20 02:25:28 volumio volumio[936]: info: ----- System startup ---- Oct 20 02:25:28 volumio volumio[936]: info: ------------------------------------------- Oct 20 02:25:29 volumio volumio[936]: info: MYVOLUMIO Environment detected Oct 20 02:25:29 volumio volumio[936]: info: Plugin folders cleanup Oct 20 02:25:29 volumio volumio[936]: info: Scanning into folder /volumio/app/plugins/ Oct 20 02:25:29 volumio volumio[936]: info: Scanning category audio_interface Oct 20 02:25:29 volumio volumio[936]: info: Scanning category miscellanea Oct 20 02:25:29 volumio volumio[936]: info: Scanning category music_service Oct 20 02:25:29 volumio volumio[936]: info: Scanning category plugins.json Oct 20 02:25:29 volumio volumio[936]: info: Scanning category system_controller Oct 20 02:25:29 volumio volumio[936]: info: Scanning category user_interface Oct 20 02:25:29 volumio volumio[936]: info: Scanning into folder /data/plugins/ Oct 20 02:25:29 volumio volumio[936]: info: Plugin folders cleanup completed Oct 20 02:25:29 volumio volumio[936]: info: ------------------------------------------- Oct 20 02:25:29 volumio volumio[936]: info: ----- Core plugins startup ---- Oct 20 02:25:29 volumio volumio[936]: info: ------------------------------------------- Oct 20 02:25:29 volumio volumio[936]: info: Loading plugins from folder /volumio/app/plugins/ Oct 20 02:25:29 volumio volumio[936]: info: Adding plugin upnp to MyMusic Plugins Oct 20 02:25:29 volumio volumio[936]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 20 02:25:29 volumio volumio[936]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 20 02:25:29 volumio volumio[936]: info: Loading plugins from folder /data/plugins/ Oct 20 02:25:29 volumio volumio[936]: info: Loading plugin "system"... Oct 20 02:25:29 volumio volumio[936]: info: Loading plugin "appearance"... Oct 20 02:25:31 volumio volumio-remote-updater[702]: [2024-10-20 02:25:31] [connect] Successful connection Oct 20 02:25:33 volumio volumio[936]: info: Loading plugin "network"... Oct 20 02:25:33 volumio volumio[936]: info: Refreshing Cached IP Addresses Oct 20 02:25:33 volumio sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 20 02:25:33 volumio volumio[936]: info: Loading plugin "services"... Oct 20 02:25:33 volumio volumio[936]: info: Loading plugin "alsa_controller"... Oct 20 02:25:33 volumio sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:33 volumio sudo[1001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 20 02:25:33 volumio sudo[999]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:33 volumio sudo[1001]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:33 volumio sudo[1001]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:33 volumio volumio[936]: Invalid card number. Oct 20 02:25:33 volumio volumio[936]: info: Hardware Mixer selected but no Hardware mixer available, detecting default mixer Oct 20 02:25:33 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 20 02:25:33 volumio volumio[936]: Invalid card number. Oct 20 02:25:33 volumio volumio[936]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 20 02:25:33 volumio volumio[936]: info: Loading plugin "wizard"... Oct 20 02:25:33 volumio volumio[936]: info: Loading plugin "volumio_command_line_client"... Oct 20 02:25:33 volumio volumio[936]: info: Loading plugin "upnp"... Oct 20 02:25:33 volumio volumio[936]: info: [1729391133770] Starting Upmpd Daemon Oct 20 02:25:33 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 20 02:25:33 volumio volumio[936]: info: Loading plugin "my_music"... Oct 20 02:25:33 volumio volumio[936]: info: Loading plugin "mpd"... Oct 20 02:25:34 volumio volumio[936]: info: Loading plugin "upnp_browser"... Oct 20 02:25:35 volumio volumio[936]: info: Loading plugin "networkfs"... Oct 20 02:25:35 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 20 02:25:35 volumio volumio[936]: info: Loading plugin "alarm-clock"... Oct 20 02:25:35 volumio sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=root,password=root,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.6.8/新加卷/ptone/OpenCD /mnt/NAS/新加卷 Oct 20 02:25:35 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:35 volumio sudo[1033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.6.165/cd备份 空间4\YINYUE /mnt/NAS/YINYUE Oct 20 02:25:35 volumio sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:36 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching Oct 20 02:25:36 volumio kernel: Key type cifs.spnego registered Oct 20 02:25:36 volumio kernel: Key type cifs.idmap registered Oct 20 02:25:36 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Oct 20 02:25:36 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Oct 20 02:25:36 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "airplay_emulation"... Oct 20 02:25:36 volumio volumio[936]: info: Starting Shairport Sync Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "last_100"... Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "webradio"... Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "i2s_dacs"... Oct 20 02:25:36 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "volumiodiscovery"... Oct 20 02:25:36 volumio volumio[936]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 20 02:25:36 volumio node[936]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 20 02:25:36 volumio node[936]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 20 02:25:36 volumio node[936]: *** WARNING *** For more information see Oct 20 02:25:36 volumio node[936]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 20 02:25:36 volumio node[936]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 20 02:25:36 volumio node[936]: *** WARNING *** For more information see Oct 20 02:25:36 volumio volumio[936]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 20 02:25:36 volumio volumio[936]: *** WARNING *** For more information see Oct 20 02:25:36 volumio volumio[936]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 20 02:25:36 volumio volumio[936]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 20 02:25:36 volumio volumio[936]: *** WARNING *** For more information see Oct 20 02:25:36 volumio volumio[936]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 20 02:25:36 volumio volumio[936]: Discovery: StartAdv! undefined Oct 20 02:25:36 volumio volumio[936]: Discovery: Started advertising... Volumio - undefined Oct 20 02:25:36 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "outputs"... Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "albumart"... Oct 20 02:25:36 volumio volumio[936]: info: Plugin example_plugin is not enabled Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "inputs"... Oct 20 02:25:36 volumio volumio[936]: info: Loading plugin "updater_comm"... Oct 20 02:25:37 volumio volumio[936]: info: Plugin mpdemulation is not enabled Oct 20 02:25:37 volumio volumio[936]: info: Loading plugin "rest_api"... Oct 20 02:25:37 volumio volumio[936]: info: Loading plugin "websocket"... Oct 20 02:25:37 volumio volumio[936]: info: ___________ START PLUGINS ___________ Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 20 02:25:37 volumio volumio[936]: info: [1729391137164] CoreMusicLibrary::Adding element Media Servers Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 20 02:25:37 volumio volumio[936]: Forking 3 albumart workers Oct 20 02:25:37 volumio volumio[936]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 20 02:25:37 volumio volumio[936]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 20 02:25:37 volumio volumio[936]: info: [1729391137305] CoreMusicLibrary::Adding element Last_100 Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 20 02:25:37 volumio volumio[936]: info: [1729391137310] CoreMusicLibrary::Adding element Webradio Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 20 02:25:37 volumio volumio[936]: info: ------------------------------------------- Oct 20 02:25:37 volumio volumio[936]: info: ----- MyVolumio plugins startup ---- Oct 20 02:25:37 volumio volumio[936]: info: ------------------------------------------- Oct 20 02:25:37 volumio volumio[936]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 20 02:25:37 volumio volumio[936]: info: Loading i18n strings for locale zh Oct 20 02:25:37 volumio volumio[936]: Updating browse sources language Oct 20 02:25:37 volumio volumio[936]: Cannot find translation for sourceMedia Servers Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::initPlayerControls Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:25:37 volumio volumio[936]: info: BOOT COMPLETED Oct 20 02:25:37 volumio volumio[936]: [Metrics] CommandRouter: 9s 563.17ms Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:25:37 volumio volumio[936]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card Oct 20 02:25:37 volumio volumio[936]: aplay: main:722: audio open error: No such file or directory Oct 20 02:25:37 volumio volumio[936]: Cannot play startup sound Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::Close All Modals sent Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::Close All Modals sent Oct 20 02:25:37 volumio volumio[936]: Express server listening on port 3000 Oct 20 02:25:37 volumio volumio[936]: [Metrics] WebUI: 10s 731.53ms Oct 20 02:25:37 volumio volumio[936]: Volumio Calling Home Oct 20 02:25:37 volumio volumio[936]: info: CoreStateMachine::resetVolumioState Oct 20 02:25:37 volumio volumio[936]: info: CoreStateMachine::getcurrentVolume Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::volumioRetrievevolume Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 20 02:25:37 volumio volumio[936]: info: CoreStateMachine::getcurrentVolume Oct 20 02:25:37 volumio volumio[936]: info: CoreCommandRouter::volumioRetrievevolume Oct 20 02:25:38 volumio volumio[936]: Starting albumart workers Oct 20 02:25:38 volumio volumio[936]: Starting albumart workers Oct 20 02:25:38 volumio volumio[936]: Starting albumart workers Oct 20 02:25:38 volumio volumio[936]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 20 02:25:38 volumio volumio[936]: info: Setting Device type: Raspberry PI Oct 20 02:25:38 volumio volumio[936]: info: MPD running with PID725 Oct 20 02:25:38 volumio volumio[936]: ,establishing connection Oct 20 02:25:38 volumio volumio[936]: info: VolumeController:: Volume=undefined Mute =false Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::pushState Oct 20 02:25:38 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::updateTrackBlock Oct 20 02:25:38 volumio volumio[936]: info: CorePlayQueue::getTrackBlock Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::volumioRetrievevolume Oct 20 02:25:38 volumio volumio[936]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 20 02:25:38 volumio volumio[936]: info: VolumeController:: Volume=undefined Mute =false Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::pushState Oct 20 02:25:38 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::updateTrackBlock Oct 20 02:25:38 volumio volumio[936]: info: CorePlayQueue::getTrackBlock Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::volumioRetrievevolume Oct 20 02:25:38 volumio volumio[936]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 20 02:25:38 volumio volumio[936]: info: Reloading queue from file Oct 20 02:25:38 volumio volumio[936]: error: updateQueue error: null Oct 20 02:25:38 volumio volumio[936]: error: Failed LSINFO: Error: [50@0] {} No such directory Oct 20 02:25:38 volumio volumio[936]: info: VolumeController:: Volume=undefined Mute =false Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::pushState Oct 20 02:25:38 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:25:38 volumio volumio[936]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::setRepeat false single undefined Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::pushState Oct 20 02:25:38 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::setRandom false Oct 20 02:25:38 volumio volumio[936]: info: CoreStateMachine::pushState Oct 20 02:25:38 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:25:38 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:25:39 volumio volumio[936]: info: VolumeController:: Volume=undefined Mute =false Oct 20 02:25:39 volumio volumio[936]: info: CoreStateMachine::pushState Oct 20 02:25:39 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:39 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:25:39 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:25:39 volumio volumio[936]: info: Starting Shairport Sync Oct 20 02:25:39 volumio volumio[936]: info: Starting Shairport Sync Oct 20 02:25:39 volumio sudo[1166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 20 02:25:39 volumio sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:39 volumio sudo[1169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 20 02:25:39 volumio sudo[1169]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:39 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 20 02:25:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 20 02:25:39 volumio sudo[1166]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 20 02:25:39 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 20 02:25:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 20 02:25:39 volumio sudo[1169]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:39 volumio volumio[936]: info: Shairport-Sync Started Oct 20 02:25:39 volumio volumio[936]: Error adding Membership: Error: addMembership EINVAL Oct 20 02:25:39 volumio volumio[936]: info: Shairport-Sync Started Oct 20 02:25:41 volumio volumio[936]: info: CoreCommandRouter::volumioGetState Oct 20 02:25:41 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:41 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:25:41 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 20 02:25:42 volumio sudo[1033]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:42 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 20 02:25:42 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 20 02:25:42 volumio volumio[936]: info: Cannot mount NAS YINYUE at system boot, trial number 1 ,retrying in 5 seconds Oct 20 02:25:43 volumio sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 20 02:25:43 volumio sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:43 volumio sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 20 02:25:43 volumio sudo[1202]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:43 volumio sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:43 volumio sudo[1204]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:43 volumio sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 20 02:25:43 volumio sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:43 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 20 02:25:43 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 20 02:25:43 volumio sudo[1214]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:43 volumio volumio[936]: info: Upmpdcli Daemon Started Oct 20 02:25:43 volumio volumio[936]: info: Volumio called home Oct 20 02:25:43 volumio volumio[936]: info: CoreCommandRouter::volumioGetState Oct 20 02:25:43 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetVisibleSources Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 20 02:25:44 volumio volumio[936]: info: Listing playlists Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetQueue Oct 20 02:25:44 volumio volumio[936]: info: CoreStateMachine::getQueue Oct 20 02:25:44 volumio volumio[936]: info: CorePlayQueue::getQueue Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetState Oct 20 02:25:44 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetVisibleSources Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 20 02:25:44 volumio volumio[936]: info: Listing playlists Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetQueue Oct 20 02:25:44 volumio volumio[936]: info: CoreStateMachine::getQueue Oct 20 02:25:44 volumio volumio[936]: info: CorePlayQueue::getQueue Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetState Oct 20 02:25:44 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetVisibleSources Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 20 02:25:44 volumio volumio[936]: info: Listing playlists Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetQueue Oct 20 02:25:44 volumio volumio[936]: info: CoreStateMachine::getQueue Oct 20 02:25:44 volumio volumio[936]: info: CorePlayQueue::getQueue Oct 20 02:25:44 volumio volumio[936]: Discovery: adding 4eb92b65-8509-44b1-99d7-d5b2b27fe7d6 Oct 20 02:25:44 volumio volumio[936]: info: mDNS: Found device Volumio Oct 20 02:25:44 volumio volumio[936]: info: CoreCommandRouter::volumioGetState Oct 20 02:25:44 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:25:46 volumio volumio-remote-updater[702]: [2024-10-20 02:25:46] [connect] Successful connection Oct 20 02:25:46 volumio volumio-remote-updater[702]: [2024-10-20 02:25:46] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1729391146 101 Oct 20 02:25:47 volumio sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.6.165/cd备份 空间4\YINYUE /mnt/NAS/YINYUE Oct 20 02:25:47 volumio sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:47 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Oct 20 02:25:53 volumio sudo[1250]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:53 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 20 02:25:53 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 20 02:25:53 volumio volumio[936]: info: Cannot mount NAS YINYUE at system boot, trial number 2 ,retrying in 5 seconds Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 20 02:25:54 volumio volumio[936]: info: Adding plugin bluetooth to MyMusic Plugins Oct 20 02:25:54 volumio volumio[936]: info: Adding plugin cd_controller to MyMusic Plugins Oct 20 02:25:54 volumio volumio[936]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 20 02:25:54 volumio volumio[936]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 20 02:25:54 volumio volumio[936]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 20 02:25:55 volumio volumio[936]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 20 02:25:56 volumio volumio[936]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 20 02:25:56 volumio volumio[936]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 20 02:25:56 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:25:56 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:25:56 volumio volumio[936]: info: Starting MyVolumio Remote Streaming Endpoints Oct 20 02:25:56 volumio volumio[936]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 20 02:25:56 volumio volumio[936]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 20 02:25:56 volumio volumio[936]: info: Streaming services startup Oct 20 02:25:56 volumio volumio[936]: info: Starting Streaming Daemon Oct 20 02:25:56 volumio sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 20 02:25:56 volumio sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:56 volumio volumio[936]: info: MyVolumio login type: Token Oct 20 02:25:56 volumio systemd[1]: Stopping Volumio Streaming Daemon... Oct 20 02:25:56 volumio volumio[936]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 20 02:25:56 volumio systemd[1]: Starting Volumio Streaming Daemon... Oct 20 02:25:56 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 20 02:25:56 volumio volumio-streaming-daemon[1285]: ############################ Oct 20 02:25:56 volumio volumio-streaming-daemon[1285]: # Volumio Streaming Daemon # Oct 20 02:25:56 volumio volumio-streaming-daemon[1285]: # Running on port 7777 # Oct 20 02:25:56 volumio volumio-streaming-daemon[1285]: ############################ Oct 20 02:25:56 volumio volumio-streaming-daemon[1285]: Environment: production Oct 20 02:25:56 volumio sudo[1275]: pam_unix(sudo:session): session closed for user root Oct 20 02:25:57 volumio volumio[936]: error: MyVolumio Custom Token format not valid, refreshing it Oct 20 02:25:58 volumio sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.6.165/cd备份 空间4\YINYUE /mnt/NAS/YINYUE Oct 20 02:25:58 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:25:58 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Oct 20 02:25:58 volumio volumio-streaming-daemon[1285]: Environment: production Oct 20 02:25:58 volumio volumio[936]: info: Fetching Streaming Services browse cache Oct 20 02:25:59 volumio volumio[936]: info: MyVolumio login type: Token Oct 20 02:26:01 volumio volumio[936]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 20 02:26:01 volumio volumio[936]: info: MYVOLUMIO: Adding device Oct 20 02:26:01 volumio volumio[936]: info: MYVOLUMIO: Evaluating Server Oct 20 02:26:01 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 20 02:26:04 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 20 02:26:04 volumio volumio[936]: info: MyVolumio status changed Oct 20 02:26:04 volumio volumio[936]: info: Streaming services startup Oct 20 02:26:04 volumio volumio[936]: info: Re-Starting Streaming Daemon Oct 20 02:26:04 volumio volumio[936]: info: Removing browser output: myVolumio user plan is not superstar Oct 20 02:26:04 volumio volumio[936]: info: Removing audio output: Oct 20 02:26:04 volumio volumio[936]: info: Stoppping Tunnel 1 Oct 20 02:26:04 volumio sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 20 02:26:04 volumio sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:26:04 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Oct 20 02:26:04 volumio sudo[1338]: pam_unix(sudo:session): session closed for user root Oct 20 02:26:04 volumio volumio-streaming-daemon[1285]: Restarting daemon Oct 20 02:26:04 volumio volumio-streaming-daemon[1285]: Environment: production Oct 20 02:26:04 volumio volumio[936]: info: Remote SSH Stopped Oct 20 02:26:04 volumio sudo[1302]: pam_unix(sudo:session): session closed for user root Oct 20 02:26:04 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 20 02:26:04 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 20 02:26:04 volumio volumio[936]: info: Cannot mount NAS YINYUE at system boot, trial number 3 ,retrying in 5 seconds Oct 20 02:26:05 volumio volumio-streaming-daemon[1285]: Environment: production Oct 20 02:26:05 volumio volumio[936]: info: Fetching Streaming Services browse cache Oct 20 02:26:06 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 20 02:26:07 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 20 02:26:07 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:07 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 20 02:26:10 volumio sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.6.165/cd备份 空间4\YINYUE /mnt/NAS/YINYUE Oct 20 02:26:10 volumio sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:26:10 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Oct 20 02:26:10 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 20 02:26:11 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 20 02:26:16 volumio sudo[1377]: pam_unix(sudo:session): session closed for user root Oct 20 02:26:16 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 20 02:26:16 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 20 02:26:16 volumio volumio[936]: info: Cannot mount NAS YINYUE at system boot, trial number 4 ,retrying in 5 seconds Oct 20 02:26:17 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 20 02:26:18 volumio volumio[936]: info: Setting Geolocation for MyVolumio to us2 Oct 20 02:26:18 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:18 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:18 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:19 volumio volumio[936]: info: Updating MyVolumio device info Oct 20 02:26:19 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:19 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:19 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:21 volumio sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.6.165/cd备份 空间4\YINYUE /mnt/NAS/YINYUE Oct 20 02:26:21 volumio sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 02:26:21 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Oct 20 02:26:21 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 20 02:26:22 volumio volumio[936]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/Smile/c3974ec6-a230-4b64-9245-cf300b5d7782.jpg' Oct 20 02:26:22 volumio volumio[936]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/Smile/83f56650-f263-4e18-bd0a-0ee260949181.jpg' Oct 20 02:26:23 volumio volumio[936]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::ClearQueue Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::stop Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 02:26:23 volumio volumio[936]: UNSET VOLATILE Oct 20 02:26:23 volumio volumio[936]: info: CorePlayQueue::clearPlayQueue Oct 20 02:26:23 volumio volumio[936]: info: CorePlayQueue::saveQueue Oct 20 02:26:23 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:26:23 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:26:23 volumio volumio[936]: info: CoreCommandRouter::volumioPushQueue Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::addQueueItems Oct 20 02:26:23 volumio volumio[936]: info: CorePlayQueue::addQueueItems Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281326 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281326 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281338 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281338 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281348 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281348 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281358 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281358 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281368 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281368 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281378 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281378 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281388 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281388 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281398 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281398 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281408 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281408 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281418 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281418 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: Adding Item to queue: upnp/http://192.168.6.8:49152/upnp/control/cds@281428 Oct 20 02:26:23 volumio volumio[936]: info: Exploding uri upnp/http://192.168.6.8:49152/upnp/control/cds@281428 in service upnp_browser Oct 20 02:26:23 volumio volumio[936]: info: CorePlayQueue::saveQueue Oct 20 02:26:23 volumio volumio[936]: info: CoreCommandRouter::volumioPushQueue Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::updateTrackBlock Oct 20 02:26:23 volumio volumio[936]: info: CorePlayQueue::getTrackBlock Oct 20 02:26:23 volumio volumio[936]: info: CoreCommandRouter::volumioPlay Oct 20 02:26:23 volumio volumio[936]: UNSET VOLATILE Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::play index 0 Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::stop Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 02:26:23 volumio volumio[936]: UNSET VOLATILE Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::play index undefined Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 02:26:23 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:26:23 volumio volumio[936]: info: CoreStateMachine::startPlaybackTimer Oct 20 02:26:23 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:26:23 volumio volumio[936]: info: [1729391183885] ControllerUPNPBrowser::clearAddPlayTrack Oct 20 02:26:23 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand stop Oct 20 02:26:23 volumio volumio[936]: info: sendMpdCommand stop took 6 milliseconds Oct 20 02:26:23 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand clear Oct 20 02:26:23 volumio volumio[936]: info: Oct 20 02:26:23 volumio volumio[936]: ---------------------------- MPD announces system playlist update Oct 20 02:26:23 volumio volumio[936]: info: Ignoring MPD Status Update Oct 20 02:26:23 volumio volumio[936]: info: sendMpdCommand clear took 5 milliseconds Oct 20 02:26:23 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.6.8:49152/content/media/object_id/281326/res_id/0/ext/file.flac" Oct 20 02:26:23 volumio volumio[936]: error: updateQueue error: null Oct 20 02:26:23 volumio volumio[936]: info: ------------------------------ 7ms Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.6.8:49152/content/media/object_id/281326/res_id/0/ext/file.flac" Oct 20 02:26:24 volumio volumio[936]: info: Oct 20 02:26:24 volumio volumio[936]: ---------------------------- MPD announces system playlist update Oct 20 02:26:24 volumio volumio[936]: info: Ignoring MPD Status Update Oct 20 02:26:24 volumio volumio[936]: info: sendMpdCommand add "http://192.168.6.8:49152/content/media/object_id/281326/res_id/0/ext/file.flac" took 2 milliseconds Oct 20 02:26:24 volumio volumio[936]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand play Oct 20 02:26:24 volumio volumio[936]: info: ------------------------------ 4ms Oct 20 02:26:24 volumio volumio[936]: info: sendMpdCommand play took 3 milliseconds Oct 20 02:26:24 volumio volumio[936]: info: Oct 20 02:26:24 volumio volumio[936]: ---------------------------- MPD announces state update: player Oct 20 02:26:24 volumio volumio[936]: info: ControllerMpd::getState Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand status Oct 20 02:26:24 volumio volumio[936]: info: Oct 20 02:26:24 volumio volumio[936]: ---------------------------- MPD announces state update: player Oct 20 02:26:24 volumio volumio[936]: info: ControllerMpd::getState Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand status Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 20 02:26:24 volumio volumio[936]: info: sendMpdCommand status took 19 milliseconds Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::parseState Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 20 02:26:24 volumio volumio[936]: info: sendMpdCommand status took 33 milliseconds Oct 20 02:26:24 volumio volumio[936]: info: sendMpdCommand clearerror took 24 milliseconds Oct 20 02:26:24 volumio volumio[936]: info: sendMpdCommand playlistinfo took 14 milliseconds Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::parseState Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::parseTrackInfo Oct 20 02:26:24 volumio volumio[936]: info: ControllerMpd::pushState Oct 20 02:26:24 volumio volumio[936]: info: CoreCommandRouter::servicePushState Oct 20 02:26:24 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:26:24 volumio volumio[936]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.6.8:49152/content/media/object_id/281326/res_id/0/ext/file.flac","trackType":"flac"} Oct 20 02:26:24 volumio volumio[936]: verbose: CURRENT POSITION 0 Oct 20 02:26:24 volumio volumio[936]: info: CoreStateMachine::syncState stateService pause Oct 20 02:26:24 volumio volumio[936]: info: CoreStateMachine::syncState currentStatus stop Oct 20 02:26:24 volumio volumio[936]: info: CoreStateMachine::pushState Oct 20 02:26:24 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:26:24 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:26:24 volumio volumio[936]: info: ------------------------------ 102ms Oct 20 02:26:24 volumio volumio[936]: info: sendMpdCommand clearerror took 61 milliseconds Oct 20 02:26:24 volumio volumio[936]: info: sendMpdCommand playlistinfo took 52 milliseconds Oct 20 02:26:24 volumio volumio[936]: verbose: ControllerMpd::parseTrackInfo Oct 20 02:26:24 volumio volumio[936]: info: ControllerMpd::pushState Oct 20 02:26:24 volumio volumio[936]: info: CoreCommandRouter::servicePushState Oct 20 02:26:24 volumio volumio[936]: info: CorePlayQueue::getTrack 0 Oct 20 02:26:24 volumio volumio[936]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.flac","artist":null,"album":null,"uri":"http://192.168.6.8:49152/content/media/object_id/281326/res_id/0/ext/file.flac","trackType":"flac"} Oct 20 02:26:24 volumio volumio[936]: verbose: CURRENT POSITION 0 Oct 20 02:26:24 volumio volumio[936]: info: CoreStateMachine::syncState stateService pause Oct 20 02:26:24 volumio volumio[936]: info: CoreStateMachine::syncState currentStatus stop Oct 20 02:26:24 volumio volumio[936]: info: CoreStateMachine::pushState Oct 20 02:26:24 volumio volumio[936]: info: CoreCommandRouter::volumioPushState Oct 20 02:26:24 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 02:26:24 volumio volumio[936]: info: ------------------------------ 108ms Oct 20 02:26:27 volumio sudo[1410]: pam_unix(sudo:session): session closed for user root Oct 20 02:26:27 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 20 02:26:27 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 20 02:26:27 volumio volumio[936]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Oct 20 02:26:31 volumio volumio[936]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 20 02:26:31 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 20 02:26:31 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:31 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 20 02:26:31 volumio volumio[936]: info: Getting Alsa Cards List without I2S DAC Oct 20 02:26:31 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 20 02:26:31 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 20 02:26:32 volumio volumio[936]: Invalid card number. Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 20 02:26:32 volumio volumio[936]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 20 02:26:54 volumio volumio[936]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 20 02:26:54 volumio volumio[936]: { Error: connect ETIMEDOUT 103.252.114.101:443 Oct 20 02:26:54 volumio volumio[936]: at Object._errnoException (util.js:1022:11) Oct 20 02:26:54 volumio volumio[936]: at _exceptionWithHostPort (util.js:1044:20) Oct 20 02:26:54 volumio volumio[936]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 20 02:26:54 volumio volumio[936]: code: 'ETIMEDOUT', Oct 20 02:26:54 volumio volumio[936]: errno: 'ETIMEDOUT', Oct 20 02:26:54 volumio volumio[936]: syscall: 'connect', Oct 20 02:26:54 volumio volumio[936]: address: '103.252.114.101', Oct 20 02:26:54 volumio volumio[936]: port: 443 } Oct 20 02:26:54 volumio volumio[936]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 20 02:26:55 volumio sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-20 02:25 Oct 20 02:26:55 volumio sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"