-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Fri 2025-05-09 12:20:12 UTC. --
May 09 12:19:45 volumio systemd-timedated[1668]: Changed local time to Fri May  9 12:19:45 2025
May 09 12:19:45 volumio volumio[813]: info: Discovery: A device disappeared from network
May 09 12:19:45 volumio volumio[813]: info: Discovery: Device volumio disappeared from network
May 09 12:19:45 volumio sudo[1662]: pam_unix(sudo:session): session closed for user root
May 09 12:19:45 volumio systemd[1]: Starting Daily apt download activities...
May 09 12:19:45 volumio systemd[1]: Starting Daily man-db regeneration...
May 09 12:19:45 volumio volumio-time-update[538]: volumio-time-update-util: System time updated successfully.
May 09 12:19:45 volumio systemd[1]: Started Volumio Time Update Utility.
May 09 12:19:45 volumio volumio[813]: info: Discovery: adding 1fe42d27-d440-48ad-b89c-c0ccfdb49e5b
May 09 12:19:45 volumio volumio[813]: info: Discovery: Found device Volumio
May 09 12:19:45 volumio volumio[813]: info: CoreCommandRouter::volumioGetState
May 09 12:19:45 volumio volumio[813]: info: CorePlayQueue::getTrack 0
May 09 12:19:45 volumio volumio[813]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=tinkerboard&variante=volumio&version=3.779&uuid=3f1ec8390b886c870e31e26a5101e615" http://updates.volumio.org/downloader-v1/track-device
May 09 12:19:45 volumio volumio[813]:   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
May 09 12:19:45 volumio volumio[813]:                                  Dload  Upload   Total   Spent    Left  Speed
May 09 12:19:45 volumio volumio[813]: [132B blob data]
May 09 12:19:45 volumio volumio[813]:  retrying in 5 seconds, trial 0
May 09 12:19:45 volumio volumio[813]: info: Volumio Calling Home
May 09 12:19:45 volumio systemd[1]: man-db.service: Succeeded.
May 09 12:19:45 volumio systemd[1]: Started Daily man-db regeneration.
May 09 12:19:45 volumio nmbd[691]: [2025/05/09 12:19:45.365447,  0] ../lib/util/become_daemon.c:138(daemon_ready)
May 09 12:19:45 volumio kernel: nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead.
May 09 12:19:45 volumio nmbd[691]:   daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
May 09 12:19:45 volumio systemd[1]: Started Samba NMB Daemon.
May 09 12:19:45 volumio systemd[1]: Starting Samba Winbind Daemon...
May 09 12:19:45 volumio winbindd[1716]: [2025/05/09 12:19:45.618361,  0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
May 09 12:19:45 volumio winbindd[1716]:   initialize_winbindd_cache: clearing cache and re-creating with version number 2
May 09 12:19:45 volumio winbindd[1716]: [2025/05/09 12:19:45.658924,  0] ../lib/util/become_daemon.c:138(daemon_ready)
May 09 12:19:45 volumio systemd[1]: Started Samba Winbind Daemon.
May 09 12:19:45 volumio winbindd[1716]:   daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
May 09 12:19:45 volumio systemd[1]: Starting Samba SMB Daemon...
May 09 12:19:45 volumio systemd[1]: apt-daily.service: Succeeded.
May 09 12:19:45 volumio systemd[1]: Started Daily apt download activities.
May 09 12:19:45 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
May 09 12:19:46 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
May 09 12:19:46 volumio systemd[1]: Started Daily apt upgrade and clean activities.
May 09 12:19:46 volumio smbd[1758]: [2025/05/09 12:19:46.309471,  0] ../lib/util/become_daemon.c:138(daemon_ready)
May 09 12:19:46 volumio smbd[1758]:   daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
May 09 12:19:46 volumio systemd[1]: Started Samba SMB Daemon.
May 09 12:19:46 volumio systemd[1]: Reached target Multi-User System.
May 09 12:19:46 volumio systemd[1]: Reached target Graphical Interface.
May 09 12:19:46 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
May 09 12:19:46 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
May 09 12:19:46 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart
May 09 12:19:46 volumio volumio[813]: info: Refreshing Cached IP Addresses
May 09 12:19:46 volumio sudo[1828]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 09 12:19:46 volumio sudo[1825]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
May 09 12:19:46 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
May 09 12:19:46 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
May 09 12:19:46 volumio systemd[1]: Startup finished in 23.374s (kernel) + 25.683s (userspace) = 49.057s.
May 09 12:19:46 volumio sudo[1827]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 09 12:19:46 volumio sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:46 volumio sudo[1825]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:46 volumio sudo[1827]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:46 volumio sudo[1825]: pam_unix(sudo:session): session closed for user root
May 09 12:19:46 volumio systemd[1]: upmpdcli.service: Main process exited, code=killed, status=15/TERM
May 09 12:19:46 volumio systemd[1]: upmpdcli.service: Succeeded.
May 09 12:19:46 volumio sudo[1828]: pam_unix(sudo:session): session closed for user root
May 09 12:19:46 volumio sudo[1827]: pam_unix(sudo:session): session closed for user root
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 09 12:19:46 volumio volumio[813]: info: Adding plugin bluetooth to MyMusic Plugins
May 09 12:19:46 volumio volumio[813]: info: Adding plugin multiroom to MyMusic Plugins
May 09 12:19:46 volumio volumio[813]: info: Adding plugin metavolumio to MyMusic Plugins
May 09 12:19:46 volumio volumio[813]: info: Adding plugin cd_controller to MyMusic Plugins
May 09 12:19:46 volumio volumio[813]: info: Adding plugin smart_inputs to MyMusic Plugins
May 09 12:19:46 volumio volumio[813]: info: Adding plugin tidalconnect to MyMusic Plugins
May 09 12:19:46 volumio volumio[813]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 09 12:19:47 volumio volumio[813]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 09 12:19:47 volumio volumio[813]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 09 12:19:47 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 12:19:47 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 12:19:47 volumio volumio[813]: info: Starting MyVolumio Remote Streaming Endpoints
May 09 12:19:47 volumio volumio[813]: info: MyVolumio not started
May 09 12:19:47 volumio volumio[813]: info: Initializing device activation check
May 09 12:19:47 volumio volumio[813]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 09 12:19:47 volumio volumio[813]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 09 12:19:48 volumio volumio[813]: info: Starting Streaming Service Transparent Proxy
May 09 12:19:48 volumio volumio[813]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 09 12:19:48 volumio volumio[813]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 09 12:19:48 volumio volumio[813]: info: Streaming services startup
May 09 12:19:48 volumio volumio[813]: info: Starting Streaming Daemon
May 09 12:19:48 volumio sudo[1866]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 09 12:19:48 volumio sudo[1866]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:48 volumio volumio[813]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 09 12:19:48 volumio sudo[1866]: pam_unix(sudo:session): session closed for user root
May 09 12:19:48 volumio volumio[813]: info: Volumio called home
May 09 12:19:48 volumio volumio[813]: error: Cannot start Volumio Streaming Daemon
May 09 12:19:48 volumio volumio[813]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 09 12:19:48 volumio volumio[813]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 09 12:19:49 volumio volumio[813]: STREAMING PROXY: Starting server on port 3245
May 09 12:19:49 volumio volumio[813]: Node JS runtime: 14
May 09 12:19:52 volumio volumio[813]: info: Volumio Network Manager: Network status updated: 1
May 09 12:19:52 volumio systemd[1]: systemd-fsckd.service: Succeeded.
May 09 12:19:53 volumio dbus-daemon[541]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.16' (uid=0 pid=1881 comm="/usr/bin/vivaldi --kiosk --no-sandbox --disable-ba")
May 09 12:19:53 volumio systemd[1]: Starting Bluetooth service...
May 09 12:19:53 volumio bluetoothd[1925]: Bluetooth daemon 5.50
May 09 12:19:53 volumio bluetoothd[1925]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
May 09 12:19:53 volumio dbus-daemon[541]: [system] Successfully activated service 'org.bluez'
May 09 12:19:53 volumio systemd[1]: Started Bluetooth service.
May 09 12:19:53 volumio bluetoothd[1925]: Starting SDP server
May 09 12:19:53 volumio bluetoothd[1925]: Excluding (cli) sap
May 09 12:19:53 volumio bluetoothd[1925]: kernel lacks bnep-protocol support
May 09 12:19:53 volumio bluetoothd[1925]: System does not support network plugin
May 09 12:19:53 volumio dbus-daemon[541]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.17' (uid=0 pid=1925 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
May 09 12:19:53 volumio bluetoothd[1925]: Bluetooth management interface 1.10 initialized
May 09 12:19:53 volumio systemd[1]: Starting Hostname Service...
May 09 12:19:53 volumio kernel: IPVS: Creating netns size=1496 id=2
May 09 12:19:53 volumio kernel: IPVS: ftp: loaded support on port[0] = 21
May 09 12:19:53 volumio dbus-daemon[541]: [system] Successfully activated service 'org.freedesktop.hostname1'
May 09 12:19:53 volumio systemd[1]: Started Hostname Service.
May 09 12:19:56 volumio sudo[1952]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 09 12:19:56 volumio sudo[1954]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 09 12:19:56 volumio sudo[1957]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 09 12:19:56 volumio sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:56 volumio sudo[1952]: pam_unix(sudo:session): session closed for user root
May 09 12:19:56 volumio sudo[1954]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:56 volumio sudo[1957]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:56 volumio sudo[1954]: pam_unix(sudo:session): session closed for user root
May 09 12:19:56 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
May 09 12:19:56 volumio sudo[1957]: pam_unix(sudo:session): session closed for user root
May 09 12:19:56 volumio volumio[813]: info: Upmpdcli Daemon Started
May 09 12:19:56 volumio sudo[2006]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 09 12:19:56 volumio sudo[2008]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 09 12:19:56 volumio sudo[2008]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:56 volumio sudo[2006]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:56 volumio volumio[1978]: Generating RSA private key, 4096 bit long modulus (2 primes)
May 09 12:19:56 volumio sudo[2006]: pam_unix(sudo:session): session closed for user root
May 09 12:19:56 volumio sudo[2008]: pam_unix(sudo:session): session closed for user root
May 09 12:19:56 volumio volumio[813]: verbose: New Socket.io Connection to 192.168.2.8 from 192.168.2.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 3
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::volumioGetVisibleSources
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 09 12:19:56 volumio volumio[813]: aplay: device_list:272: no soundcards found...
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 09 12:19:56 volumio volumio[813]: info: Received Get System Info
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 09 12:19:56 volumio volumio[813]: info: Discovery: Getting this device information
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::volumioGetState
May 09 12:19:56 volumio volumio[813]: info: CorePlayQueue::getTrack 0
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 09 12:19:56 volumio volumio-remote-updater[537]: No test mode
May 09 12:19:56 volumio volumio-remote-updater[537]: No alpha test mode
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:19:56 volumio volumio[813]: info: Retrieving Cloud Streaming UI
May 09 12:19:56 volumio volumio[813]: info: Getting Tidal Cloud Configuration
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:19:56 volumio volumio[813]: info: Getting Qobuz Cloud Configuration
May 09 12:19:56 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:19:56 volumio volumio[813]: info: Getting Spotify Cloud Configuration
May 09 12:19:56 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:19:56 volumio volumio[813]: info: Saving Spotify Acccount
May 09 12:19:56 volumio volumio[813]: info: Got Tidal Cloud Configuration
May 09 12:19:56 volumio volumio[813]: info: Got it
May 09 12:19:56 volumio volumio[813]: info: Got it
May 09 12:19:56 volumio volumio[813]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 09 12:19:56 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:19:56 volumio volumio[813]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 09 12:19:57 volumio volumio[1978]: .........++++
May 09 12:19:57 volumio volumio[813]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nSlow down CD read speed
\nFix NAS Mounting
\n
\nNEW ADDITIONS
\n\nRevert  TIDAL Connect to working version
\nFix for USB DAC not recognized after OTA update
\n\n","title":"Update v3.804","updateavailable":true}
May 09 12:19:57 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 09 12:19:57 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 09 12:19:57 volumio volumio[813]: info: Loading i18n strings for locale zh
May 09 12:19:58 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 09 12:19:58 volumio volumio[813]: info: Setting timezone to Asia/Shanghai
May 09 12:19:58 volumio sudo[2059]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 09 12:19:58 volumio sudo[2059]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:58 volumio sudo[2059]: pam_unix(sudo:session): session closed for user root
May 09 12:19:58 volumio sudo[2069]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime
May 09 12:19:58 volumio sudo[2069]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:58 volumio sudo[2069]: pam_unix(sudo:session): session closed for user root
May 09 12:19:58 volumio sudo[2081]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 09 12:19:58 volumio sudo[2081]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:58 volumio sudo[2081]: pam_unix(sudo:session): session closed for user root
May 09 12:19:58 volumio sudo[2103]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
May 09 12:19:58 volumio sudo[2103]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:58 volumio systemd-timedated[1668]: Failed to set time zone: Permission denied
May 09 12:19:58 volumio sudo[2103]: pam_unix(sudo:session): session closed for user root
May 09 12:19:58 volumio volumio[813]: Failed to set time zone: Access denied
May 09 12:19:58 volumio volumio[813]: info: Could not set timezone, retrying
May 09 12:19:58 volumio volumio[813]: Updating browse sources language
May 09 12:19:58 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:19:58 volumio volumio[813]: info: Fetching Streaming Services browse cache
May 09 12:19:58 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 09 12:19:59 volumio sudo[2181]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
May 09 12:19:59 volumio sudo[2181]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:19:59 volumio sudo[2181]: pam_unix(sudo:session): session closed for user root
May 09 12:20:01 volumio volumio[813]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 4
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::volumioGetVisibleSources
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 09 12:20:01 volumio volumio[813]: aplay: device_list:272: no soundcards found...
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 09 12:20:01 volumio volumio[813]: info: Received Get System Info
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 09 12:20:01 volumio volumio[813]: info: Discovery: Getting this device information
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::volumioGetState
May 09 12:20:01 volumio volumio[813]: info: CorePlayQueue::getTrack 0
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 09 12:20:01 volumio volumio-remote-updater[537]: No test mode
May 09 12:20:01 volumio volumio-remote-updater[537]: No alpha test mode
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 09 12:20:01 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 09 12:20:02 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:02 volumio volumio[813]: info: Retrieving Cloud Streaming UI
May 09 12:20:02 volumio volumio[813]: info: Getting Tidal Cloud Configuration
May 09 12:20:02 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:02 volumio volumio[813]: info: Getting Qobuz Cloud Configuration
May 09 12:20:02 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:02 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:02 volumio volumio[813]: info: Getting Spotify Cloud Configuration
May 09 12:20:02 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:02 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:02 volumio volumio[813]: info: Saving Spotify Acccount
May 09 12:20:02 volumio volumio[813]: info: Got Tidal Cloud Configuration
May 09 12:20:02 volumio volumio[813]: info: Got it
May 09 12:20:02 volumio volumio[813]: info: Got it
May 09 12:20:02 volumio volumio[813]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 09 12:20:02 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:02 volumio volumio[813]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 09 12:20:02 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 09 12:20:02 volumio volumio[813]: info: Loading i18n strings for locale zh
May 09 12:20:02 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 09 12:20:02 volumio volumio[813]: info: Setting timezone to Asia/Shanghai
May 09 12:20:02 volumio sudo[2235]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 09 12:20:02 volumio sudo[2235]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:02 volumio sudo[2235]: pam_unix(sudo:session): session closed for user root
May 09 12:20:02 volumio sudo[2245]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime
May 09 12:20:02 volumio sudo[2245]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:02 volumio sudo[2245]: pam_unix(sudo:session): session closed for user root
May 09 12:20:02 volumio sudo[2255]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 09 12:20:02 volumio sudo[2255]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:02 volumio sudo[2255]: pam_unix(sudo:session): session closed for user root
May 09 12:20:03 volumio sudo[2265]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
May 09 12:20:03 volumio sudo[2265]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:03 volumio sudo[2265]: pam_unix(sudo:session): session closed for user root
May 09 12:20:03 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
May 09 12:20:03 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
May 09 12:20:03 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 09 12:20:03 volumio sudo[2275]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 09 12:20:03 volumio volumio[813]: info: Fetching Streaming Services browse cache
May 09 12:20:03 volumio volumio[813]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nSlow down CD read speed
\nFix NAS Mounting
\n
\nNEW ADDITIONS
\n\nRevert  TIDAL Connect to working version
\nFix for USB DAC not recognized after OTA update
\n\n","title":"Update v3.804","updateavailable":true}
May 09 12:20:03 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 09 12:20:03 volumio sudo[2275]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:03 volumio volumio[813]: Updating browse sources language
May 09 12:20:03 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:20:03 volumio volumio[813]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
May 09 12:20:03 volumio sudo[2275]: pam_unix(sudo:session): session closed for user root
May 09 12:20:03 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 09 12:20:03 volumio volumio[813]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
May 09 12:20:03 volumio volumio[813]: wlan0     Interface doesn't support scanning.
May 09 12:20:03 volumio volumio[813]: info: Cannot use regular scanning, forcing with ap-force
May 09 12:20:03 volumio sudo[2287]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
May 09 12:20:03 volumio sudo[2287]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:03 volumio sudo[2287]: pam_unix(sudo:session): session closed for user root
May 09 12:20:03 volumio volumio[813]: command failed: No such device (-19)
May 09 12:20:03 volumio volumio[813]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
May 09 12:20:03 volumio volumio[813]: command failed: No such device (-19)
May 09 12:20:03 volumio volumio[813]: info: CoreCommandRouter::volumioGetState
May 09 12:20:03 volumio volumio[813]: info: CorePlayQueue::getTrack 0
May 09 12:20:04 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 09 12:20:04 volumio volumio[813]: info: Loading i18n strings for locale en
May 09 12:20:04 volumio volumio[813]: Updating browse sources language
May 09 12:20:04 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:20:04 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 09 12:20:04 volumio volumio[813]: info: Setting timezone to UTC
May 09 12:20:04 volumio sudo[2302]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 09 12:20:04 volumio sudo[2302]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:04 volumio sudo[2302]: pam_unix(sudo:session): session closed for user root
May 09 12:20:04 volumio sudo[2312]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime
May 09 12:20:04 volumio sudo[2312]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:04 volumio volumio[1978]: ..........................................................................................................++++
May 09 12:20:04 volumio volumio[1978]: e is 65537 (0x010001)
May 09 12:20:04 volumio sudo[2312]: pam_unix(sudo:session): session closed for user root
May 09 12:20:04 volumio volumio[1978]: writing RSA key
May 09 12:20:04 volumio sudo[2328]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 09 12:20:04 volumio sudo[2328]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:04 volumio sudo[2328]: pam_unix(sudo:session): session closed for user root
May 09 12:20:04 volumio sudo[2338]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
May 09 12:20:04 volumio sudo[2338]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:04 volumio systemd-timedated[1668]: Failed to set time zone: Permission denied
May 09 12:20:04 volumio sudo[2338]: pam_unix(sudo:session): session closed for user root
May 09 12:20:04 volumio volumio[813]: Failed to set time zone: Access denied
May 09 12:20:04 volumio volumio[813]: info: Could not set timezone, retrying
May 09 12:20:04 volumio volumio[813]: info: Fetching Streaming Services browse cache
May 09 12:20:04 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 09 12:20:04 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 12:20:04 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 09 12:20:05 volumio sudo[2356]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
May 09 12:20:05 volumio sudo[2356]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:05 volumio sudo[2356]: pam_unix(sudo:session): session closed for user root
May 09 12:20:07 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 12:20:07 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 12:20:07 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 09 12:20:07 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 09 12:20:07 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 09 12:20:07 volumio volumio[813]: info: CoreCommandRouter::volumioGetBrowseSources
May 09 12:20:07 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices
May 09 12:20:08 volumio volumio[813]: aplay: device_list:272: no soundcards found...
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 09 12:20:08 volumio volumio[813]: error: MyVolumio Plugin failed to authenticate in a timely fashion
May 09 12:20:08 volumio volumio[813]: info: Completed starting MyVolumio Plugin
May 09 12:20:08 volumio volumio[813]:  [Metrics]  CommandRouter:  38s 524.08ms 
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::volumiosetStartupVolume
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::Close All Modals sent
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::Close All Modals sent
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Retrieving Cloud Streaming UI
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Retrieving Cloud Streaming UI
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Retrieving Cloud Streaming UI
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Retrieving Cloud Streaming UI
May 09 12:20:08 volumio volumio[813]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
May 09 12:20:08 volumio volumio[813]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card
May 09 12:20:08 volumio volumio[813]: aplay: main:828: audio open error: No such device
May 09 12:20:08 volumio volumio[813]: info: Getting Tidal Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Getting Qobuz Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Getting Spotify Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Saving Spotify Acccount
May 09 12:20:08 volumio volumio[813]: info: Got Tidal Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Got it
May 09 12:20:08 volumio volumio[813]: info: Got it
May 09 12:20:08 volumio volumio[813]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 09 12:20:08 volumio volumio[813]: info: Getting Tidal Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Getting Qobuz Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Getting Spotify Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Saving Spotify Acccount
May 09 12:20:08 volumio volumio[813]: info: Got Tidal Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Got it
May 09 12:20:08 volumio volumio[813]: info: Got it
May 09 12:20:08 volumio volumio[813]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 09 12:20:08 volumio volumio[813]: info: Getting Tidal Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Getting Qobuz Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Getting Spotify Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Saving Spotify Acccount
May 09 12:20:08 volumio volumio[813]: info: Got Tidal Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Got it
May 09 12:20:08 volumio volumio[813]: info: Got it
May 09 12:20:08 volumio volumio[813]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 09 12:20:08 volumio volumio[813]: info: Getting Tidal Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Getting Qobuz Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Getting Spotify Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: info: Saving Spotify Acccount
May 09 12:20:08 volumio volumio[813]: info: Got Tidal Cloud Configuration
May 09 12:20:08 volumio volumio[813]: info: Got it
May 09 12:20:08 volumio volumio[813]: info: Got it
May 09 12:20:08 volumio volumio[813]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 09 12:20:08 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:08 volumio volumio[813]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 09 12:20:09 volumio volumio[813]: aplay: device_list:272: no soundcards found...
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 09 12:20:09 volumio volumio[813]: info: Version has changed, forcing UI Reload
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::Reload Ui
May 09 12:20:09 volumio sudo[2375]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 09 12:20:09 volumio sudo[2378]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 09 12:20:09 volumio sudo[2375]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:09 volumio sudo[2375]: pam_unix(sudo:session): session closed for user root
May 09 12:20:09 volumio sudo[2378]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:09 volumio sudo[2378]: pam_unix(sudo:session): session closed for user root
May 09 12:20:09 volumio volumio[813]: verbose: New Socket.io Connection to 192.168.2.8 from 192.168.2.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::volumioGetVisibleSources
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 09 12:20:09 volumio volumio[813]: aplay: device_list:272: no soundcards found...
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 09 12:20:09 volumio volumio[813]: info: Received Get System Info
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 09 12:20:09 volumio volumio[813]: info: Discovery: Getting this device information
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::volumioGetState
May 09 12:20:09 volumio volumio[813]: info: CorePlayQueue::getTrack 0
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 09 12:20:09 volumio volumio-remote-updater[537]: No test mode
May 09 12:20:09 volumio volumio-remote-updater[537]: No alpha test mode
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 09 12:20:09 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: info: Retrieving Cloud Streaming UI
May 09 12:20:10 volumio volumio[813]: info: Getting Tidal Cloud Configuration
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: info: Getting Qobuz Cloud Configuration
May 09 12:20:10 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: info: Getting Spotify Cloud Configuration
May 09 12:20:10 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: info: Saving Spotify Acccount
May 09 12:20:10 volumio volumio[813]: info: Got Tidal Cloud Configuration
May 09 12:20:10 volumio volumio[813]: info: Got it
May 09 12:20:10 volumio volumio[813]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 09 12:20:10 volumio volumio[813]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 5
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::volumioGetVisibleSources
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
May 09 12:20:10 volumio volumio[813]: aplay: device_list:272: no soundcards found...
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
May 09 12:20:10 volumio volumio[813]: info: Received Get System Info
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 09 12:20:10 volumio volumio[813]: info: Discovery: Getting this device information
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::volumioGetState
May 09 12:20:10 volumio volumio[813]: info: CorePlayQueue::getTrack 0
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: info: Retrieving Cloud Streaming UI
May 09 12:20:10 volumio volumio[813]: info: Getting Tidal Cloud Configuration
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: info: Getting Qobuz Cloud Configuration
May 09 12:20:10 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: info: Getting Spotify Cloud Configuration
May 09 12:20:10 volumio volumio[813]: info: Asking plugin for UI Config
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: info: Saving Spotify Acccount
May 09 12:20:10 volumio volumio[813]: info: Got Tidal Cloud Configuration
May 09 12:20:10 volumio volumio[813]: info: Got it
May 09 12:20:10 volumio volumio[813]: info: Got it
May 09 12:20:10 volumio volumio[813]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::getUIConfigOnPlugin
May 09 12:20:10 volumio volumio[813]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 09 12:20:10 volumio volumio-remote-updater[537]: No test mode
May 09 12:20:10 volumio volumio-remote-updater[537]: No alpha test mode
May 09 12:20:10 volumio volumio[813]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nSlow down CD read speed
\nFix NAS Mounting
\n
\nNEW ADDITIONS
\n\nRevert  TIDAL Connect to working version
\nFix for USB DAC not recognized after OTA update
\n\n","title":"Update v3.804","updateavailable":true}
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 09 12:20:10 volumio volumio[813]: info: Loading i18n strings for locale zh
May 09 12:20:10 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 09 12:20:10 volumio volumio[813]: info: Setting timezone to Asia/Shanghai
May 09 12:20:11 volumio sudo[2405]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 09 12:20:11 volumio sudo[2405]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:11 volumio sudo[2405]: pam_unix(sudo:session): session closed for user root
May 09 12:20:11 volumio sudo[2415]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime
May 09 12:20:11 volumio sudo[2415]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:11 volumio sudo[2415]: pam_unix(sudo:session): session closed for user root
May 09 12:20:11 volumio sudo[2425]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 09 12:20:11 volumio sudo[2425]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:11 volumio sudo[2425]: pam_unix(sudo:session): session closed for user root
May 09 12:20:11 volumio sudo[2435]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
May 09 12:20:11 volumio sudo[2435]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:11 volumio systemd-timedated[1668]: Failed to set time zone: Permission denied
May 09 12:20:11 volumio sudo[2435]: pam_unix(sudo:session): session closed for user root
May 09 12:20:11 volumio volumio[813]: Failed to set time zone: Access denied
May 09 12:20:11 volumio volumio[813]: info: Could not set timezone, retrying
May 09 12:20:11 volumio volumio[813]: Updating browse sources language
May 09 12:20:11 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:20:11 volumio volumio[813]: info: Fetching Streaming Services browse cache
May 09 12:20:11 volumio volumio[813]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nSlow down CD read speed
\nFix NAS Mounting
\n
\nNEW ADDITIONS
\n\nRevert  TIDAL Connect to working version
\nFix for USB DAC not recognized after OTA update
\n\n","title":"Update v3.804","updateavailable":true}
May 09 12:20:11 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 09 12:20:11 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 09 12:20:11 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
May 09 12:20:11 volumio volumio[813]: info: Loading i18n strings for locale en
May 09 12:20:11 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
May 09 12:20:11 volumio volumio[813]: info: Setting timezone to UTC
May 09 12:20:12 volumio sudo[2445]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
May 09 12:20:12 volumio sudo[2445]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:12 volumio sudo[2445]: pam_unix(sudo:session): session closed for user root
May 09 12:20:12 volumio sudo[2455]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime
May 09 12:20:12 volumio sudo[2455]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:12 volumio sudo[2455]: pam_unix(sudo:session): session closed for user root
May 09 12:20:12 volumio sudo[2465]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
May 09 12:20:12 volumio sudo[2465]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:12 volumio sudo[2465]: pam_unix(sudo:session): session closed for user root
May 09 12:20:12 volumio sudo[2475]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
May 09 12:20:12 volumio sudo[2475]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:12 volumio systemd-timedated[1668]: Failed to set time zone: Permission denied
May 09 12:20:12 volumio sudo[2475]: pam_unix(sudo:session): session closed for user root
May 09 12:20:12 volumio volumio[813]: Failed to set time zone: Access denied
May 09 12:20:12 volumio volumio[813]: info: Could not set timezone, retrying
May 09 12:20:12 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 09 12:20:12 volumio volumio[813]: Updating browse sources language
May 09 12:20:12 volumio volumio[813]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 09 12:20:12 volumio sudo[2499]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
May 09 12:20:12 volumio sudo[2499]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 09 12:20:12 volumio systemd-timedated[1668]: Failed to set time zone: Permission denied
May 09 12:20:12 volumio sudo[2499]: pam_unix(sudo:session): session closed for user root
May 09 12:20:12 volumio volumio[813]: Failed to set time zone: Access denied
May 09 12:20:12 volumio volumio[813]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 09 12:20:12 volumio volumio[813]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Asia/Shanghai'
May 09 12:20:12 volumio volumio[813]: Failed to set time zone: Access denied
May 09 12:20:12 volumio volumio[813]:     at checkExecSyncError (child_process.js:790:11)
May 09 12:20:12 volumio volumio[813]:     at execSync (child_process.js:863:15)
May 09 12:20:12 volumio volumio[813]:     at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9)
May 09 12:20:12 volumio volumio[813]:     at listOnTimeout (internal/timers.js:557:17)
May 09 12:20:12 volumio volumio[813]:     at processTimers (internal/timers.js:500:7) {
May 09 12:20:12 volumio volumio[813]:   status: 1,
May 09 12:20:12 volumio volumio[813]:   signal: null,
May 09 12:20:12 volumio volumio[813]:   output: [ null, '', 'Failed to set time zone: Access denied\n' ],
May 09 12:20:12 volumio volumio[813]:   pid: 2497,
May 09 12:20:12 volumio volumio[813]:   stdout: '',
May 09 12:20:12 volumio volumio[813]:   stderr: 'Failed to set time zone: Access denied\n'
May 09 12:20:12 volumio volumio[813]: }
May 09 12:20:12 volumio volumio[813]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 09 12:20:12 volumio sudo[2517]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 12:19
May 09 12:20:12 volumio sudo[2517]: 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="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:11:38 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_DEVICENAME="Asus Tinkerboard"
VOLUMIO_HASH="932fc3546f7cc8faa2b4d349036752dd"