-- Logs begin at Thu 2019-02-14 12:11:58 EET, end at Sat 2025-12-13 18:37:25 EET. -- Dec 13 18:36:34 minidsp-shd systemd-timedated[934]: Changed local time to Sat Dec 13 18:36:34 2025 Dec 13 18:36:34 minidsp-shd sudo[932]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:34 minidsp-shd volumio-time-update[501]: volumio-time-update-util: System time updated successfully. Dec 13 18:36:34 minidsp-shd systemd[1]: Starting Daily apt download activities... Dec 13 18:36:34 minidsp-shd systemd[1]: Started Volumio Time Update Utility. Dec 13 18:36:34 minidsp-shd volumio[910]: info: ------------------------------------------- Dec 13 18:36:34 minidsp-shd volumio[910]: info: ----- Volumio3 ---- Dec 13 18:36:34 minidsp-shd volumio[910]: info: ------------------------------------------- Dec 13 18:36:34 minidsp-shd volumio[910]: info: ----- System startup ---- Dec 13 18:36:34 minidsp-shd volumio[910]: info: ------------------------------------------- Dec 13 18:36:34 minidsp-shd nmbd[728]: [2025/12/13 18:36:34.651581, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 13 18:36:34 minidsp-shd nmbd[728]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 13 18:36:34 minidsp-shd systemd[1]: Started Samba NMB Daemon. Dec 13 18:36:34 minidsp-shd systemd[1]: Starting Samba Winbind Daemon... Dec 13 18:36:34 minidsp-shd ntpd[901]: Soliciting pool server 95.216.71.38 Dec 13 18:36:34 minidsp-shd ntpd[901]: Soliciting pool server 62.80.139.57 Dec 13 18:36:34 minidsp-shd ntpd[901]: Soliciting pool server 194.100.49.139 Dec 13 18:36:35 minidsp-shd winbindd[966]: [2025/12/13 18:36:35.141805, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Dec 13 18:36:35 minidsp-shd winbindd[966]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 13 18:36:35 minidsp-shd systemd[1]: apt-daily.service: Succeeded. Dec 13 18:36:35 minidsp-shd systemd[1]: Started Daily apt download activities. Dec 13 18:36:35 minidsp-shd systemd[1]: Starting Daily apt upgrade and clean activities... Dec 13 18:36:35 minidsp-shd winbindd[966]: [2025/12/13 18:36:35.165028, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 13 18:36:35 minidsp-shd systemd[1]: Started Samba Winbind Daemon. Dec 13 18:36:35 minidsp-shd winbindd[966]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 13 18:36:35 minidsp-shd systemd[1]: Starting Samba SMB Daemon... Dec 13 18:36:35 minidsp-shd ntpd[901]: Soliciting pool server 162.159.200.123 Dec 13 18:36:35 minidsp-shd ntpd[901]: Soliciting pool server 95.216.138.141 Dec 13 18:36:35 minidsp-shd smbd[999]: [2025/12/13 18:36:35.958811, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 13 18:36:35 minidsp-shd systemd[1]: Started Samba SMB Daemon. Dec 13 18:36:35 minidsp-shd systemd[1]: Reached target Multi-User System. Dec 13 18:36:35 minidsp-shd systemd[1]: Reached target Graphical Interface. Dec 13 18:36:35 minidsp-shd smbd[999]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 13 18:36:35 minidsp-shd systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 13 18:36:36 minidsp-shd systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 13 18:36:36 minidsp-shd systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 13 18:36:36 minidsp-shd systemd[1]: apt-daily-upgrade.service: Succeeded. Dec 13 18:36:36 minidsp-shd systemd[1]: Started Daily apt upgrade and clean activities. Dec 13 18:36:36 minidsp-shd systemd[1]: Startup finished in 6.645s (kernel) + 31.734s (userspace) = 38.379s. Dec 13 18:36:36 minidsp-shd volumio[910]: info: MYVOLUMIO Environment detected Dec 13 18:36:36 minidsp-shd volumio[910]: info: Plugin folders cleanup Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning into folder /volumio/app/plugins/ Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning category audio_interface Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning category miscellanea Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning category music_service Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning category plugins.json Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning category system_controller Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning category user_interface Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning into folder /data/plugins/ Dec 13 18:36:36 minidsp-shd volumio[910]: info: Scanning category music_service Dec 13 18:36:36 minidsp-shd volumio[910]: info: Plugin folders cleanup completed Dec 13 18:36:36 minidsp-shd volumio[910]: info: ------------------------------------------- Dec 13 18:36:36 minidsp-shd volumio[910]: info: ----- Core plugins startup ---- Dec 13 18:36:36 minidsp-shd volumio[910]: info: ------------------------------------------- Dec 13 18:36:36 minidsp-shd volumio[910]: info: Loading plugins from folder /volumio/app/plugins/ Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin bluetooth to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin multiroom to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin upnp to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin metavolumio to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin ms_surface_dial to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin cd_controller to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin raat to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 13 18:36:36 minidsp-shd volumio[910]: info: Loading plugins from folder /data/plugins/ Dec 13 18:36:36 minidsp-shd volumio[910]: info: Loading plugin "system"... Dec 13 18:36:36 minidsp-shd volumio[910]: info: Loading plugin "appearance"... Dec 13 18:36:36 minidsp-shd ntpd[901]: Soliciting pool server 65.21.91.95 Dec 13 18:36:36 minidsp-shd ntpd[901]: Soliciting pool server 2a01:4f9:c013:7394::1 Dec 13 18:36:36 minidsp-shd systemd[1]: systemd-fsckd.service: Succeeded. Dec 13 18:36:37 minidsp-shd sh[452]: timed out Dec 13 18:36:37 minidsp-shd sh[452]: dhcpcd exited Dec 13 18:36:37 minidsp-shd dhcpcd[489]: timed out Dec 13 18:36:37 minidsp-shd sh[452]: ifup: failed to bring up eth0 Dec 13 18:36:37 minidsp-shd dhcpcd[489]: dhcpcd exited Dec 13 18:36:37 minidsp-shd systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Dec 13 18:36:37 minidsp-shd systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "network"... Dec 13 18:36:38 minidsp-shd volumio[910]: info: Refreshing Cached IP Addresses Dec 13 18:36:38 minidsp-shd sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 13 18:36:38 minidsp-shd sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:36:38 minidsp-shd sudo[1060]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:38 minidsp-shd sudo[1062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 18:36:38 minidsp-shd sudo[1062]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:36:38 minidsp-shd sudo[1062]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "services"... Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "alsa_controller"... Dec 13 18:36:38 minidsp-shd sudo[1075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 13 18:36:38 minidsp-shd sudo[1075]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:36:38 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "wizard"... Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "networkfs"... Dec 13 18:36:38 minidsp-shd volumio[910]: info: Starting Udev Watcher for removable devices Dec 13 18:36:38 minidsp-shd volumio[910]: info: Ignoring mount for partition: BOOT Dec 13 18:36:38 minidsp-shd volumio[910]: info: Ignoring mount for partition: volumio Dec 13 18:36:38 minidsp-shd volumio[910]: info: Ignoring mount for partition: volumio_data Dec 13 18:36:38 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "volumio_command_line_client"... Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "upnp"... Dec 13 18:36:38 minidsp-shd volumio[910]: info: [1765643798836] Starting Upmpd Daemon Dec 13 18:36:38 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "my_music"... Dec 13 18:36:38 minidsp-shd volumio[910]: info: Loading plugin "mpd"... Dec 13 18:36:39 minidsp-shd volumio[910]: info: Loading plugin "upnp_browser"... Dec 13 18:36:40 minidsp-shd volumio[910]: info: Loading plugin "bluetooth"... Dec 13 18:36:40 minidsp-shd volumio[910]: info: [1765643800297] Starting BluetoothController Dec 13 18:36:40 minidsp-shd volumio[910]: info: Loading plugin "alarm-clock"... Dec 13 18:36:40 minidsp-shd volumio[910]: info: Loading plugin "manifestui"... Dec 13 18:36:40 minidsp-shd volumio-remote-updater[500]: [2025-12-13 18:36:40] [connect] Successful connection Dec 13 18:36:41 minidsp-shd ntpd[901]: receive: Unexpected origin timestamp 0xece81498.e7d22e34 does not match aorg 0000000000.00000000 from server@95.216.138.141 xmt 0xece81499.8ee2cfbd Dec 13 18:36:41 minidsp-shd ntpd[901]: receive: Unexpected origin timestamp 0xece81498.e7e60955 does not match aorg 0000000000.00000000 from server@195.148.70.12 xmt 0xece81499.8ef03829 Dec 13 18:36:41 minidsp-shd ntpd[901]: receive: Unexpected origin timestamp 0xece81498.e7e046bc does not match aorg 0000000000.00000000 from server@194.100.49.139 xmt 0xece81499.8fbd079f Dec 13 18:36:41 minidsp-shd volumio[910]: info: Loading plugin "metavolumio"... Dec 13 18:36:43 minidsp-shd volumio[910]: info: Loading plugin "airplay_emulation"... Dec 13 18:36:43 minidsp-shd volumio[910]: info: Starting Shairport Sync Dec 13 18:36:43 minidsp-shd volumio[910]: info: Loading plugin "cd_controller"... Dec 13 18:36:44 minidsp-shd volumio[910]: info: Loading plugin "last_100"... Dec 13 18:36:44 minidsp-shd volumio[910]: info: Loading plugin "qobuzconnect"... Dec 13 18:36:44 minidsp-shd volumio[910]: info: Loading plugin "raat"... Dec 13 18:36:44 minidsp-shd volumio[910]: info: RAAT Plugin loaded Dec 13 18:36:44 minidsp-shd volumio[910]: info: Adding restartRAATSocket REST API Endpoint Dec 13 18:36:44 minidsp-shd volumio[910]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Dec 13 18:36:44 minidsp-shd volumio[910]: info: Loading plugin "streaming_services"... Dec 13 18:36:46 minidsp-shd volumio[910]: info: Starting Streaming Service Transparent Proxy Dec 13 18:36:46 minidsp-shd volumio[910]: info: Loading plugin "tidalconnect"... Dec 13 18:36:46 minidsp-shd volumio[910]: info: Loading plugin "webradio"... Dec 13 18:36:47 minidsp-shd volumio[910]: info: Loading plugin "i2s_dacs"... Dec 13 18:36:47 minidsp-shd volumio[910]: info: I2S DAC not set, start Auto-detection Dec 13 18:36:47 minidsp-shd volumio[910]: info: Loading plugin "volumiodiscovery"... Dec 13 18:36:47 minidsp-shd volumio[910]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 13 18:36:47 minidsp-shd volumio[910]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 18:36:47 minidsp-shd volumio[910]: *** WARNING *** For more information see Dec 13 18:36:47 minidsp-shd volumio[910]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 13 18:36:47 minidsp-shd volumio[910]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 18:36:47 minidsp-shd volumio[910]: *** WARNING *** For more information see Dec 13 18:36:47 minidsp-shd node[910]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 13 18:36:47 minidsp-shd node[910]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 18:36:47 minidsp-shd node[910]: *** WARNING *** For more information see Dec 13 18:36:47 minidsp-shd node[910]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 13 18:36:47 minidsp-shd node[910]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 18:36:47 minidsp-shd node[910]: *** WARNING *** For more information see Dec 13 18:36:47 minidsp-shd volumio[910]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 13 18:36:47 minidsp-shd volumio[910]: info: Discovery: Started advertising with name: miniDSP SHD Dec 13 18:36:47 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 18:36:47 minidsp-shd volumio[910]: info: Loading plugin "spop"... Dec 13 18:36:48 minidsp-shd volumio[910]: STREAMING PROXY: Starting server on port 3245 Dec 13 18:36:48 minidsp-shd volumio[910]: Node JS runtime: 14 Dec 13 18:36:49 minidsp-shd volumio[910]: info: Loading plugin "multiroom"... Dec 13 18:36:51 minidsp-shd volumio[910]: info: Applying required configuration parameters for plugin multiroom Dec 13 18:36:51 minidsp-shd sudo[1112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Dec 13 18:36:51 minidsp-shd sudo[1112]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:36:51 minidsp-shd sudo[1112]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:51 minidsp-shd volumio[910]: info: MRS: MultiRoom plugin initialized Dec 13 18:36:51 minidsp-shd volumio[910]: info: MRS: STOPPING SNAPCLIENT Dec 13 18:36:51 minidsp-shd volumio[910]: info: MRS: Snap server stop Dec 13 18:36:51 minidsp-shd sudo[1128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Dec 13 18:36:51 minidsp-shd sudo[1128]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:36:51 minidsp-shd volumio[910]: info: MRS: STOPPING volumioStreaming Dec 13 18:36:51 minidsp-shd sudo[1131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Dec 13 18:36:51 minidsp-shd sudo[1131]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:36:51 minidsp-shd sudo[1128]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:51 minidsp-shd sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Dec 13 18:36:51 minidsp-shd volumio[910]: info: Loading plugin "outputs"... Dec 13 18:36:51 minidsp-shd sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:36:51 minidsp-shd volumio[910]: info: Loading plugin "albumart"... Dec 13 18:36:51 minidsp-shd sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 13 18:36:51 minidsp-shd sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:36:51 minidsp-shd sudo[1136]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:51 minidsp-shd volumio[910]: info: Loading plugin "ms_surface_dial"... Dec 13 18:36:51 minidsp-shd sudo[1134]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:51 minidsp-shd sudo[1131]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:52 minidsp-shd volumio[910]: Forking 3 albumart workers Dec 13 18:36:52 minidsp-shd volumio[910]: info: Applying required configuration parameters for plugin ms_surface_dial Dec 13 18:36:52 minidsp-shd volumio[910]: info: Plugin example_plugin is not enabled Dec 13 18:36:52 minidsp-shd volumio[910]: info: Loading plugin "hi_res_audio"... Dec 13 18:36:53 minidsp-shd volumio[910]: Starting albumart workers Dec 13 18:36:53 minidsp-shd volumio[910]: Starting albumart workers Dec 13 18:36:53 minidsp-shd volumio[910]: Starting albumart workers Dec 13 18:36:54 minidsp-shd sudo[1075]: pam_unix(sudo:session): session closed for user root Dec 13 18:36:55 minidsp-shd volumio[910]: info: Applying required configuration parameters for plugin hi_res_audio Dec 13 18:36:55 minidsp-shd volumio[910]: info: Loading plugin "inputs"... Dec 13 18:36:56 minidsp-shd volumio[910]: info: Loading plugin "qobuz"... Dec 13 18:36:56 minidsp-shd volumio-remote-updater[500]: [2025-12-13 18:36:56] [connect] Successful connection Dec 13 18:36:58 minidsp-shd volumio[910]: info: Loading plugin "tidal"... Dec 13 18:36:59 minidsp-shd wpa_supplicant[811]: wlan0: Trying to associate with 7c:00:4d:22:11:04 (SSID='Elisa_kuitu' freq=5180 MHz) Dec 13 18:36:59 minidsp-shd wpa_supplicant[811]: Failed to add supported operating classes IE Dec 13 18:36:59 minidsp-shd dhcpcd[605]: wlan0: carrier lost Dec 13 18:36:59 minidsp-shd kernel: wlan0: deauthenticating from a0:44:5c:67:81:b0 by local choice (Reason: 3=DEAUTH_LEAVING) Dec 13 18:36:59 minidsp-shd avahi-daemon[504]: Withdrawing address record for 192.168.100.18 on wlan0. Dec 13 18:36:59 minidsp-shd dhcpcd[605]: wlan0: deleting route to 192.168.100.0/24 Dec 13 18:36:59 minidsp-shd avahi-daemon[504]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.18. Dec 13 18:36:59 minidsp-shd dhcpcd[605]: wlan0: deleting default route via 192.168.100.1 Dec 13 18:36:59 minidsp-shd avahi-daemon[504]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 13 18:36:59 minidsp-shd kernel: wlan0: authenticate with 7c:00:4d:22:11:04 Dec 13 18:36:59 minidsp-shd volumio[910]: info: Loading plugin "oem_helper"... Dec 13 18:36:59 minidsp-shd wpa_supplicant[811]: wlan0: CTRL-EVENT-DISCONNECTED bssid=7c:00:4d:22:11:04 reason=0 Dec 13 18:36:59 minidsp-shd kernel: wlan0: send auth to 7c:00:4d:22:11:04 (try 1/3) Dec 13 18:36:59 minidsp-shd wpa_supplicant[811]: wlan0: Associated with 7c:00:4d:22:11:04 Dec 13 18:36:59 minidsp-shd wpa_supplicant[811]: wlan0: WPA: Key negotiation completed with 7c:00:4d:22:11:04 [PTK=CCMP GTK=CCMP] Dec 13 18:36:59 minidsp-shd wpa_supplicant[811]: wlan0: CTRL-EVENT-CONNECTED - Connection to 7c:00:4d:22:11:04 completed [id=0 id_str=] Dec 13 18:36:59 minidsp-shd dhcpcd[605]: wlan0: carrier acquired Dec 13 18:36:59 minidsp-shd kernel: wlan0: authenticated Dec 13 18:36:59 minidsp-shd kernel: wlan0: associate with 7c:00:4d:22:11:04 (try 1/3) Dec 13 18:36:59 minidsp-shd kernel: wlan0: RX AssocResp from 7c:00:4d:22:11:04 (capab=0x1531 status=0 aid=5) Dec 13 18:36:59 minidsp-shd kernel: wlan0: associated Dec 13 18:36:59 minidsp-shd dhcpcd[605]: wlan0: IAID 45:62:2c:70 Dec 13 18:37:00 minidsp-shd kernel: wlan0: Limiting TX power to 23 (23 - 0) dBm as advertised by 7c:00:4d:22:11:04 Dec 13 18:37:00 minidsp-shd dhcpcd[605]: wlan0: soliciting a DHCP lease Dec 13 18:37:00 minidsp-shd dhcpcd[605]: wlan0: soliciting an IPv6 router Dec 13 18:37:01 minidsp-shd ntpd[901]: Deleting interface #3 wlan0, 192.168.100.18#123, interface stats: received=64, sent=66, dropped=0, active_time=30 secs Dec 13 18:37:01 minidsp-shd ntpd[901]: 65.21.91.95 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd ntpd[901]: 95.216.138.141 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd ntpd[901]: 162.159.200.123 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd ntpd[901]: 194.100.49.139 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd ntpd[901]: 95.216.71.38 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd ntpd[901]: 162.159.200.1 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd ntpd[901]: 62.80.139.68 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd ntpd[901]: 185.251.115.30 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd ntpd[901]: 195.148.70.12 local addr 192.168.100.18 -> Dec 13 18:37:01 minidsp-shd volumio[910]: info: Applying required configuration parameters for plugin oem_helper Dec 13 18:37:01 minidsp-shd volumio[910]: info: Loading plugin "updater_comm"... Dec 13 18:37:01 minidsp-shd volumio[910]: info: Plugin mpdemulation is not enabled Dec 13 18:37:01 minidsp-shd volumio[910]: info: Loading plugin "rest_api"... Dec 13 18:37:01 minidsp-shd volumio[910]: info: Loading plugin "websocket"... Dec 13 18:37:01 minidsp-shd volumio[910]: info: Starting Socket.io Server version 2.3.0 Dec 13 18:37:01 minidsp-shd volumio[910]: info: Loading plugin "motherearthradio"... Dec 13 18:37:02 minidsp-shd volumio[910]: info: Applying required configuration parameters for plugin motherearthradio Dec 13 18:37:02 minidsp-shd volumio[910]: info: [1765643822420] [MotherEarth] API delay: 5 Dec 13 18:37:02 minidsp-shd volumio[910]: info: Loading plugin "personal_radio"... Dec 13 18:37:02 minidsp-shd dhcpcd[605]: wlan0: offered 192.168.100.18 from 192.168.100.1 Dec 13 18:37:02 minidsp-shd dhcpcd[605]: wlan0: probing address 192.168.100.18/24 Dec 13 18:37:03 minidsp-shd volumio[910]: info: ControllerPersonalRadio::constructor Dec 13 18:37:03 minidsp-shd volumio[910]: info: Loading i18n strings for locale fi Dec 13 18:37:03 minidsp-shd volumio[910]: Updating browse sources language Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::initPlayerControls Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 13 18:37:03 minidsp-shd volumio[910]: Express server listening on port 3000 Dec 13 18:37:03 minidsp-shd volumio[910]: [Metrics] WebUI: 29s 784.53ms Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreStateMachine::resetVolumioState Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreStateMachine::getcurrentVolume Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreStateMachine::pushState Dec 13 18:37:03 minidsp-shd volumio[910]: info: CorePlayQueue::getTrack 0 Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::volumioPushState Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 18:37:03 minidsp-shd sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 13 18:37:03 minidsp-shd sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:37:03 minidsp-shd sudo[1240]: pam_unix(sudo:session): session closed for user root Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: inputs , getVolume Dec 13 18:37:03 minidsp-shd volumio[910]: info: CoreCommandRouter::executeOnPlugin: inputs , getDSP Dec 13 18:37:03 minidsp-shd sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 18:37:03 minidsp-shd sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:37:03 minidsp-shd volumio[910]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 13 18:37:03 minidsp-shd sudo[1243]: pam_unix(sudo:session): session closed for user root Dec 13 18:37:03 minidsp-shd volumio[910]: info: Completed loading Core Plugins Dec 13 18:37:03 minidsp-shd volumio[910]: info: Preparing to generate the ALSA configuration file Dec 13 18:37:03 minidsp-shd volumio[910]: info: Volumio Network Manager: Network status updated: 2 Dec 13 18:37:03 minidsp-shd volumio[910]: info: MRS: Removed streaming files Dec 13 18:37:03 minidsp-shd volumio[910]: info: MRS: volumioStreaming STOPPED Dec 13 18:37:03 minidsp-shd volumio[910]: info: MRS: SNAPSERVER STOPPED Dec 13 18:37:03 minidsp-shd volumio[910]: info: MRS: SNAPCLIENT STOPPED Dec 13 18:37:03 minidsp-shd volumio[910]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 13 18:37:03 minidsp-shd volumio[910]: wlan0 Failed to read scan data : Resource temporarily unavailable Dec 13 18:37:03 minidsp-shd volumio[910]: info: Cannot use regular scanning, forcing with ap-force Dec 13 18:37:04 minidsp-shd sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 13 18:37:04 minidsp-shd sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 18:37:04 minidsp-shd systemd[1]: systemd-timedated.service: Succeeded. Dec 13 18:37:07 minidsp-shd dhcpcd[605]: wlan0: leased 192.168.100.18 for 86400 seconds Dec 13 18:37:07 minidsp-shd dhcpcd[605]: wlan0: adding route to 192.168.100.0/24 Dec 13 18:37:07 minidsp-shd dhcpcd[605]: wlan0: adding default route via 192.168.100.1 Dec 13 18:37:07 minidsp-shd avahi-daemon[504]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.18. Dec 13 18:37:07 minidsp-shd avahi-daemon[504]: New relevant interface wlan0.IPv4 for mDNS. Dec 13 18:37:07 minidsp-shd avahi-daemon[504]: Registering new address record for 192.168.100.18 on wlan0.IPv4. Dec 13 18:37:07 minidsp-shd ntpd[901]: ntpd exiting on signal 15 (Terminated) Dec 13 18:37:07 minidsp-shd systemd[1]: Stopping Network Time Service... Dec 13 18:37:07 minidsp-shd systemd[1]: ntp.service: Succeeded. Dec 13 18:37:07 minidsp-shd systemd[1]: Stopped Network Time Service. Dec 13 18:37:07 minidsp-shd systemd[1]: Starting Network Time Service... Dec 13 18:37:07 minidsp-shd ntpd[1283]: ntpd 4.2.8p12@1.3728-o (1): Starting Dec 13 18:37:07 minidsp-shd ntpd[1283]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Dec 13 18:37:07 minidsp-shd systemd[1]: Started Network Time Service. Dec 13 18:37:07 minidsp-shd ntpd[1289]: proto: precision = 1.208 usec (-20) Dec 13 18:37:07 minidsp-shd ntpd[1289]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Dec 13 18:37:07 minidsp-shd ntpd[1289]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Dec 13 18:37:07 minidsp-shd ntpd[1289]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1082 days ago Dec 13 18:37:07 minidsp-shd ntpd[1289]: Listen and drop on 0 v6wildcard [::]:123 Dec 13 18:37:07 minidsp-shd ntpd[1289]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 13 18:37:07 minidsp-shd ntpd[1289]: Listen normally on 2 lo 127.0.0.1:123 Dec 13 18:37:07 minidsp-shd ntpd[1289]: Listen normally on 3 wlan0 192.168.100.18:123 Dec 13 18:37:07 minidsp-shd ntpd[1289]: Listening on routing socket on fd #20 for interface updates Dec 13 18:37:07 minidsp-shd ntpd[1289]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Dec 13 18:37:07 minidsp-shd ntpd[1289]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Dec 13 18:37:08 minidsp-shd ntpd[1289]: Soliciting pool server 195.148.70.12 Dec 13 18:37:09 minidsp-shd ntpd[1289]: Soliciting pool server 185.251.115.30 Dec 13 18:37:09 minidsp-shd ntpd[1289]: Soliciting pool server 95.217.251.167 Dec 13 18:37:10 minidsp-shd ntpd[1289]: Soliciting pool server 62.237.86.238 Dec 13 18:37:10 minidsp-shd ntpd[1289]: Soliciting pool server 62.80.139.57 Dec 13 18:37:10 minidsp-shd ntpd[1289]: Soliciting pool server 162.159.200.1 Dec 13 18:37:11 minidsp-shd ntpd[1289]: Soliciting pool server 95.216.138.141 Dec 13 18:37:11 minidsp-shd ntpd[1289]: Soliciting pool server 95.217.153.166 Dec 13 18:37:11 minidsp-shd ntpd[1289]: Soliciting pool server 62.80.139.68 Dec 13 18:37:11 minidsp-shd volumio-remote-updater[500]: [2025-12-13 18:37:11] [connect] Successful connection Dec 13 18:37:11 minidsp-shd ntpd[1289]: Soliciting pool server 194.100.49.139 Dec 13 18:37:12 minidsp-shd ntpd[1289]: Soliciting pool server 95.216.71.38 Dec 13 18:37:13 minidsp-shd ntpd[1289]: Soliciting pool server 2a01:4f9:c010:1eba::1 Dec 13 18:37:14 minidsp-shd ntpd[1289]: Soliciting pool server 162.159.200.123 Dec 13 18:37:15 minidsp-shd ntpd[1289]: Soliciting pool server 65.21.91.95 Dec 13 18:37:17 minidsp-shd ntpd[1289]: receive: Unexpected origin timestamp 0xece814bd.5cd74311 does not match aorg 0000000000.00000000 from server@195.148.70.12 xmt 0xece814bd.609d569b Dec 13 18:37:17 minidsp-shd ntpd[1289]: receive: Unexpected origin timestamp 0xece814bd.5ccdf497 does not match aorg 0000000000.00000000 from server@62.80.139.57 xmt 0xece814bd.602c47eb Dec 13 18:37:22 minidsp-shd dbus-daemon[506]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30004ms) Dec 13 18:37:24 minidsp-shd sudo[1246]: pam_unix(sudo:session): session closed for user root Dec 13 18:37:24 minidsp-shd volumio[910]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 13 18:37:24 minidsp-shd volumio[910]: info: Reading ALSA contributions from plugins. Dec 13 18:37:24 minidsp-shd volumio[910]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 13 18:37:24 minidsp-shd volumio[910]: Error: write EPIPE Dec 13 18:37:24 minidsp-shd volumio[910]: at afterWriteDispatched (internal/stream_base_commons.js:156:25) Dec 13 18:37:24 minidsp-shd volumio[910]: at writeGeneric (internal/stream_base_commons.js:147:3) Dec 13 18:37:24 minidsp-shd volumio[910]: at Socket._writeGeneric (net.js:798:11) Dec 13 18:37:24 minidsp-shd volumio[910]: at Socket._write (net.js:810:8) Dec 13 18:37:24 minidsp-shd volumio[910]: at writeOrBuffer (internal/streams/writable.js:358:12) Dec 13 18:37:24 minidsp-shd volumio[910]: at Socket.Writable.write (internal/streams/writable.js:303:10) Dec 13 18:37:24 minidsp-shd volumio[910]: at /volumio/app/plugins/miscellanea/ms_surface_dial/node_modules/dbus-next/lib/handshake.js:84:16 Dec 13 18:37:24 minidsp-shd volumio[910]: at Socket.readable (/volumio/app/plugins/miscellanea/ms_surface_dial/node_modules/dbus-next/lib/readline.js:12:11) Dec 13 18:37:24 minidsp-shd volumio[910]: at Socket.emit (events.js:400:28) Dec 13 18:37:24 minidsp-shd volumio[910]: at emitReadable_ (internal/streams/readable.js:555:12) Dec 13 18:37:24 minidsp-shd volumio[910]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Dec 13 18:37:24 minidsp-shd volumio[910]: errno: -32, Dec 13 18:37:24 minidsp-shd volumio[910]: code: 'EPIPE', Dec 13 18:37:24 minidsp-shd volumio[910]: syscall: 'write' Dec 13 18:37:24 minidsp-shd volumio[910]: } Dec 13 18:37:24 minidsp-shd volumio[910]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 13 18:37:24 minidsp-shd sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-13 18:36 Dec 13 18:37:25 minidsp-shd sudo[1363]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 18 Nov 2025 04:14:14 PM CET" VOLUMIO_VERSION="3.877" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="57978c68a391dbf6badbe915e5672a72"