-- Logs begin at Tue 2025-02-25 14:07:40 -03, end at Tue 2025-02-25 17:09:42 -03. -- Feb 25 17:08:22 volumio systemd-timedated[1329]: Changed local time to Tue Feb 25 20:08:22 2025 Feb 25 17:08:22 volumio sudo[1284]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:22 volumio volumio-time-update[917]: volumio-time-update-util: System time updated successfully. Feb 25 17:08:22 volumio systemd[1]: Started Volumio Time Update Utility. Feb 25 17:08:22 volumio firststart.sh[1233]: Creating /var/log/samba/cores folder Feb 25 17:08:22 volumio firststart.sh[1233]: Removing default SSH host keys Feb 25 17:08:22 volumio startx[1236]: X.Org X Server 1.20.4 Feb 25 17:08:22 volumio startx[1236]: X Protocol Version 11, Revision 0 Feb 25 17:08:22 volumio startx[1236]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Feb 25 17:08:22 volumio startx[1236]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Feb 25 17:08:22 volumio startx[1236]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d35eb915-f24a-437a-a43b-4afe991304f7 bootpart=UUID=79FB-2BA3 datapart=UUID=2fc5abe1-9579-4377-a3f7-b00c1ebaeecd hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Feb 25 17:08:22 volumio startx[1236]: Build Date: 18 December 2021 09:05:36AM Feb 25 17:08:22 volumio startx[1236]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Feb 25 17:08:22 volumio startx[1236]: Current version of pixman: 0.36.0 Feb 25 17:08:22 volumio startx[1236]: Before reporting problems, check http://wiki.x.org Feb 25 17:08:22 volumio startx[1236]: to make sure that you have the latest version. Feb 25 17:08:22 volumio startx[1236]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 25 17:08:22 volumio startx[1236]: (++) from command line, (!!) notice, (II) informational, Feb 25 17:08:22 volumio startx[1236]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 25 17:08:22 volumio startx[1236]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Feb 25 20:08:22 2025 Feb 25 17:08:22 volumio firststart.sh[1233]: removed '/etc/ssh/ssh_host_ecdsa_key' Feb 25 17:08:22 volumio firststart.sh[1233]: removed '/etc/ssh/ssh_host_ecdsa_key.pub' Feb 25 17:08:22 volumio firststart.sh[1233]: removed '/etc/ssh/ssh_host_ed25519_key' Feb 25 17:08:22 volumio firststart.sh[1233]: removed '/etc/ssh/ssh_host_ed25519_key.pub' Feb 25 17:08:22 volumio firststart.sh[1233]: removed '/etc/ssh/ssh_host_rsa_key' Feb 25 17:08:22 volumio firststart.sh[1233]: removed '/etc/ssh/ssh_host_rsa_key.pub' Feb 25 17:08:22 volumio firststart.sh[1233]: Generating SSH host keys Feb 25 17:08:22 volumio startx[1236]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 25 17:08:22 volumio systemd[1]: soundcard-init.service: Succeeded. Feb 25 17:08:22 volumio ntpd[1220]: Soliciting pool server 200.160.7.197 Feb 25 17:08:22 volumio ntpd[1220]: Soliciting pool server 216.238.106.159 Feb 25 17:08:22 volumio ntpd[1220]: Soliciting pool server 168.181.126.28 Feb 25 17:08:22 volumio ntpd[1220]: Soliciting pool server 200.189.40.8 Feb 25 17:08:23 volumio ntpd[1220]: Soliciting pool server 200.160.7.193 Feb 25 17:08:23 volumio ntpd[1220]: Soliciting pool server 143.107.229.211 Feb 25 17:08:23 volumio ntpd[1220]: Soliciting pool server 200.192.232.8 Feb 25 17:08:24 volumio ntpd[1220]: Soliciting pool server 2001:12ff:0:7::196 Feb 25 17:08:25 volumio systemd[1]: systemd-fsckd.service: Succeeded. Feb 25 17:08:25 volumio smbd[1325]: [2025/02/25 20:08:25.682344, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 25 17:08:25 volumio smbd[1325]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 25 17:08:25 volumio systemd[1]: Started Samba SMB Daemon. Feb 25 17:08:25 volumio systemd[1]: Reached target Multi-User System. Feb 25 17:08:25 volumio systemd[1]: Reached target Graphical Interface. Feb 25 17:08:25 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 25 17:08:25 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 25 17:08:25 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 25 17:08:26 volumio volumio-remote-updater[916]: [2025-02-25 20:08:26] [info] asio async_connect error: system:111 (Connection refused) Feb 25 17:08:26 volumio volumio-remote-updater[916]: [2025-02-25 20:08:26] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 25 17:08:26 volumio volumio-remote-updater[916]: [2025-02-25 20:08:26] [error] handle_connect error: Underlying Transport Error Feb 25 17:08:27 volumio startx[1236]: nvc0_screen_create:925 - Base screen init failed: -19 Feb 25 17:08:28 volumio firststart.sh[1233]: debconf: unable to initialize frontend: Dialog Feb 25 17:08:28 volumio firststart.sh[1233]: debconf: (TERM is not set, so the dialog frontend is not usable.) Feb 25 17:08:28 volumio firststart.sh[1233]: debconf: falling back to frontend: Readline Feb 25 17:08:28 volumio mpd[1160]: Feb 25 20:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 25 17:08:28 volumio firststart.sh[1233]: debconf: unable to initialize frontend: Readline Feb 25 17:08:28 volumio firststart.sh[1233]: debconf: (This frontend requires a controlling tty.) Feb 25 17:08:28 volumio firststart.sh[1233]: debconf: falling back to frontend: Teletype Feb 25 17:08:28 volumio mpd[1160]: Feb 25 20:08 : exception: Database corrupted Feb 25 17:08:28 volumio systemd[1]: Started Music Player Daemon. Feb 25 17:08:28 volumio systemd[1]: Startup finished in 1min 14.870s (firmware) + 7.468s (loader) + 8min 9.005s (kernel) + 53.381s (userspace) = 10min 24.725s. Feb 25 17:08:28 volumio mpd_monitor.sh[918]: MPD restarted due to no mpc output. Feb 25 17:08:31 volumio ntpd[1220]: receive: Unexpected origin timestamp 0xeb68a1bc.9c8e595b does not match aorg 0000000000.00000000 from server@216.238.106.159 xmt 0xeb68a1bf.7d7171e9 Feb 25 17:08:31 volumio ntpd[1220]: receive: Unexpected origin timestamp 0xeb68a1bc.9c8fd51d does not match aorg 0000000000.00000000 from server@200.160.7.186 xmt 0xeb68a1bf.7d76dd7b Feb 25 17:08:31 volumio ntpd[1220]: receive: Unexpected origin timestamp 0xeb68a1bc.9c8de0f4 does not match aorg 0000000000.00000000 from server@200.160.7.197 xmt 0xeb68a1bf.7d797dda Feb 25 17:08:31 volumio ntpd[1220]: receive: Unexpected origin timestamp 0xeb68a1bc.9c8f54d0 does not match aorg 0000000000.00000000 from server@200.160.7.196 xmt 0xeb68a1bf.7d7bec94 Feb 25 17:08:31 volumio ntpd[1220]: receive: Unexpected origin timestamp 0xeb68a1bc.9c90c89a does not match aorg 0000000000.00000000 from server@200.160.0.8 xmt 0xeb68a1bf.7d774ed5 Feb 25 17:08:31 volumio ntpd[1220]: receive: Unexpected origin timestamp 0xeb68a1bc.9c8bcb19 does not match aorg 0000000000.00000000 from server@200.192.232.8 xmt 0xeb68a1bf.7d0da935 Feb 25 17:08:31 volumio ntpd[1220]: receive: Unexpected origin timestamp 0xeb68a1bc.9c90510d does not match aorg 0000000000.00000000 from server@192.36.143.130 xmt 0xeb68a1bf.972fe7d0 Feb 25 17:08:31 volumio volumio[1232]: info: ------------------------------------------- Feb 25 17:08:31 volumio volumio[1232]: info: ----- Volumio3 ---- Feb 25 17:08:31 volumio volumio[1232]: info: ------------------------------------------- Feb 25 17:08:31 volumio volumio[1232]: info: ----- System startup ---- Feb 25 17:08:31 volumio volumio[1232]: info: ------------------------------------------- Feb 25 17:08:31 volumio startx[1236]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Feb 25 17:08:32 volumio firststart.sh[1233]: Creating SSH2 RSA key; this may take some time ... Feb 25 17:08:32 volumio firststart.sh[1233]: 2048 SHA256:4FQsPYe8VM0eUOrAYbsvqdmQs1uI1ZdUGAGmuFEfiMc root@volumio (RSA) Feb 25 17:08:32 volumio firststart.sh[1233]: Creating SSH2 DSA key; this may take some time ... Feb 25 17:08:32 volumio firststart.sh[1233]: 1024 SHA256:cnYHEzzmGduTToDl76c6hYhRuxFZ7/+/e/SGH6sp+LU root@volumio (DSA) Feb 25 17:08:32 volumio firststart.sh[1233]: Creating SSH2 ECDSA key; this may take some time ... Feb 25 17:08:32 volumio firststart.sh[1233]: 256 SHA256:tsag0ZKzXkDEFFFFK8aCW/oUazrYRJPTsU9VbHfgVy8 root@volumio (ECDSA) Feb 25 17:08:32 volumio volumio[1232]: info: File /data/configuration/plugins.json does not exist. Copying from Volumio Feb 25 17:08:32 volumio volumio[1232]: info: MYVOLUMIO Environment detected Feb 25 17:08:32 volumio volumio[1232]: info: Plugin folders cleanup Feb 25 17:08:32 volumio volumio[1232]: info: Scanning into folder /volumio/app/plugins/ Feb 25 17:08:32 volumio volumio[1232]: info: Scanning category audio_interface Feb 25 17:08:32 volumio volumio[1232]: info: Scanning category miscellanea Feb 25 17:08:32 volumio volumio[1232]: info: Scanning category music_service Feb 25 17:08:32 volumio volumio[1232]: info: Scanning category plugins.json Feb 25 17:08:32 volumio volumio[1232]: info: Scanning category system_controller Feb 25 17:08:32 volumio volumio[1232]: info: Scanning category user_interface Feb 25 17:08:32 volumio volumio[1232]: info: Scanning into folder /data/plugins/ Feb 25 17:08:32 volumio volumio[1232]: info: Plugin folders cleanup completed Feb 25 17:08:32 volumio volumio[1232]: info: ------------------------------------------- Feb 25 17:08:32 volumio volumio[1232]: info: ----- Core plugins startup ---- Feb 25 17:08:32 volumio volumio[1232]: info: ------------------------------------------- Feb 25 17:08:32 volumio volumio[1232]: info: Loading plugins from folder /volumio/app/plugins/ Feb 25 17:08:32 volumio volumio[1232]: info: Adding plugin upnp to MyMusic Plugins Feb 25 17:08:32 volumio volumio[1232]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 25 17:08:32 volumio volumio[1232]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 25 17:08:32 volumio volumio[1232]: info: Loading plugins from folder /data/plugins/ Feb 25 17:08:32 volumio volumio[1232]: info: Loading plugin "system"... Feb 25 17:08:32 volumio volumio[1232]: info: No id defined. Creating one Feb 25 17:08:32 volumio volumio[1232]: info: Loading plugin "appearance"... Feb 25 17:08:32 volumio systemd[1]: Reloading. Feb 25 17:08:32 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 25 17:08:32 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Feb 25 17:08:33 volumio firststart.sh[1233]: rescue-ssh.target is a disabled or a static unit, not starting it. Feb 25 17:08:33 volumio firststart.sh[1233]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5). Feb 25 17:08:33 volumio firststart.sh[1233]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty). Feb 25 17:08:33 volumio systemd[1]: Reloading. Feb 25 17:08:33 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "network"... Feb 25 17:08:33 volumio volumio[1232]: info: Refreshing Cached IP Addresses Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "services"... Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "alsa_controller"... Feb 25 17:08:33 volumio sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:08:33 volumio sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:33 volumio sudo[1661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:08:33 volumio sudo[1661]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:33 volumio sudo[1659]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:33 volumio sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 25 17:08:33 volumio sudo[1661]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:33 volumio sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:33 volumio sudo[1671]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:33 volumio volumio[1232]: warn: The ALSA output card is not set, defaulting to card [object Object] Feb 25 17:08:33 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 17:08:33 volumio volumio[1232]: info: Found match in Cards Database: setting mixer for card Analog Out Feb 25 17:08:33 volumio volumio[1232]: info: Setting mixer Master for card Analog Out Feb 25 17:08:33 volumio volumio[1232]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 25 17:08:33 volumio volumio[1232]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 25 17:08:33 volumio volumio[1232]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 25 17:08:33 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "wizard"... Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "networkfs"... Feb 25 17:08:33 volumio volumio[1232]: info: Starting Udev Watcher for removable devices Feb 25 17:08:33 volumio volumio[1232]: info: Ignoring mount for partition: 0700-1BB9 Feb 25 17:08:33 volumio volumio[1232]: info: Ignoring mount for partition: ccc818f9-ba2d-4973-969b-d23f5075f99d Feb 25 17:08:33 volumio volumio[1232]: info: Ignoring mount for partition: fedora Feb 25 17:08:33 volumio volumio[1232]: info: Ignoring mount for partition: boot Feb 25 17:08:33 volumio volumio[1232]: info: Ignoring mount for partition: volumio Feb 25 17:08:33 volumio volumio[1232]: info: Ignoring mount for partition: volumio_data Feb 25 17:08:33 volumio volumio[1232]: info: Ignoring mount for partition: 0E2ECEAB2ECE8AE3 Feb 25 17:08:33 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "volumio_command_line_client"... Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "upnp"... Feb 25 17:08:33 volumio volumio[1232]: info: [1740514113654] Starting Upmpd Daemon Feb 25 17:08:33 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "my_music"... Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "mpd"... Feb 25 17:08:33 volumio firststart.sh[1233]: Enabling SSH for first boot Feb 25 17:08:33 volumio systemd[1]: Starting OpenBSD Secure Shell server... Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "upnp_browser"... Feb 25 17:08:33 volumio sshd[1721]: Server listening on 0.0.0.0 port 22. Feb 25 17:08:33 volumio sshd[1721]: Server listening on :: port 22. Feb 25 17:08:33 volumio systemd[1]: Started OpenBSD Secure Shell server. Feb 25 17:08:33 volumio firststart.sh[1233]: Disabling firststart service Feb 25 17:08:33 volumio firststart.sh[1233]: Removed /etc/systemd/system/multi-user.target.wants/firststart.service. Feb 25 17:08:33 volumio systemd[1]: Reloading. Feb 25 17:08:33 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 25 17:08:33 volumio volumio[1232]: info: Loading plugin "alarm-clock"... Feb 25 17:08:34 volumio firststart.sh[1233]: Finalizing Feb 25 17:08:34 volumio volumio[1232]: info: Loading plugin "airplay_emulation"... Feb 25 17:08:34 volumio volumio[1232]: info: Starting Shairport Sync Feb 25 17:08:34 volumio volumio[1232]: info: Loading plugin "last_100"... Feb 25 17:08:34 volumio volumio[1232]: info: Loading plugin "webradio"... Feb 25 17:08:34 volumio volumio[1232]: info: Loading plugin "i2s_dacs"... Feb 25 17:08:34 volumio volumio[1232]: info: I2S DAC not set, start Auto-detection Feb 25 17:08:34 volumio volumio[1232]: info: Loading plugin "volumiodiscovery"... Feb 25 17:08:37 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Feb 25 17:08:39 volumio volumio-remote-updater[916]: [2025-02-25 20:08:39] [connect] Successful connection Feb 25 17:08:41 volumio volumio[1232]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 25 17:08:41 volumio volumio[1232]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 25 17:08:41 volumio volumio[1232]: *** WARNING *** For more information see Feb 25 17:08:41 volumio volumio[1232]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 25 17:08:41 volumio volumio[1232]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 25 17:08:41 volumio volumio[1232]: *** WARNING *** For more information see Feb 25 17:08:41 volumio node[1232]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 25 17:08:41 volumio node[1232]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 25 17:08:41 volumio node[1232]: *** WARNING *** For more information see Feb 25 17:08:41 volumio node[1232]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 25 17:08:41 volumio node[1232]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 25 17:08:41 volumio node[1232]: *** WARNING *** For more information see Feb 25 17:08:41 volumio volumio[1232]: info: Discovery: Started advertising with name: Volumio Feb 25 17:08:41 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 25 17:08:41 volumio volumio[1232]: info: Loading plugin "outputs"... Feb 25 17:08:41 volumio volumio[1232]: info: Loading plugin "albumart"... Feb 25 17:08:41 volumio volumio[1232]: info: Plugin example_plugin is not enabled Feb 25 17:08:41 volumio volumio[1232]: info: Loading plugin "inputs"... Feb 25 17:08:41 volumio volumio[1232]: info: Loading plugin "updater_comm"... Feb 25 17:08:43 volumio volumio[1232]: Forking 7 albumart workers Feb 25 17:08:43 volumio volumio[1232]: Starting albumart workers Feb 25 17:08:43 volumio volumio[1232]: Starting albumart workers Feb 25 17:08:43 volumio volumio[1232]: Starting albumart workers Feb 25 17:08:43 volumio volumio[1232]: Starting albumart workers Feb 25 17:08:43 volumio volumio[1232]: Starting albumart workers Feb 25 17:08:43 volumio volumio[1232]: Starting albumart workers Feb 25 17:08:43 volumio volumio[1232]: Starting albumart workers Feb 25 17:08:45 volumio volumio[1232]: info: Plugin mpdemulation is not enabled Feb 25 17:08:45 volumio volumio[1232]: info: Loading plugin "rest_api"... Feb 25 17:08:45 volumio volumio[1232]: info: Loading plugin "websocket"... Feb 25 17:08:45 volumio volumio[1232]: info: Starting Socket.io Server version 2.3.0 Feb 25 17:08:45 volumio systemd[1]: firststart.service: Succeeded. Feb 25 17:08:46 volumio volumio[1232]: info: Loading i18n strings for locale en Feb 25 17:08:46 volumio volumio[1232]: Updating browse sources language Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::initPlayerControls Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: Express server listening on port 3000 Feb 25 17:08:46 volumio volumio[1232]: [Metrics] WebUI: 14s 947.94ms Feb 25 17:08:46 volumio volumio[1232]: info: Setting Device type: x86 Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::resetVolumioState Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::getcurrentVolume Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::getcurrentVolume Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 17:08:46 volumio sudo[1873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:08:46 volumio sudo[1873]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio volumio[1232]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 25 17:08:46 volumio sudo[1873]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: info: Completed loading Core Plugins Feb 25 17:08:46 volumio volumio[1232]: info: Preparing to generate the ALSA configuration file Feb 25 17:08:46 volumio sudo[1875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:08:46 volumio sudo[1875]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio volumio[1232]: info: Cannot read play queue from file Feb 25 17:08:46 volumio sudo[1875]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: info: Volumio Network Manager: Network status updated: 1 Feb 25 17:08:46 volumio volumio[1232]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 25 17:08:46 volumio volumio[1232]: wlan0 Interface doesn't support scanning. Feb 25 17:08:46 volumio volumio[1232]: info: Cannot use regular scanning, forcing with ap-force Feb 25 17:08:46 volumio sudo[1883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 25 17:08:46 volumio sudo[1883]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio sudo[1883]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: command failed: No such device (-19) Feb 25 17:08:46 volumio volumio[1232]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 25 17:08:46 volumio volumio[1232]: command failed: No such device (-19) Feb 25 17:08:46 volumio volumio[1232]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Feb 25 17:08:46 volumio volumio[1232]: info: VolumeController:: Volume=41 Mute =false Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::pushState Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioPushState Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::updateTrackBlock Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrackBlock Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 17:08:46 volumio volumio[1232]: info: VolumeController:: Volume=41 Mute =false Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::pushState Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioPushState Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::updateTrackBlock Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrackBlock Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:08:46 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:08:46 volumio volumio[1232]: info: Asound.conf file written Feb 25 17:08:46 volumio sudo[1897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 25 17:08:46 volumio sudo[1897]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio sudo[1897]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: No state is present for card PCH Feb 25 17:08:46 volumio volumio[1232]: Found hardware: "HDA-Intel" "Realtek ALC662 rev3" "HDA:10ec0662,10ec0662,00100300" "0x8086" "0x7270" Feb 25 17:08:46 volumio volumio[1232]: Hardware is initialized using a generic method Feb 25 17:08:46 volumio volumio[1232]: No state is present for card PCH Feb 25 17:08:46 volumio volumio[1232]: No state is present for card NVidia Feb 25 17:08:46 volumio volumio[1232]: Found hardware: "HDA-Intel" "Nvidia GPU 71 HDMI/DP" "HDA:10de0071,1458367a,00100100" "0x1458" "0x367a" Feb 25 17:08:46 volumio volumio[1232]: Hardware is initialized using a generic method Feb 25 17:08:46 volumio volumio[1232]: No state is present for card NVidia Feb 25 17:08:46 volumio volumio[1232]: No state is present for card C920 Feb 25 17:08:46 volumio volumio[1232]: Found hardware: "USB-Audio" "USB Mixer" "USB046d:08e5" "" "" Feb 25 17:08:46 volumio volumio[1232]: Hardware is initialized using a generic method Feb 25 17:08:46 volumio volumio[1232]: No state is present for card C920 Feb 25 17:08:46 volumio volumio[1232]: info: Output device has changed, restarting MPD Feb 25 17:08:46 volumio volumio[1232]: info: Output device has changed, restarting Shairport Sync Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:08:46 volumio sudo[1902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 25 17:08:46 volumio sudo[1902]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio sudo[1904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 25 17:08:46 volumio sudo[1904]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio systemd[1]: Stopping Music Player Daemon... Feb 25 17:08:46 volumio volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 17:08:46 volumio volumio[1232]: info: ___________ START PLUGINS ___________ Feb 25 17:08:46 volumio volumio[1232]: info: Setting Hotspot Unique name on first start: Volumio-9C489 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::Reload Ui Feb 25 17:08:46 volumio volumio[1232]: info: ControllerMpd::onStart: Initializing MPD Feb 25 17:08:46 volumio volumio[1232]: info: Creating MPD Configuration file Feb 25 17:08:46 volumio sudo[1902]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio sudo[1911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 25 17:08:46 volumio sudo[1911]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio volumio[1232]: info: [1740514126340] CoreMusicLibrary::Adding element Media Servers Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:08:46 volumio sudo[1911]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio sudo[1913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 25 17:08:46 volumio sudo[1913]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 25 17:08:46 volumio volumio[1232]: info: [1740514126371] CoreMusicLibrary::Adding element Last_100 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 25 17:08:46 volumio volumio[1232]: info: [1740514126372] CoreMusicLibrary::Adding element Webradio Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 17:08:46 volumio volumio[1232]: info: Initializing BBC Radios Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: Volumio Calling Home Feb 25 17:08:46 volumio volumio[1232]: info: MPD Permissions set Feb 25 17:08:46 volumio volumio[1232]: info: MPD Permissions set Feb 25 17:08:46 volumio volumio[1232]: info: VolumeController:: Volume=41 Mute =false Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::pushState Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioPushState Feb 25 17:08:46 volumio volumio[1232]: info: VolumeController:: Volume=41 Mute =false Feb 25 17:08:46 volumio volumio[1232]: info: CoreStateMachine::pushState Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioPushState Feb 25 17:08:46 volumio volumio[1232]: verbose: New Socket.io Connection to 192.168.3.6:3000 from 192.168.3.38 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Feb 25 17:08:46 volumio sudo[1936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 25 17:08:46 volumio sudo[1936]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 17:08:46 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Feb 25 17:08:46 volumio sudo[1936]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio systemd[1]: mpd.service: Succeeded. Feb 25 17:08:46 volumio systemd[1]: Stopped Music Player Daemon. Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio systemd[1]: Starting Music Player Daemon... Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:08:46 volumio sudo[1945]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 25 17:08:46 volumio sudo[1945]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio sudo[1945]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 17:08:46 volumio volumio[1232]: info: Upmpdcli Daemon Started Feb 25 17:08:46 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:08:46 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:46 volumio volumio[1232]: info: Starting Shairport Sync Feb 25 17:08:46 volumio volumio[1232]: info: Starting Shairport Sync Feb 25 17:08:46 volumio sudo[1955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 17:08:46 volumio volumio[1232]: info: Starting Shairport Sync Feb 25 17:08:46 volumio sudo[1955]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio sudo[1957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 17:08:46 volumio sudo[1957]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 25 17:08:46 volumio systemd[1]: shairport-sync.service: Succeeded. Feb 25 17:08:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 25 17:08:46 volumio sudo[1960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 17:08:46 volumio sudo[1960]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:46 volumio mpd[1953]: Feb 25 20:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 25 17:08:46 volumio systemd[1]: Started Music Player Daemon. Feb 25 17:08:46 volumio sudo[1913]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio sudo[1904]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: info: Completed starting Core Plugins Feb 25 17:08:46 volumio volumio[1232]: info: ------------------------------------------- Feb 25 17:08:46 volumio volumio[1232]: info: ----- MyVolumio plugins startup ---- Feb 25 17:08:46 volumio volumio[1232]: info: ------------------------------------------- Feb 25 17:08:46 volumio volumio[1232]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 25 17:08:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 25 17:08:46 volumio sudo[1955]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: info: MPD running with PID1953 Feb 25 17:08:46 volumio volumio[1232]: ,establishing connection Feb 25 17:08:46 volumio sudo[1960]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:46 volumio volumio[1232]: info: Volumio called home Feb 25 17:08:46 volumio sudo[1957]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:47 volumio volumio[1232]: error: MPD error: The expression evaluated to a falsy value: Feb 25 17:08:47 volumio volumio[1232]: assert.ok(self.idling) Feb 25 17:08:47 volumio volumio[1232]: error: The expression evaluated to a falsy value: Feb 25 17:08:47 volumio volumio[1232]: assert.ok(self.idling) Feb 25 17:08:47 volumio volumio[1232]: error: MPD error: The expression evaluated to a falsy value: Feb 25 17:08:47 volumio volumio[1232]: assert.ok(self.idling) Feb 25 17:08:47 volumio volumio[1232]: error: The expression evaluated to a falsy value: Feb 25 17:08:47 volumio volumio[1232]: assert.ok(self.idling) Feb 25 17:08:47 volumio volumio[1232]: info: Shairport-Sync Started Feb 25 17:08:47 volumio volumio[1232]: Error adding Membership: Error: addMembership EINVAL Feb 25 17:08:47 volumio volumio[1232]: info: Shairport-Sync Started Feb 25 17:08:47 volumio volumio[1232]: info: Shairport-Sync Started Feb 25 17:08:47 volumio volumio[1232]: error: updateQueue error: null Feb 25 17:08:47 volumio volumio[1938]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 25 17:08:47 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:08:47 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:08:47 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:08:47 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:08:47 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:47 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:08:47 volumio sudo[1987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Feb 25 17:08:47 volumio sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:47 volumio sudo[1987]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:47 volumio volumio[1232]: info: Permissions for /etc/hostapd/hostapd.conf Feb 25 17:08:47 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Feb 25 17:08:47 volumio volumio[1232]: info: Discovery: Restarting Advertising due to device name change Feb 25 17:08:47 volumio sudo[1990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Feb 25 17:08:47 volumio sudo[1990]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:47 volumio systemd[1]: Starting Wireless Services... Feb 25 17:08:47 volumio wireless.js[1992]: WIRELESS: No wireless interface, exiting Feb 25 17:08:47 volumio iw[2003]: command failed: No such device (-19) Feb 25 17:08:47 volumio iwconfig[2006]: Error for wireless request "Set Power Management" (8B2C) : Feb 25 17:08:47 volumio iwconfig[2006]: SET failed on device wlan0 ; No such device. Feb 25 17:08:47 volumio systemd[1]: wireless.service: Succeeded. Feb 25 17:08:47 volumio systemd[1]: Started Wireless Services. Feb 25 17:08:47 volumio sudo[1990]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:48 volumio volumio[1232]: info: Discovery: A device disappeared from network Feb 25 17:08:48 volumio volumio[1232]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Feb 25 17:08:48 volumio volumio[1232]: info: Discovery: adding 06c02e00-5fbc-4755-a779-78527139141f Feb 25 17:08:48 volumio volumio[1232]: info: Discovery: Found device Volumio Feb 25 17:08:48 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:08:48 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:49 volumio volumio[1938]: ..............................................................................................................................................................................................................................................................................................................................++++ Feb 25 17:08:49 volumio volumio[1938]: ........................................................++++ Feb 25 17:08:49 volumio volumio[1938]: e is 65537 (0x010001) Feb 25 17:08:49 volumio volumio[1938]: writing RSA key Feb 25 17:08:50 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:08:50 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:08:50 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:08:50 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:08:50 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:50 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:08:51 volumio volumio[1232]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 25 17:08:52 volumio volumio[1232]: info: Discovery: Started advertising with name: Volumio Feb 25 17:08:52 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Feb 25 17:08:52 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Feb 25 17:08:53 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:08:53 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:08:53 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:08:53 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:08:53 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:53 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:08:54 volumio volumio-remote-updater[916]: [2025-02-25 20:08:54] [connect] Successful connection Feb 25 17:08:54 volumio volumio-remote-updater[916]: [2025-02-25 20:08:54] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740514134 101 Feb 25 17:08:54 volumio volumio[1232]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Feb 25 17:08:54 volumio sudo[2050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:08:54 volumio sudo[2050]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:08:54 volumio sudo[2050]: pam_unix(sudo:session): session closed for user root Feb 25 17:08:54 volumio systemd[1]: systemd-timedated.service: Succeeded. Feb 25 17:08:55 volumio volumio[1232]: info: Discovery: this is already registered, 06c02e00-5fbc-4755-a779-78527139141f Feb 25 17:08:55 volumio volumio[1232]: info: Discovery: Found device Volumio Feb 25 17:08:55 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:08:55 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 25 17:08:55 volumio volumio[1232]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 25 17:08:55 volumio volumio[1232]: info: Adding plugin bluetooth to MyMusic Plugins Feb 25 17:08:55 volumio volumio[1232]: info: Adding plugin multiroom to MyMusic Plugins Feb 25 17:08:55 volumio volumio[1232]: info: Adding plugin metavolumio to MyMusic Plugins Feb 25 17:08:58 volumio volumio[1232]: info: Adding plugin cd_controller to MyMusic Plugins Feb 25 17:08:58 volumio volumio[1232]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 25 17:08:58 volumio volumio[1232]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 25 17:08:58 volumio volumio[1232]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 25 17:09:06 volumio volumio[1232]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 25 17:09:06 volumio volumio[1232]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 25 17:09:06 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:09:06 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:09:06 volumio volumio[1232]: info: Starting MyVolumio Remote Streaming Endpoints Feb 25 17:09:06 volumio volumio[1232]: info: MyVolumio not started Feb 25 17:09:06 volumio volumio[1232]: info: Initializing device activation check Feb 25 17:09:06 volumio volumio[1232]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 25 17:09:06 volumio volumio[1232]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 25 17:09:09 volumio volumio[1232]: info: Starting Streaming Service Transparent Proxy Feb 25 17:09:09 volumio volumio[1232]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 25 17:09:09 volumio volumio[1232]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 25 17:09:09 volumio volumio[1232]: info: Streaming services startup Feb 25 17:09:09 volumio volumio[1232]: info: Starting Streaming Daemon Feb 25 17:09:09 volumio sudo[2154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 25 17:09:09 volumio sudo[2154]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:09 volumio volumio[1232]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 25 17:09:09 volumio sudo[2154]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:09 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Feb 25 17:09:09 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Feb 25 17:09:09 volumio volumio[1232]: info: Refreshing Cached IP Addresses Feb 25 17:09:09 volumio sudo[2162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Feb 25 17:09:09 volumio sudo[2162]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:09 volumio sudo[2162]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:09 volumio sudo[2164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:09:09 volumio sudo[2164]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:09 volumio sudo[2164]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:09 volumio sudo[2167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:09:09 volumio sudo[2167]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:09 volumio volumio[1232]: error: Cannot start Volumio Streaming Daemon Feb 25 17:09:09 volumio volumio[1232]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 25 17:09:09 volumio volumio[1232]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 25 17:09:09 volumio sudo[2167]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:09 volumio systemd[1]: upmpdcli.service: Succeeded. Feb 25 17:09:09 volumio volumio[1232]: STREAMING PROXY: Starting server on port 3245 Feb 25 17:09:09 volumio volumio[1232]: Node JS runtime: 14 Feb 25 17:09:10 volumio sudo[2173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:09:10 volumio sudo[2173]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:10 volumio sudo[2173]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:10 volumio sudo[2175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:09:10 volumio sudo[2175]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:10 volumio sudo[2175]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:10 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:10 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:10 volumio volumio[1232]: verbose: New Socket.io Connection to 192.168.3.6 from 192.168.3.38 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Feb 25 17:09:10 volumio volumio[1232]: info: Received Get System Info Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:10 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:10 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:10 volumio volumio-remote-updater[916]: No test mode Feb 25 17:09:10 volumio volumio-remote-updater[916]: No alpha test mode Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:10 volumio volumio[1232]: info: Retrieving Cloud Streaming UI Feb 25 17:09:10 volumio volumio[1232]: info: Getting Tidal Cloud Configuration Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:10 volumio volumio[1232]: info: Getting Qobuz Cloud Configuration Feb 25 17:09:10 volumio volumio[1232]: info: Asking plugin for UI Config Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:10 volumio volumio[1232]: info: Getting Spotify Cloud Configuration Feb 25 17:09:10 volumio volumio[1232]: info: Asking plugin for UI Config Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:10 volumio volumio[1232]: info: Saving Spotify Acccount Feb 25 17:09:10 volumio volumio[1232]: info: Got Tidal Cloud Configuration Feb 25 17:09:10 volumio volumio[1232]: info: Got it Feb 25 17:09:10 volumio volumio[1232]: info: Got it Feb 25 17:09:10 volumio volumio[1232]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:10 volumio volumio[1232]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 25 17:09:10 volumio volumio[1232]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 17:09:10 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 17:09:11 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 17:09:11 volumio volumio[1232]: info: Loading i18n strings for locale en Feb 25 17:09:11 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 17:09:11 volumio volumio[1232]: info: Setting timezone to America/Sao_Paulo Feb 25 17:09:11 volumio sudo[2248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 17:09:11 volumio sudo[2248]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:11 volumio sudo[2248]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:11 volumio sudo[2252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Sao_Paulo /etc/localtime Feb 25 17:09:11 volumio sudo[2252]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:11 volumio sudo[2252]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:11 volumio sudo[2264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 17:09:11 volumio sudo[2264]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:11 volumio sudo[2264]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:11 volumio sudo[2286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Sao_Paulo Feb 25 17:09:11 volumio sudo[2286]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:11 volumio dbus-daemon[919]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=2287 comm="/usr/bin/timedatectl set-timezone America/Sao_Paul") Feb 25 17:09:12 volumio systemd[1]: Starting Time & Date Service... Feb 25 17:09:12 volumio dbus-daemon[919]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 25 17:09:12 volumio systemd[1]: Started Time & Date Service. Feb 25 17:09:12 volumio sudo[2286]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:12 volumio volumio[1232]: Updating browse sources language Feb 25 17:09:12 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:12 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 17:09:12 volumio volumio[1232]: info: Fetching Streaming Services browse cache Feb 25 17:09:18 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 17:09:18 volumio volumio[1232]: info: Loading i18n strings for locale pt Feb 25 17:09:24 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 17:09:24 volumio volumio[1232]: info: Setting timezone to America/Sao_Paulo Feb 25 17:09:24 volumio sudo[2321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 17:09:24 volumio sudo[2321]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio sudo[2321]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:24 volumio sudo[2325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Sao_Paulo /etc/localtime Feb 25 17:09:24 volumio sudo[2325]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio sudo[2325]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:24 volumio sudo[2328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 17:09:24 volumio systemd[1]: Starting Daily apt download activities... Feb 25 17:09:24 volumio sudo[2328]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio sudo[2328]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:24 volumio sudo[2331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Sao_Paulo Feb 25 17:09:24 volumio sudo[2331]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio sudo[2331]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:24 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 17:09:24 volumio volumio[1232]: info: Loading i18n strings for locale pt Feb 25 17:09:24 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 17:09:24 volumio volumio[1232]: info: Setting timezone to America/Sao_Paulo Feb 25 17:09:24 volumio sudo[2334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 17:09:24 volumio sudo[2334]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio sudo[2334]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:24 volumio sudo[2337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Sao_Paulo /etc/localtime Feb 25 17:09:24 volumio sudo[2337]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio sudo[2337]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:24 volumio sudo[2340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 17:09:24 volumio sudo[2340]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio sudo[2340]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:24 volumio sudo[2343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Sao_Paulo Feb 25 17:09:24 volumio sudo[2343]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio sudo[2343]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:24 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 25 17:09:24 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 25 17:09:24 volumio sudo[2346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 25 17:09:24 volumio sudo[2346]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:24 volumio volumio-remote-updater[916]: [2025-02-25 20:09:24] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 17:09:26 volumio sudo[2352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 17:09:26 volumio sudo[2352]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:26 volumio sudo[2352]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:26 volumio sudo[2355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:09:26 volumio sudo[2355]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:26 volumio volumio[1232]: info: Fetching Streaming Services browse cache Feb 25 17:09:26 volumio volumio[1232]: info: Fetching Streaming Services browse cache Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::volumioGetBrowseSources Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:26 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:26 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:26 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:26 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:26 volumio volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 25 17:09:26 volumio volumio[1232]: Updating browse sources language Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:26 volumio volumio[1232]: Updating browse sources language Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:26 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 25 17:09:27 volumio sudo[2346]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:27 volumio sudo[2355]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:27 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:27 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:27 volumio volumio[1232]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 25 17:09:27 volumio volumio[1232]: wlan0 Interface doesn't support scanning. Feb 25 17:09:27 volumio volumio[1232]: info: Cannot use regular scanning, forcing with ap-force Feb 25 17:09:27 volumio sudo[2365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:09:27 volumio sudo[2361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 25 17:09:27 volumio sudo[2363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:09:27 volumio sudo[2365]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:27 volumio sudo[2361]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:27 volumio sudo[2363]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:27 volumio sudo[2363]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:27 volumio sudo[2371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 25 17:09:27 volumio sudo[2371]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:27 volumio volumio[1232]: command failed: No such device (-19) Feb 25 17:09:27 volumio volumio[1232]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 25 17:09:27 volumio volumio[1232]: command failed: No such device (-19) Feb 25 17:09:27 volumio sudo[2365]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:27 volumio sudo[2371]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:27 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Feb 25 17:09:27 volumio sudo[2361]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:27 volumio volumio[1232]: info: Upmpdcli Daemon Started Feb 25 17:09:27 volumio volumio[1232]: verbose: New Socket.io Connection to 192.168.3.6 from 192.168.3.38 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 25 17:09:27 volumio volumio[2372]: writing RSA key Feb 25 17:09:27 volumio volumio[1232]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 17:09:27 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:27 volumio volumio[1232]: info: Received Get System Info Feb 25 17:09:27 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:27 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:27 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:27 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:27 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:27 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:29 volumio volumio-remote-updater[916]: [2025-02-25 20:09:29] [connect] Successful connection Feb 25 17:09:29 volumio volumio-remote-updater[916]: [2025-02-25 20:09:29] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740514169 101 Feb 25 17:09:29 volumio volumio[1232]: 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: 5 Feb 25 17:09:29 volumio volumio[1232]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 25 17:09:29 volumio volumio[1232]: info: Completed starting MyVolumio Plugin Feb 25 17:09:29 volumio volumio[1232]: [Metrics] CommandRouter: 57s 804.51ms Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::volumiosetStartupVolume Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 17:09:29 volumio volumio[1232]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 25 17:09:29 volumio volumio[1232]: info: Received Get System Version Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 17:09:29 volumio volumio[1232]: info: Received Get System Info Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:29 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:29 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:29 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:29 volumio sudo[2409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:09:29 volumio sudo[2411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:09:29 volumio sudo[2409]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:29 volumio sudo[2411]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:29 volumio sudo[2409]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:29 volumio sudo[2411]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:29 volumio volumio[1232]: verbose: New Socket.io Connection to 192.168.3.6 from 192.168.3.38 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Feb 25 17:09:30 volumio volumio[1232]: info: Received Get System Info Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:30 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:30 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:30 volumio volumio-remote-updater[916]: No test mode Feb 25 17:09:30 volumio volumio-remote-updater[916]: No alpha test mode Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:30 volumio volumio[1232]: info: Retrieving Cloud Streaming UI Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:30 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:30 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:30 volumio volumio[1232]: info: Getting Tidal Cloud Configuration Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:30 volumio volumio[1232]: info: Getting Qobuz Cloud Configuration Feb 25 17:09:30 volumio volumio[1232]: info: Asking plugin for UI Config Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:30 volumio volumio[1232]: info: Getting Spotify Cloud Configuration Feb 25 17:09:30 volumio volumio[1232]: info: Asking plugin for UI Config Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:30 volumio volumio[1232]: info: Saving Spotify Acccount Feb 25 17:09:30 volumio volumio[1232]: info: Got Tidal Cloud Configuration Feb 25 17:09:30 volumio volumio[1232]: info: Got it Feb 25 17:09:30 volumio volumio[1232]: info: Got it Feb 25 17:09:30 volumio volumio[1232]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:30 volumio volumio[1232]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 25 17:09:30 volumio kernel: snd_hda_intel 0000:00:1b.0: IRQ timing workaround is activated for card #0. Suggest a bigger bdl_pos_adj. Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 25 17:09:30 volumio volumio[1232]: info: Version has changed, forcing UI Reload Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::Reload Ui Feb 25 17:09:30 volumio volumio[1232]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 17:09:30 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 17:09:30 volumio systemd[1]: apt-daily.service: Succeeded. Feb 25 17:09:30 volumio systemd[1]: Started Daily apt download activities. Feb 25 17:09:30 volumio volumio[1232]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 25 17:09:30 volumio sudo[2504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:09:30 volumio sudo[2504]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:30 volumio sudo[2504]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:30 volumio sudo[2506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:09:30 volumio sudo[2506]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:31 volumio sudo[2506]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:31 volumio volumio[1232]: verbose: New Socket.io Connection to 192.168.3.6 from 192.168.3.38 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Feb 25 17:09:31 volumio volumio[1232]: info: Received Get System Info Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:31 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:31 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:31 volumio volumio-remote-updater[916]: No test mode Feb 25 17:09:31 volumio volumio-remote-updater[916]: No alpha test mode Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: info: Retrieving Cloud Streaming UI Feb 25 17:09:31 volumio volumio[1232]: info: Getting Tidal Cloud Configuration Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: info: Getting Qobuz Cloud Configuration Feb 25 17:09:31 volumio volumio[1232]: info: Asking plugin for UI Config Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: info: Getting Spotify Cloud Configuration Feb 25 17:09:31 volumio volumio[1232]: info: Asking plugin for UI Config Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: info: Saving Spotify Acccount Feb 25 17:09:31 volumio volumio[1232]: info: Got Tidal Cloud Configuration Feb 25 17:09:31 volumio volumio[1232]: info: Got it Feb 25 17:09:31 volumio volumio[1232]: info: Got it Feb 25 17:09:31 volumio volumio[1232]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Feb 25 17:09:31 volumio volumio[1232]: info: Received Get System Info Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:09:31 volumio volumio[1232]: info: Discovery: Getting this device information Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Feb 25 17:09:31 volumio volumio[1232]: info: CorePlayQueue::getTrack 0 Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: info: Retrieving Cloud Streaming UI Feb 25 17:09:31 volumio volumio[1232]: info: Getting Tidal Cloud Configuration Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: info: Getting Qobuz Cloud Configuration Feb 25 17:09:31 volumio volumio[1232]: info: Asking plugin for UI Config Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: info: Getting Spotify Cloud Configuration Feb 25 17:09:31 volumio volumio[1232]: info: Asking plugin for UI Config Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: info: Saving Spotify Acccount Feb 25 17:09:31 volumio volumio[1232]: info: Got Tidal Cloud Configuration Feb 25 17:09:31 volumio volumio[1232]: info: Got it Feb 25 17:09:31 volumio volumio[1232]: info: Got it Feb 25 17:09:31 volumio volumio[1232]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:09:31 volumio volumio[1232]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 25 17:09:31 volumio volumio-remote-updater[916]: No test mode Feb 25 17:09:31 volumio volumio-remote-updater[916]: No alpha test mode Feb 25 17:09:31 volumio volumio[1232]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 17:09:31 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 17:09:32 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 17:09:32 volumio volumio[1232]: info: Loading i18n strings for locale en Feb 25 17:09:32 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 17:09:32 volumio volumio[1232]: info: Setting timezone to America/Sao_Paulo Feb 25 17:09:32 volumio sudo[2526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 17:09:32 volumio sudo[2526]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:34 volumio sudo[2526]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:34 volumio sudo[2543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Sao_Paulo /etc/localtime Feb 25 17:09:34 volumio sudo[2543]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:34 volumio sudo[2543]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:34 volumio sudo[2550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 17:09:34 volumio sudo[2550]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:36 volumio sudo[2550]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:36 volumio sudo[2553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Sao_Paulo Feb 25 17:09:36 volumio sudo[2553]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:36 volumio sudo[2553]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:36 volumio volumio[1232]: info: Fetching Streaming Services browse cache Feb 25 17:09:36 volumio volumio[1232]: info: BOOT COMPLETED Feb 25 17:09:36 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 17:09:36 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 17:09:37 volumio volumio[1232]: info: Loading i18n strings for locale en Feb 25 17:09:37 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 17:09:37 volumio volumio[1232]: info: Setting timezone to UTC Feb 25 17:09:37 volumio sudo[2556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 17:09:37 volumio sudo[2556]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:37 volumio sudo[2556]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:37 volumio sudo[2559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime Feb 25 17:09:37 volumio sudo[2559]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:37 volumio sudo[2559]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:37 volumio sudo[2562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 17:09:37 volumio sudo[2562]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:37 volumio sudo[2562]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:37 volumio sudo[2565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Feb 25 17:09:37 volumio sudo[2565]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:37 volumio systemd-timedated[2288]: Failed to set time zone: Permission denied Feb 25 17:09:37 volumio sudo[2565]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:37 volumio volumio[1232]: Failed to set time zone: Access denied Feb 25 17:09:37 volumio volumio[1232]: info: Could not set timezone, retrying Feb 25 17:09:37 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 17:09:37 volumio volumio[1232]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 17:09:37 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 17:09:37 volumio volumio[1232]: Updating browse sources language Feb 25 17:09:37 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:37 volumio volumio[1232]: Updating browse sources language Feb 25 17:09:37 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:37 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 17:09:37 volumio volumio[1232]: info: Loading i18n strings for locale pt Feb 25 17:09:37 volumio volumio[1232]: Updating browse sources language Feb 25 17:09:37 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:09:37 volumio volumio[1232]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 17:09:37 volumio volumio[1232]: info: Setting timezone to America/Sao_Paulo Feb 25 17:09:39 volumio sudo[2568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 17:09:39 volumio sudo[2568]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:39 volumio sudo[2568]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:39 volumio sudo[2583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Sao_Paulo /etc/localtime Feb 25 17:09:39 volumio sudo[2583]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:39 volumio sudo[2583]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:39 volumio sudo[2635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 17:09:39 volumio sudo[2635]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:39 volumio sudo[2635]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:39 volumio sudo[2647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Sao_Paulo Feb 25 17:09:39 volumio sudo[2647]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:39 volumio systemd-timedated[2288]: Failed to set time zone: Permission denied Feb 25 17:09:39 volumio sudo[2647]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:39 volumio volumio[1232]: Failed to set time zone: Access denied Feb 25 17:09:39 volumio volumio[1232]: info: Could not set timezone, retrying Feb 25 17:09:39 volumio volumio[1232]: info: Fetching Streaming Services browse cache Feb 25 17:09:39 volumio volumio[1232]: info: Fetching Streaming Services browse cache Feb 25 17:09:42 volumio sudo[2754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Feb 25 17:09:42 volumio sudo[2754]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:09:42 volumio systemd-timedated[2288]: Failed to set time zone: Permission denied Feb 25 17:09:42 volumio sudo[2754]: pam_unix(sudo:session): session closed for user root Feb 25 17:09:42 volumio volumio[1232]: Failed to set time zone: Access denied Feb 25 17:09:42 volumio volumio[1232]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 17:09:42 volumio volumio[1232]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'UTC' Feb 25 17:09:42 volumio volumio[1232]: Failed to set time zone: Access denied Feb 25 17:09:42 volumio volumio[1232]: at checkExecSyncError (child_process.js:790:11) Feb 25 17:09:42 volumio volumio[1232]: at execSync (child_process.js:863:15) Feb 25 17:09:42 volumio volumio[1232]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9) Feb 25 17:09:42 volumio volumio[1232]: at listOnTimeout (internal/timers.js:557:17) Feb 25 17:09:42 volumio volumio[1232]: at processTimers (internal/timers.js:500:7) { Feb 25 17:09:42 volumio volumio[1232]: status: 1, Feb 25 17:09:42 volumio volumio[1232]: signal: null, Feb 25 17:09:42 volumio volumio[1232]: output: [ null, '', 'Failed to set time zone: Access denied\n' ], Feb 25 17:09:42 volumio volumio[1232]: pid: 2753, Feb 25 17:09:42 volumio volumio[1232]: stdout: '', Feb 25 17:09:42 volumio volumio[1232]: stderr: 'Failed to set time zone: Access denied\n' Feb 25 17:09:42 volumio volumio[1232]: } Feb 25 17:09:42 volumio volumio[1232]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 17:09:42 volumio sudo[2766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-25 17:08 Feb 25 17:09:42 volumio sudo[2766]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"