-- Logs begin at Tue 2025-04-29 20:04:55 +05, end at Tue 2025-04-29 20:06:37 +05. --
Apr 29 20:05:00 smsl-n100 dhcpcd[602]: wlan0: waiting for carrier
Apr 29 20:05:00 smsl-n100 dhcpcd[602]: wlan0: carrier acquired
Apr 29 20:05:00 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:00] [info] asio async_connect error: system:111 (Connection refused)
Apr 29 20:05:00 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 29 20:05:00 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:00] [error] handle_connect error: Underlying Transport Error
Apr 29 20:05:00 smsl-n100 dhcpcd[602]: DUID 00:01:00:01:2f:21:51:15:8a:d0:f8:33:b7:4d
Apr 29 20:05:00 smsl-n100 dhcpcd[602]: wlan0: IAID 2b:ee:c9:2d
Apr 29 20:05:00 smsl-n100 dhcpcd[602]: wlan0: adding address fe80::2af5:2bff:feee:c92d
Apr 29 20:05:00 smsl-n100 dhcpcd[602]: ipv6_addaddr1: Permission denied
Apr 29 20:05:00 smsl-n100 ifup[541]: ifup: waiting for lock on /run/network/ifstate.wlan0
Apr 29 20:05:00 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:00 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:00 smsl-n100 sh[536]: wlan0=wlan0
Apr 29 20:05:00 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:00 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:00 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:00 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:00 smsl-n100 systemd[1]: Started Raise network interfaces.
Apr 29 20:05:00 smsl-n100 systemd[1]: Reached target Network.
Apr 29 20:05:00 smsl-n100 systemd[1]: Starting Network Time Service...
Apr 29 20:05:00 smsl-n100 systemd[1]: Reached target Network is Online.
Apr 29 20:05:00 smsl-n100 systemd[1]: Starting LSB: Brings up/down network automatically...
Apr 29 20:05:00 smsl-n100 dhcpcd[602]: wlan0: soliciting an IPv6 router
Apr 29 20:05:00 smsl-n100 systemd[1]: Starting Samba NMB Daemon...
Apr 29 20:05:00 smsl-n100 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Apr 29 20:05:00 smsl-n100 systemd[1]: Starting /etc/rc.local Compatibility...
Apr 29 20:05:00 smsl-n100 systemd[1]: Starting Music Player Daemon...
Apr 29 20:05:00 smsl-n100 dhcpcd[602]: wlan0: soliciting a DHCP lease
Apr 29 20:05:00 smsl-n100 systemd[1]: Starting Permit User Sessions...
Apr 29 20:05:00 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 29 20:05:00 smsl-n100 ntpd[724]: ntpd 4.2.8p12@1.3728-o (1): Starting
Apr 29 20:05:00 smsl-n100 ntpd[724]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Apr 29 20:05:00 smsl-n100 systemd[1]: Started Network Time Service.
Apr 29 20:05:00 smsl-n100 ntpd[739]: proto: precision = 1.166 usec (-20)
Apr 29 20:05:00 smsl-n100 systemd[1]: Started /etc/rc.local Compatibility.
Apr 29 20:05:00 smsl-n100 ntpd[739]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Apr 29 20:05:00 smsl-n100 ntpd[739]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Apr 29 20:05:00 smsl-n100 ntpd[739]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 854 days ago
Apr 29 20:05:00 smsl-n100 ntpd[739]: Listen and drop on 0 v6wildcard [::]:123
Apr 29 20:05:00 smsl-n100 ntpd[739]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Apr 29 20:05:00 smsl-n100 ntpd[739]: Listen normally on 2 lo 127.0.0.1:123
Apr 29 20:05:00 smsl-n100 ntpd[739]: Listening on routing socket on fd #19 for interface updates
Apr 29 20:05:00 smsl-n100 ntpd[739]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 29 20:05:00 smsl-n100 ntpd[739]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 29 20:05:00 smsl-n100 systemd[1]: Started Permit User Sessions.
Apr 29 20:05:00 smsl-n100 systemd[1]: Starting Terminate Plymouth Boot Screen...
Apr 29 20:05:00 smsl-n100 systemd[1]: Starting Hold until boot process finishes up...
Apr 29 20:05:00 smsl-n100 systemd[1]: Received SIGRTMIN+21 from PID 229 (plymouthd).
Apr 29 20:05:00 smsl-n100 systemd[1]: Received SIGRTMIN+21 from PID 229 (plymouthd).
Apr 29 20:05:00 smsl-n100 systemd[1]: plymouth-quit.service: Succeeded.
Apr 29 20:05:00 smsl-n100 systemd[1]: Started Terminate Plymouth Boot Screen.
Apr 29 20:05:00 smsl-n100 systemd[1]: plymouth-quit-wait.service: Succeeded.
Apr 29 20:05:00 smsl-n100 systemd[1]: Started Hold until boot process finishes up.
Apr 29 20:05:00 smsl-n100 systemd[1]: Started Serial Getty on ttyS2.
Apr 29 20:05:00 smsl-n100 ifplugd(eth0)[756]: ifplugd 0.28 initializing.
Apr 29 20:05:00 smsl-n100 ifplugd(eth0)[756]: Using interface eth0/8A:D0:F8:33:B7:4D with driver (version: Jan_2016)
Apr 29 20:05:00 smsl-n100 ifplugd(eth0)[756]: Using detection mode: SIOCETHTOOL
Apr 29 20:05:00 smsl-n100 ifplugd(eth0)[756]: Initialization complete, link beat not detected.
Apr 29 20:05:00 smsl-n100 systemd[1]: Started Getty on tty1.
Apr 29 20:05:00 smsl-n100 systemd[1]: Reached target Login Prompts.
Apr 29 20:05:00 smsl-n100 sudo[732]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 29 20:05:00 smsl-n100 sudo[732]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:00 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:00 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:00 smsl-n100 sudo[732]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Apr 29 20:05:00 smsl-n100 sudo[732]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 ifplugd[725]: Network Interface Plugging Daemon...start eth0...done.
Apr 29 20:05:01 smsl-n100 systemd[1]: Started LSB: Brings up/down network automatically.
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 ntpd[739]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 nmbd[740]: [2025/04/29 20:05:01.734369, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Apr 29 20:05:01 smsl-n100 nmbd[740]: started asyncdns process 760
Apr 29 20:05:01 smsl-n100 nmbd[740]: [2025/04/29 20:05:01.741512, 0] ../lib/util/become_daemon.c:149(daemon_status)
Apr 29 20:05:01 smsl-n100 nmbd[740]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Apr 29 20:05:01 smsl-n100 nmbd[740]: [2025/04/29 20:05:01.742202, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Apr 29 20:05:01 smsl-n100 nmbd[740]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 wireless.js[501]: Cleaning previous...
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:01 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 sudo[768]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 29 20:05:02 smsl-n100 sudo[768]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:02 smsl-n100 sudo[768]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 sudo[770]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 29 20:05:02 smsl-n100 sudo[770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 dhcpcd[602]: wlan0: carrier lost
Apr 29 20:05:02 smsl-n100 sudo[770]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 systemd[1]: systemd-rfkill.service: Succeeded.
Apr 29 20:05:02 smsl-n100 wireless.js[501]: Stopped aP
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 wireless.js[501]: Wireless Networking DISABLED, not starting wireless flow
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 kernel: vdd_arm: ramp_delay not set
Apr 29 20:05:02 smsl-n100 iwconfig[791]: Error for wireless request "Set Power Management" (8B2C) :
Apr 29 20:05:02 smsl-n100 iwconfig[791]: SET failed on device wlan0 ; Operation not permitted.
Apr 29 20:05:02 smsl-n100 systemd[1]: wireless.service: Succeeded.
Apr 29 20:05:02 smsl-n100 systemd[1]: Started Wireless Services.
Apr 29 20:05:02 smsl-n100 systemd[1]: Started Volumio Backend Module.
Apr 29 20:05:02 smsl-n100 systemd[1]: Started Volumio Cpu Tweaker.
Apr 29 20:05:02 smsl-n100 ntpd[739]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Apr 29 20:05:02 smsl-n100 volumio-cpu-tweak[793]: Setting RT Priority for mpd
Apr 29 20:05:02 smsl-n100 volumio-cpu-tweak[793]: Setting MPD Affinity
Apr 29 20:05:02 smsl-n100 volumio-cpu-tweak[793]: pid 759's current affinity mask: f
Apr 29 20:05:02 smsl-n100 volumio-cpu-tweak[793]: pid 759's new affinity mask: 3
Apr 29 20:05:02 smsl-n100 volumio-cpu-tweak[793]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Apr 29 20:05:02 smsl-n100 volumio-cpu-tweak[793]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Apr 29 20:05:02 smsl-n100 systemd[1]: volumio_cpu_tweak.service: Succeeded.
Apr 29 20:05:03 smsl-n100 ntpd[739]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Apr 29 20:05:04 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:04 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:04 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:04 smsl-n100 ntpd[739]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 29 20:05:05 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:05] [info] asio async_connect error: system:111 (Connection refused)
Apr 29 20:05:05 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 29 20:05:05 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:05] [error] handle_connect error: Underlying Transport Error
Apr 29 20:05:05 smsl-n100 mpd[759]: Apr 29 20:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 29 20:05:06 smsl-n100 systemd[1]: Started Music Player Daemon.
Apr 29 20:05:06 smsl-n100 mpd_monitor.sh[512]: MPD restarted due to no mpc output.
Apr 29 20:05:08 smsl-n100 volumio[792]: info: -------------------------------------------
Apr 29 20:05:08 smsl-n100 volumio[792]: info: ----- Volumio3 ----
Apr 29 20:05:09 smsl-n100 volumio[792]: info: -------------------------------------------
Apr 29 20:05:09 smsl-n100 volumio[792]: info: ----- System startup ----
Apr 29 20:05:09 smsl-n100 volumio[792]: info: -------------------------------------------
Apr 29 20:05:09 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:09 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:09 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:10 smsl-n100 volumio[792]: info: MYVOLUMIO Environment detected
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Plugin folders cleanup
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Scanning into folder /volumio/app/plugins/
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Scanning category audio_interface
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Scanning category miscellanea
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Scanning category music_service
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Scanning category plugins.json
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Scanning category system_controller
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Scanning category user_interface
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Scanning into folder /data/plugins/
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Plugin folders cleanup completed
Apr 29 20:05:11 smsl-n100 volumio[792]: info: -------------------------------------------
Apr 29 20:05:11 smsl-n100 volumio[792]: info: ----- Core plugins startup ----
Apr 29 20:05:11 smsl-n100 volumio[792]: info: -------------------------------------------
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Loading plugins from folder /volumio/app/plugins/
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin multiroom to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin upnp to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin raat to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin smart_inputs to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin tidalconnect to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Loading plugins from folder /data/plugins/
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Loading plugin "system"...
Apr 29 20:05:11 smsl-n100 volumio[792]: info: Loading plugin "appearance"...
Apr 29 20:05:12 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:12] [connect] Successful connection
Apr 29 20:05:13 smsl-n100 volumio[792]: info: Loading plugin "network"...
Apr 29 20:05:13 smsl-n100 volumio[792]: info: Refreshing Cached IP Addresses
Apr 29 20:05:13 smsl-n100 sudo[837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 29 20:05:13 smsl-n100 sudo[837]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:13 smsl-n100 sudo[837]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:13 smsl-n100 volumio[792]: info: Loading plugin "services"...
Apr 29 20:05:13 smsl-n100 sudo[839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 29 20:05:13 smsl-n100 sudo[839]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:13 smsl-n100 volumio[792]: info: Loading plugin "alsa_controller"...
Apr 29 20:05:13 smsl-n100 sudo[839]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 20:05:13 smsl-n100 volumio[792]: info: Loading plugin "wizard"...
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Loading plugin "networkfs"...
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Starting Udev Watcher for removable devices
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Ignoring mount for partition: boot
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Ignoring mount for partition: volumio
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Ignoring mount for partition: volumio_data
Apr 29 20:05:14 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Loading plugin "volumio_command_line_client"...
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Loading plugin "upnp"...
Apr 29 20:05:14 smsl-n100 volumio[792]: info: [1745939114154] Starting Upmpd Daemon
Apr 29 20:05:14 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Loading plugin "my_music"...
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Loading plugin "mpd"...
Apr 29 20:05:14 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:14 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:14 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:14 smsl-n100 volumio[792]: info: Loading plugin "upnp_browser"...
Apr 29 20:05:15 smsl-n100 volumio[792]: info: Plugin bluetooth is not enabled
Apr 29 20:05:15 smsl-n100 volumio[792]: info: Loading plugin "alarm-clock"...
Apr 29 20:05:16 smsl-n100 volumio[792]: info: Loading plugin "manifestui"...
Apr 29 20:05:16 smsl-n100 volumio[792]: info: Loading plugin "metavolumio"...
Apr 29 20:05:19 smsl-n100 volumio[792]: info: Loading plugin "airplay_emulation"...
Apr 29 20:05:19 smsl-n100 volumio[792]: info: Starting Shairport Sync
Apr 29 20:05:19 smsl-n100 volumio[792]: info: Loading plugin "cd_controller"...
Apr 29 20:05:19 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:19 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:19 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:19 smsl-n100 volumio[792]: info: Loading plugin "last_100"...
Apr 29 20:05:19 smsl-n100 volumio[792]: info: Loading plugin "raat"...
Apr 29 20:05:20 smsl-n100 volumio[792]: info: RAAT Plugin loaded
Apr 29 20:05:20 smsl-n100 volumio[792]: info: Adding restartRAATSocket REST API Endpoint
Apr 29 20:05:20 smsl-n100 volumio[792]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat
Apr 29 20:05:20 smsl-n100 volumio[792]: info: Loading plugin "streaming_services"...
Apr 29 20:05:22 smsl-n100 volumio[792]: info: Starting Streaming Service Transparent Proxy
Apr 29 20:05:22 smsl-n100 volumio[792]: info: Loading plugin "tidalconnect"...
Apr 29 20:05:22 smsl-n100 volumio[792]: info: Loading plugin "webradio"...
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Loading plugin "i2s_dacs"...
Apr 29 20:05:23 smsl-n100 volumio[792]: info: I2S DAC not set, start Auto-detection
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Loading plugin "volumiodiscovery"...
Apr 29 20:05:23 smsl-n100 volumio[792]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 29 20:05:23 smsl-n100 node[792]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 29 20:05:23 smsl-n100 node[792]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 29 20:05:23 smsl-n100 volumio[792]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 29 20:05:23 smsl-n100 volumio[792]: *** WARNING *** For more information see
Apr 29 20:05:23 smsl-n100 volumio[792]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 29 20:05:23 smsl-n100 volumio[792]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 29 20:05:23 smsl-n100 volumio[792]: *** WARNING *** For more information see
Apr 29 20:05:23 smsl-n100 node[792]: *** WARNING *** For more information see
Apr 29 20:05:23 smsl-n100 node[792]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 29 20:05:23 smsl-n100 node[792]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 29 20:05:23 smsl-n100 node[792]: *** WARNING *** For more information see
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Discovery: Started advertising with name: SMSL N100
Apr 29 20:05:23 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Plugin multiroom is not enabled
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Loading plugin "outputs"...
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Loading plugin "albumart"...
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Plugin example_plugin is not enabled
Apr 29 20:05:23 smsl-n100 volumio[792]: info: Loading plugin "hi_res_audio"...
Apr 29 20:05:24 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:24 smsl-n100 volumio[792]: Forking 3 albumart workers
Apr 29 20:05:24 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:24 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:25 smsl-n100 volumio[792]: STREAMING PROXY: Starting server on port 3245
Apr 29 20:05:25 smsl-n100 volumio[792]: Node JS runtime: 14
Apr 29 20:05:26 smsl-n100 volumio[792]: Starting albumart workers
Apr 29 20:05:26 smsl-n100 volumio[792]: Starting albumart workers
Apr 29 20:05:26 smsl-n100 volumio[792]: Starting albumart workers
Apr 29 20:05:27 smsl-n100 systemd[1]: systemd-fsckd.service: Succeeded.
Apr 29 20:05:27 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:27] [connect] Successful connection
Apr 29 20:05:27 smsl-n100 volumio[792]: info: Applying required configuration parameters for plugin hi_res_audio
Apr 29 20:05:27 smsl-n100 volumio[792]: info: Loading plugin "inputs"...
Apr 29 20:05:27 smsl-n100 sh[467]: timed out
Apr 29 20:05:27 smsl-n100 sh[467]: dhcpcd exited
Apr 29 20:05:27 smsl-n100 dhcpcd[490]: timed out
Apr 29 20:05:27 smsl-n100 sh[467]: ifup: failed to bring up eth0
Apr 29 20:05:27 smsl-n100 systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Apr 29 20:05:27 smsl-n100 dhcpcd[490]: dhcpcd exited
Apr 29 20:05:27 smsl-n100 systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Apr 29 20:05:29 smsl-n100 volumio[792]: info: Loading plugin "qobuz"...
Apr 29 20:05:29 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:29 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:29 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:31 smsl-n100 volumio[792]: info: Loading plugin "smart_inputs"...
Apr 29 20:05:32 smsl-n100 volumio[792]: info: Loading plugin "tidal"...
Apr 29 20:05:34 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:34 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:34 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:35 smsl-n100 volumio[792]: info: Loading plugin "oem_helper"...
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Applying required configuration parameters for plugin oem_helper
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Loading plugin "smslcontrol"...
Apr 29 20:05:37 smsl-n100 kernel: gpio gpiochip0: Persistence not supported for GPIO 5
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Adding this device properties
Apr 29 20:05:37 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Setting Additional Device Volumio Properties: [object Object]
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Loading plugin "updater_comm"...
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Plugin mpdemulation is not enabled
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Loading plugin "rest_api"...
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Loading plugin "websocket"...
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Starting Socket.io Server version 2.3.0
Apr 29 20:05:37 smsl-n100 volumio[792]: info: Loading i18n strings for locale ru
Apr 29 20:05:37 smsl-n100 volumio[792]: Updating browse sources language
Apr 29 20:05:37 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::initPlayerControls
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 20:05:38 smsl-n100 volumio[792]: Express server listening on port 3000
Apr 29 20:05:38 smsl-n100 volumio[792]: [Metrics] WebUI: 30s 679.12ms
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreStateMachine::resetVolumioState
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreStateMachine::getcurrentVolume
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioRetrievevolume
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:38 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:05:38 smsl-n100 sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 29 20:05:38 smsl-n100 sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:38 smsl-n100 sudo[997]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:38 smsl-n100 sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 29 20:05:38 smsl-n100 volumio[792]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 29 20:05:38 smsl-n100 sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:38 smsl-n100 volumio[792]: info: Completed loading Core Plugins
Apr 29 20:05:38 smsl-n100 volumio[792]: info: Preparing to generate the ALSA configuration file
Apr 29 20:05:38 smsl-n100 sudo[999]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:38 smsl-n100 volumio[792]: info: Volumio Network Manager: Network status updated: 0
Apr 29 20:05:38 smsl-n100 volumio[792]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Reloading queue from file
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Asound.conf file unchanged, so no further update is needed
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Output device has changed, restarting MPD
Apr 29 20:05:39 smsl-n100 sudo[1007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Output device has changed, restarting Shairport Sync
Apr 29 20:05:39 smsl-n100 sudo[1007]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:05:39 smsl-n100 sudo[1007]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:39 smsl-n100 sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 29 20:05:39 smsl-n100 sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:39 smsl-n100 systemd[1]: Stopping Music Player Daemon...
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 29 20:05:39 smsl-n100 volumio[792]: info: ___________ START PLUGINS ___________
Apr 29 20:05:39 smsl-n100 volumio[792]: info: ControllerMpd::onStart: Initializing MPD
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Creating MPD Configuration file
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 20:05:39 smsl-n100 sudo[1016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 29 20:05:39 smsl-n100 volumio[792]: info: [1745939139333] CoreMusicLibrary::Adding element Медиа-Ñерверы
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 20:05:39 smsl-n100 sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:39 smsl-n100 sudo[1016]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:39 smsl-n100 sudo[1018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 29 20:05:39 smsl-n100 sudo[1018]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Adding METAVOLUMIO REST API Endpoints
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:05:39 smsl-n100 systemd[1]: mpd.service: Succeeded.
Apr 29 20:05:39 smsl-n100 systemd[1]: Stopped Music Player Daemon.
Apr 29 20:05:39 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:39 smsl-n100 systemd[1]: Starting Music Player Daemon...
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:05:39 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:39 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Preparing CD Folders
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Adding CD REST API Endpoints
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Starting UDEV Watcher for CD
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Detecting CD presence with UDEV
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 29 20:05:39 smsl-n100 volumio[792]: info: [1745939139680] CoreMusicLibrary::Adding element Last_100
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Starting RAAT Plugin
Apr 29 20:05:39 smsl-n100 sudo[1028]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 29 20:05:39 smsl-n100 sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:39 smsl-n100 sudo[1028]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Additional UI Settings Added for plugin music_service/raat
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Registering DSP Elements listener and retrieving current ones
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Additional DSP elements updated
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Updating RAAT Signal Path
Apr 29 20:05:39 smsl-n100 volumio[792]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Streaming services startup
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Starting Streaming Daemon
Apr 29 20:05:39 smsl-n100 sudo[1038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 29 20:05:39 smsl-n100 sudo[1038]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:39 smsl-n100 sudo[1038]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 29 20:05:39 smsl-n100 volumio[792]: info: [1745939139934] CoreMusicLibrary::Adding element Webradio
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 20:05:39 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 20:05:39 smsl-n100 sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Apr 29 20:05:39 smsl-n100 volumio[792]: info: Initializing BBC Radios
Apr 29 20:05:39 smsl-n100 sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:40 smsl-n100 sudo[1045]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:40 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 20:05:40 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:05:40 smsl-n100 volumio[792]: error: Hi Res Audio Failed Login: Missing Login Data
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Adding HIGHRESAUDIO REST API Endpoints
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Initializing Serial Communication on port /dev/ttyS1
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Touch Event Listener Process Starting
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Refreshing QOBUZ token
Apr 29 20:05:40 smsl-n100 sudo[1059]: pam_unix(sudo:auth): conversation failed
Apr 29 20:05:40 smsl-n100 sudo[1059]: pam_unix(sudo:auth): auth could not identify password for [volumio]
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Adding inputs REST Endpoints
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Scanning Audio Inputs
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Checking against Known Cards name
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Adding Server instance for streaming
Apr 29 20:05:40 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 20:05:40 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Initializing GPIOs
Apr 29 20:05:40 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 1
Apr 29 20:05:40 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 15
Apr 29 20:05:40 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 0
Apr 29 20:05:40 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 2
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Starting Button Listener
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Turning off Green LED
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Tuning on Blue LED
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Signaling System Ready
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Volumio Calling Home
Apr 29 20:05:40 smsl-n100 volumio[792]: (node:792) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead.
Apr 29 20:05:40 smsl-n100 volumio[792]: (Use `node --trace-deprecation ...` to show where the warning was created)
Apr 29 20:05:40 smsl-n100 volumio[792]: info: Stopping AccessToken refresher cron
Apr 29 20:05:41 smsl-n100 volumio[792]: info: AccessToken refresher cron started
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Adding TIDAL REST API Endpoints
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::setRepeat null single undefined
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::setRandom null
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Setting Device type: NanoPi NEO 3
Apr 29 20:05:41 smsl-n100 volumio[792]: Unhandled rejection Error: No sockets available, cannot start.
Apr 29 20:05:41 smsl-n100 volumio[792]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Apr 29 20:05:41 smsl-n100 volumio[792]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Apr 29 20:05:41 smsl-n100 volumio[792]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Apr 29 20:05:41 smsl-n100 volumio[792]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Apr 29 20:05:41 smsl-n100 volumio[792]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Apr 29 20:05:41 smsl-n100 volumio[792]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Apr 29 20:05:41 smsl-n100 volumio[792]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Apr 29 20:05:41 smsl-n100 volumio[792]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Apr 29 20:05:41 smsl-n100 volumio[792]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12)
Apr 29 20:05:41 smsl-n100 volumio[792]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Apr 29 20:05:41 smsl-n100 volumio[792]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Apr 29 20:05:41 smsl-n100 volumio[792]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Apr 29 20:05:41 smsl-n100 volumio[792]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Apr 29 20:05:41 smsl-n100 volumio[792]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Apr 29 20:05:41 smsl-n100 volumio[792]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Apr 29 20:05:41 smsl-n100 volumio[792]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Serial port opened successfully
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Sending serial start messages
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Reporting MCU Network Status: 0
Apr 29 20:05:41 smsl-n100 volumio[792]: warn: QOBUZ login failed: No access token received
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Stopping AccessToken refresher cron for QOBUZ
Apr 29 20:05:41 smsl-n100 volumio[792]: info: AccessToken refresher cron started for QOBUZ
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Adding QOBUZ REST API Endpoints
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Touch Event Listener Process Closed
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Cannot start Volumio Streaming Daemon
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 29 20:05:41 smsl-n100 volumio[792]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 29 20:05:41 smsl-n100 volumio[792]: info: RAAT Albumart path created successfully
Apr 29 20:05:41 smsl-n100 volumio[792]: info: MPD Permissions set
Apr 29 20:05:41 smsl-n100 volumio[792]: info: MPD Permissions set
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Setting Device Volume Override
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Apr 29 20:05:41 smsl-n100 volumio[792]: info: Disabling external Volume Control
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: MAXVOL, message:
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:41 smsl-n100 volumio[792]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:41 smsl-n100 sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 29 20:05:41 smsl-n100 sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: MAXVOL, message:
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:41 smsl-n100 volumio[792]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: MAXVOL, message:
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:41 smsl-n100 volumio[792]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 0, message: undefined
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:41 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:41 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 29 20:05:41 smsl-n100 sudo[1092]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:41 smsl-n100 volumio[792]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:41 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:42 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:42 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: MAXVOL, message:
Apr 29 20:05:42 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:42 smsl-n100 volumio[792]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Apr 29 20:05:42 smsl-n100 volumio[792]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Apr 29 20:05:42 smsl-n100 volumio[792]: info: Upmpdcli Daemon Started
Apr 29 20:05:42 smsl-n100 volumio[792]: info: Starting Shairport Sync
Apr 29 20:05:42 smsl-n100 volumio[792]: info: Starting Shairport Sync
Apr 29 20:05:42 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:42] [connect] Successful connection
Apr 29 20:05:42 smsl-n100 volumio[792]: info: Starting Shairport Sync
Apr 29 20:05:42 smsl-n100 sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 29 20:05:42 smsl-n100 sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:42 smsl-n100 sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 29 20:05:42 smsl-n100 sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:42 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 29 20:05:42 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:42 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: MAXVOL, message:
Apr 29 20:05:42 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:42 smsl-n100 volumio[792]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Apr 29 20:05:42 smsl-n100 systemd[1]: shairport-sync.service: Succeeded.
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:42 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:42 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:42 smsl-n100 sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 29 20:05:42 smsl-n100 sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:42 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 29 20:05:42 smsl-n100 sudo[1110]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:42 smsl-n100 sudo[1108]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioGetState
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:42 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 29 20:05:42 smsl-n100 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Apr 29 20:05:42 smsl-n100 systemd[1]: shairport-sync.service: Succeeded.
Apr 29 20:05:42 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioGetState
Apr 29 20:05:42 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:42 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 29 20:05:42 smsl-n100 sudo[1114]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:42 smsl-n100 volumio[792]: info: Shairport-Sync Started
Apr 29 20:05:42 smsl-n100 volumio[792]: Error adding Membership: Error: addMembership EINVAL
Apr 29 20:05:42 smsl-n100 volumio[792]: info: Shairport-Sync Started
Apr 29 20:05:43 smsl-n100 volumio-remote-updater[506]: [2025-04-29 20:05:43] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745939142 101
Apr 29 20:05:43 smsl-n100 volumio[792]: 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
Apr 29 20:05:43 smsl-n100 volumio[792]: info: Shairport-Sync Started
Apr 29 20:05:43 smsl-n100 volumio[792]: info: TidalConnect service stoped!
Apr 29 20:05:43 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:43 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:43 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:43 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:43 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: MAXVOL, message:
Apr 29 20:05:43 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:05:43 smsl-n100 volumio[792]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Apr 29 20:05:43 smsl-n100 volumio[792]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Apr 29 20:05:43 smsl-n100 volumio[792]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Apr 29 20:05:43 smsl-n100 sudo[1129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Apr 29 20:05:43 smsl-n100 sudo[1129]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:05:43 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service.
Apr 29 20:05:43 smsl-n100 sudo[1129]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:44 smsl-n100 volumio[792]: info: Executing endpoint tc_getconfig
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Apr 29 20:05:44 smsl-n100 vtcs[1131]: STARTING TidalConnect services, version: 1.4.0.34
Apr 29 20:05:44 smsl-n100 vtcs[1131]: STARTED TidalConnect services.
Apr 29 20:05:44 smsl-n100 volumio[792]: info: Executing endpoint tc_connect
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Apr 29 20:05:44 smsl-n100 volumio[792]: info: Connecting to TidalConnect
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CoreCommandRouter::servicePushState
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:44 smsl-n100 volumio[792]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CoreCommandRouter::servicePushState
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:05:44 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:05:44 smsl-n100 volumio[792]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect
Apr 29 20:05:44 smsl-n100 mpd[1036]: Apr 29 20:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 29 20:05:44 smsl-n100 systemd[1]: Started Music Player Daemon.
Apr 29 20:05:44 smsl-n100 volumio[792]: Upnp client error: Error: This socket has been ended by the other party
Apr 29 20:05:44 smsl-n100 sudo[1018]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:44 smsl-n100 sudo[1009]: pam_unix(sudo:session): session closed for user root
Apr 29 20:05:44 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:44 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:44 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:44 smsl-n100 volumio[792]: error: MPD error: The expression evaluated to a falsy value:
Apr 29 20:05:44 smsl-n100 volumio[792]: assert.ok(self.idling)
Apr 29 20:05:44 smsl-n100 volumio[792]: error: The expression evaluated to a falsy value:
Apr 29 20:05:44 smsl-n100 volumio[792]: assert.ok(self.idling)
Apr 29 20:05:44 smsl-n100 volumio[792]: error: updateQueue error: null
Apr 29 20:05:44 smsl-n100 volumio[792]: info: MPD running with PID1036
Apr 29 20:05:44 smsl-n100 volumio[792]: ,establishing connection
Apr 29 20:05:44 smsl-n100 volumio[792]: error: updateQueue error: null
Apr 29 20:05:46 smsl-n100 volumio[792]: info: TidalConnect service started!
Apr 29 20:05:46 smsl-n100 volumio[792]: info: Completed starting Core Plugins
Apr 29 20:05:46 smsl-n100 volumio[792]: info: -------------------------------------------
Apr 29 20:05:46 smsl-n100 volumio[792]: info: ----- MyVolumio plugins startup ----
Apr 29 20:05:46 smsl-n100 volumio[792]: info: -------------------------------------------
Apr 29 20:05:46 smsl-n100 volumio[792]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 29 20:05:49 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:49 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:49 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:51 smsl-n100 volumio[792]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=nanopineo3&variante=smsl&version=3.789&uuid=b615370aecd3609009ecd0e7dfda51cc" http://updates.volumio.org/downloader-v1/track-device
Apr 29 20:05:51 smsl-n100 volumio[792]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 29 20:05:51 smsl-n100 volumio[792]: Dload Upload Total Spent Left Speed
Apr 29 20:05:51 smsl-n100 volumio[792]: [132B blob data]
Apr 29 20:05:51 smsl-n100 volumio[792]: retrying in 5 seconds, trial 0
Apr 29 20:05:51 smsl-n100 volumio[792]: info: Volumio Calling Home
Apr 29 20:05:54 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:54 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:54 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:05:59 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:05:59 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:05:59 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:06:01 smsl-n100 volumio[792]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=nanopineo3&variante=smsl&version=3.789&uuid=b615370aecd3609009ecd0e7dfda51cc" http://updates.volumio.org/downloader-v1/track-device
Apr 29 20:06:01 smsl-n100 volumio[792]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 29 20:06:01 smsl-n100 volumio[792]: Dload Upload Total Spent Left Speed
Apr 29 20:06:01 smsl-n100 volumio[792]: [132B blob data]
Apr 29 20:06:01 smsl-n100 volumio[792]: retrying in 5 seconds, trial 1
Apr 29 20:06:01 smsl-n100 volumio[792]: info: Volumio Calling Home
Apr 29 20:06:04 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:06:04 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:06:04 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:06:06 smsl-n100 volumio[792]: error: MyVolumio Plugin failed to start in a timely fashion
Apr 29 20:06:06 smsl-n100 volumio[792]: [Metrics] CommandRouter: 57s 495.43ms
Apr 29 20:06:06 smsl-n100 volumio[792]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 29 20:06:06 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:06 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:06:06 smsl-n100 volumio[792]: info: CoreCommandRouter::Close All Modals sent
Apr 29 20:06:06 smsl-n100 volumio[792]: info: CoreCommandRouter::Close All Modals sent
Apr 29 20:06:06 smsl-n100 ntpd[739]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Apr 29 20:06:07 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 29 20:06:07 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 29 20:06:07 smsl-n100 ntpd[739]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Apr 29 20:06:07 smsl-n100 ntpd[739]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Apr 29 20:06:07 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 29 20:06:08 smsl-n100 ntpd[739]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 29 20:06:09 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:06:09 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:06:09 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:06:10 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 20:06:10 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 20:06:10 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 29 20:06:11 smsl-n100 volumio[792]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=nanopineo3&variante=smsl&version=3.789&uuid=b615370aecd3609009ecd0e7dfda51cc" http://updates.volumio.org/downloader-v1/track-device
Apr 29 20:06:11 smsl-n100 volumio[792]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 29 20:06:11 smsl-n100 volumio[792]: Dload Upload Total Spent Left Speed
Apr 29 20:06:11 smsl-n100 volumio[792]: [132B blob data]
Apr 29 20:06:11 smsl-n100 volumio[792]: retrying in 5 seconds, trial 2
Apr 29 20:06:11 smsl-n100 volumio[792]: info: Volumio Calling Home
Apr 29 20:06:13 smsl-n100 volumio[792]: info: BOOT COMPLETED
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 20:06:13 smsl-n100 volumio[792]: info: Not Reporting Auto name since its the default one
Apr 29 20:06:13 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Apr 29 20:06:14 smsl-n100 sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Apr 29 20:06:14 smsl-n100 sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:06:14 smsl-n100 sudo[1292]: pam_unix(sudo:session): session closed for user root
Apr 29 20:06:14 smsl-n100 sudo[1294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Apr 29 20:06:14 smsl-n100 sudo[1294]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 20:06:14 smsl-n100 systemd[1]: Started RAAT DAEMON.
Apr 29 20:06:14 smsl-n100 sudo[1294]: pam_unix(sudo:session): session closed for user root
Apr 29 20:06:14 smsl-n100 volumio[792]: info: Raat Daemon started successfully
Apr 29 20:06:14 smsl-n100 volumio[792]: info: Executing endpoint restartRAATSocket
Apr 29 20:06:14 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Apr 29 20:06:14 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:06:14 smsl-n100 volumio[792]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Apr 29 20:06:14 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:06:14 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:06:14 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:06:17 smsl-n100 volumio[792]: info: RAAT: Requesting Headphone Status
Apr 29 20:06:17 smsl-n100 volumio[792]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Apr 29 20:06:17 smsl-n100 volumio[792]: info: CoreStateMachine::pushState
Apr 29 20:06:17 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:06:17 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioPushState
Apr 29 20:06:17 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:06:17 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: MAXVOL, message:
Apr 29 20:06:17 smsl-n100 volumio[792]: error: Serial API: Failed to decode command: 100, message: undefined
Apr 29 20:06:17 smsl-n100 volumio[792]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Apr 29 20:06:19 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:06:19 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:06:19 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:06:24 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:06:24 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:06:24 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:06:29 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:06:30 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:06:30 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:06:30 smsl-n100 systemd[1]: nmbd.service: Start operation timed out. Terminating.
Apr 29 20:06:30 smsl-n100 systemd[1]: nmbd.service: Main process exited, code=killed, status=15/TERM
Apr 29 20:06:30 smsl-n100 systemd[1]: nmbd.service: Failed with result 'timeout'.
Apr 29 20:06:30 smsl-n100 systemd[1]: Failed to start Samba NMB Daemon.
Apr 29 20:06:30 smsl-n100 systemd[1]: Starting Samba Winbind Daemon...
Apr 29 20:06:31 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
Apr 29 20:06:31 smsl-n100 dhcpcd[602]: eth0: carrier acquired
Apr 29 20:06:31 smsl-n100 dhcpcd[602]: eth0: IAID f8:33:b7:4d
Apr 29 20:06:31 smsl-n100 dhcpcd[602]: eth0: adding address fe80::88d0:f8ff:fe33:b74d
Apr 29 20:06:31 smsl-n100 dhcpcd[602]: ipv6_addaddr1: Permission denied
Apr 29 20:06:31 smsl-n100 ifplugd(eth0)[756]: Link beat detected.
Apr 29 20:06:31 smsl-n100 winbindd[1361]: [2025/04/29 20:06:31.141726, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Apr 29 20:06:31 smsl-n100 winbindd[1361]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Apr 29 20:06:31 smsl-n100 dhcpcd[602]: eth0: soliciting an IPv6 router
Apr 29 20:06:31 smsl-n100 winbindd[1361]: [2025/04/29 20:06:31.170400, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 29 20:06:31 smsl-n100 winbindd[1361]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Apr 29 20:06:31 smsl-n100 systemd[1]: Started Samba Winbind Daemon.
Apr 29 20:06:31 smsl-n100 systemd[1]: Starting Samba SMB Daemon...
Apr 29 20:06:31 smsl-n100 ifplugd(eth0)[756]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Apr 29 20:06:31 smsl-n100 ifplugd(eth0)[756]: client: sending commands to master dhcpcd process
Apr 29 20:06:31 smsl-n100 dhcpcd[1386]: sending commands to master dhcpcd process
Apr 29 20:06:31 smsl-n100 dhcpcd[602]: control command: /sbin/dhcpcd eth0
Apr 29 20:06:31 smsl-n100 dhcpcd[602]: eth0: rebinding lease of 192.168.1.126
Apr 29 20:06:31 smsl-n100 dhcpcd[602]: eth0: probing address 192.168.1.126/24
Apr 29 20:06:31 smsl-n100 ifplugd(eth0)[756]: Program executed successfully.
Apr 29 20:06:31 smsl-n100 winbindd[1361]: [2025/04/29 20:06:31.916995, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv)
Apr 29 20:06:31 smsl-n100 winbindd[1361]: res_names->count = 3, expected 4
Apr 29 20:06:31 smsl-n100 smbd[1369]: [2025/04/29 20:06:31.948500, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 29 20:06:31 smsl-n100 smbd[1369]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Apr 29 20:06:31 smsl-n100 systemd[1]: Started Samba SMB Daemon.
Apr 29 20:06:35 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Fetching time from Volumio...
Apr 29 20:06:35 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Date not found in response
Apr 29 20:06:35 smsl-n100 volumio-time-update[524]: volumio-time-update-util: Retrying in 5 seconds...
Apr 29 20:06:35 smsl-n100 dhcpcd[602]: eth0: leased 192.168.1.126 for 86400 seconds
Apr 29 20:06:35 smsl-n100 avahi-daemon[517]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.126.
Apr 29 20:06:35 smsl-n100 avahi-daemon[517]: New relevant interface eth0.IPv4 for mDNS.
Apr 29 20:06:35 smsl-n100 dhcpcd[602]: eth0: adding route to 192.168.1.0/24
Apr 29 20:06:35 smsl-n100 dhcpcd[602]: eth0: adding default route via 192.168.1.1
Apr 29 20:06:35 smsl-n100 avahi-daemon[517]: Registering new address record for 192.168.1.126 on eth0.IPv4.
Apr 29 20:06:36 smsl-n100 ntpd[739]: ntpd exiting on signal 15 (Terminated)
Apr 29 20:06:36 smsl-n100 systemd[1]: Stopping Network Time Service...
Apr 29 20:06:36 smsl-n100 systemd[1]: ntp.service: Succeeded.
Apr 29 20:06:36 smsl-n100 systemd[1]: Stopped Network Time Service.
Apr 29 20:06:36 smsl-n100 systemd[1]: Starting Network Time Service...
Apr 29 20:06:36 smsl-n100 ntpd[1472]: ntpd 4.2.8p12@1.3728-o (1): Starting
Apr 29 20:06:36 smsl-n100 ntpd[1472]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Apr 29 20:06:36 smsl-n100 systemd[1]: Started Network Time Service.
Apr 29 20:06:36 smsl-n100 ntpd[1481]: proto: precision = 1.166 usec (-20)
Apr 29 20:06:36 smsl-n100 ntpd[1481]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Apr 29 20:06:36 smsl-n100 ntpd[1481]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Apr 29 20:06:36 smsl-n100 ntpd[1481]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 854 days ago
Apr 29 20:06:36 smsl-n100 ntpd[1481]: Listen and drop on 0 v6wildcard [::]:123
Apr 29 20:06:36 smsl-n100 ntpd[1481]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Apr 29 20:06:36 smsl-n100 ntpd[1481]: Listen normally on 2 lo 127.0.0.1:123
Apr 29 20:06:36 smsl-n100 ntpd[1481]: Listen normally on 3 eth0 192.168.1.126:123
Apr 29 20:06:36 smsl-n100 ntpd[1481]: Listening on routing socket on fd #20 for interface updates
Apr 29 20:06:36 smsl-n100 ntpd[1481]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 29 20:06:36 smsl-n100 ntpd[1481]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 29 20:06:36 smsl-n100 volumio[792]: info: Discovery: adding bd56b18b-f634-44ea-85d0-527c7d649f4b
Apr 29 20:06:36 smsl-n100 volumio[792]: info: Discovery: Found device SMSL N100
Apr 29 20:06:36 smsl-n100 volumio[792]: info: CoreCommandRouter::volumioGetState
Apr 29 20:06:36 smsl-n100 volumio[792]: info: CorePlayQueue::getTrack 0
Apr 29 20:06:36 smsl-n100 volumio[792]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 29 20:06:36 smsl-n100 volumio[792]: Error: The value NaN is not a number
Apr 29 20:06:36 smsl-n100 volumio[792]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20)
Apr 29 20:06:36 smsl-n100 volumio[792]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25)
Apr 29 20:06:36 smsl-n100 volumio[792]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25)
Apr 29 20:06:36 smsl-n100 volumio[792]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10)
Apr 29 20:06:36 smsl-n100 volumio[792]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12)
Apr 29 20:06:36 smsl-n100 volumio[792]: at Browser.emit (events.js:400:28)
Apr 29 20:06:36 smsl-n100 volumio[792]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14)
Apr 29 20:06:36 smsl-n100 volumio[792]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7)
Apr 29 20:06:36 smsl-n100 volumio[792]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5)
Apr 29 20:06:36 smsl-n100 volumio[792]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21)
Apr 29 20:06:36 smsl-n100 volumio[792]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11
Apr 29 20:06:36 smsl-n100 volumio[792]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7)
Apr 29 20:06:36 smsl-n100 volumio[792]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9)
Apr 29 20:06:36 smsl-n100 volumio[792]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 29 20:06:37 smsl-n100 ntpd[1481]: Soliciting pool server 92.53.119.23
Apr 29 20:06:37 smsl-n100 sudo[1492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-29 20:05
Apr 29 20:06:37 smsl-n100 sudo[1492]: 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="cc0042a1eab1cb7982711a1347e242f8947b54b6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="smsl"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET"
VOLUMIO_VERSION="3.789"
VOLUMIO_HARDWARE="nanopineo3"
VOLUMIO_DEVICENAME="Nanopi Neo3"
VOLUMIO_VENDOR_MODEL="SMSL S100"
VOLUMIO_VENDOR="SMSL"
VOLUMIO_MODEL="S100"
VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"