-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Mon 2025-12-29 18:07:43 CST. -- Dec 29 18:07:08 so1905-cbb0 systemd-timesyncd[2112]: Initial synchronization to time server 185.125.190.58:123 (ntp.ubuntu.com). Dec 29 18:07:08 so1905-cbb0 systemd[1]: Finished Load/Save Random Seed. Dec 29 18:07:08 so1905-cbb0 systemd-logind[2134]: New seat seat0. Dec 29 18:07:08 so1905-cbb0 systemd[1]: volumiossh.service: Succeeded. Dec 29 18:07:08 so1905-cbb0 systemd[1]: Finished Save/Restore Sound Card State. Dec 29 18:07:08 so1905-cbb0 sudo[2156]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Dec 29 18:07:08 so1905-cbb0 dbus-daemon[2120]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 29 18:07:08 so1905-cbb0 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Dec 29 18:07:08 so1905-cbb0 systemd[1]: Started Login Service. Dec 29 18:07:08 so1905-cbb0 sudo[2156]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:08 so1905-cbb0 systemd[1]: Reached target Network. Dec 29 18:07:08 so1905-cbb0 systemd[1]: Reached target Network is Online. Dec 29 18:07:08 so1905-cbb0 systemd[1]: Reached target Sound Card. Dec 29 18:07:08 so1905-cbb0 wifistart.sh[2204]: command failed: No such device (-19) Dec 29 18:07:08 so1905-cbb0 sudo[2156]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:08 so1905-cbb0 systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Dec 29 18:07:08 so1905-cbb0 systemd[1]: Starting Music Player Daemon... Dec 29 18:07:09 so1905-cbb0 systemd[1]: Starting Samba NMB Daemon... Dec 29 18:07:09 so1905-cbb0 volumio[2138]: Could not open config: /tmp/upmpdcli.conf Dec 29 18:07:09 so1905-cbb0 dnsmasq[2211]: dnsmasq: syntax check OK. Dec 29 18:07:09 so1905-cbb0 avahi-daemon[2119]: Server startup complete. Host name is so1905-cbb0.local. Local service cookie is 3939483742. Dec 29 18:07:09 so1905-cbb0 systemd[1]: Started NQPTP -- Not Quite PTP. Dec 29 18:07:09 so1905-cbb0 systemd[1]: Starting /etc/rc.local Compatibility... Dec 29 18:07:09 so1905-cbb0 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Dec 29 18:07:09 so1905-cbb0 systemd[1]: Starting Permit User Sessions... Dec 29 18:07:09 so1905-cbb0 systemd[1]: Starting Disk Manager (legacy version)... Dec 29 18:07:09 so1905-cbb0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 29 18:07:09 so1905-cbb0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 29 18:07:09 so1905-cbb0 serverota.sh[2133]: chmod +x /volumio/**/*.sh Dec 29 18:07:09 so1905-cbb0 serverota.sh[2133]: chmod +x /volumio/**/vollibrespot Dec 29 18:07:09 so1905-cbb0 serverota.sh[2133]: Upgrade file or version file missing. Exiting. Dec 29 18:07:09 so1905-cbb0 dbus-daemon[2120]: [system] Successfully activated service 'org.freedesktop.UDisks' Dec 29 18:07:09 so1905-cbb0 systemd[1]: Finished Server OTA Update Service. Dec 29 18:07:09 so1905-cbb0 systemd[1]: Started /etc/rc.local Compatibility. Dec 29 18:07:09 so1905-cbb0 dbus-daemon[2120]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.8' (uid=0 pid=2236 comm="/usr/lib/udisks/udisks-daemon --no-debug ") Dec 29 18:07:09 so1905-cbb0 systemd[1]: Finished Permit User Sessions. Dec 29 18:07:09 so1905-cbb0 systemd[1]: Started Disk Manager (legacy version). Dec 29 18:07:09 so1905-cbb0 systemd[1]: Started Getty on tty1. Dec 29 18:07:09 so1905-cbb0 display[2137]: 初始化FreeType... Dec 29 18:07:09 so1905-cbb0 display[2137]: FreeType初始化失败 Dec 29 18:07:09 so1905-cbb0 display[2137]: [HeartbeatMonitor] 初始化完成 Dec 29 18:07:09 so1905-cbb0 systemd[1]: Starting Authorization Manager... Dec 29 18:07:09 so1905-cbb0 systemd[1]: Started Serial Getty on ttyAS0. Dec 29 18:07:09 so1905-cbb0 systemd[1]: Reached target Login Prompts. Dec 29 18:07:09 so1905-cbb0 dnsmasq[2250]: dnsmasq: unknown interface wlan0 Dec 29 18:07:09 so1905-cbb0 dnsmasq[2250]: unknown interface wlan0 Dec 29 18:07:10 so1905-cbb0 dnsmasq[2250]: FAILED to start up Dec 29 18:07:10 so1905-cbb0 systemd[1]: dnsmasq.service: Control process exited, code=exited, status=2/INVALIDARGUMENT Dec 29 18:07:10 so1905-cbb0 systemd[1]: dnsmasq.service: Failed with result 'exit-code'. Dec 29 18:07:10 so1905-cbb0 polkitd[2260]: started daemon version 0.105 using authority implementation `local' version `0.105' Dec 29 18:07:10 so1905-cbb0 dbus-daemon[2120]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Dec 29 18:07:10 so1905-cbb0 systemd[1]: Failed to start dnsmasq - A lightweight DHCP and caching DNS server. Dec 29 18:07:10 so1905-cbb0 avahi-daemon[2119]: Service "SO1905-cbb0" (/services/volumio.service) successfully established. Dec 29 18:07:10 so1905-cbb0 systemd[1]: Started Authorization Manager. Dec 29 18:07:10 so1905-cbb0 systemd[1]: Reached target Host and Network Name Lookups. Dec 29 18:07:10 so1905-cbb0 udisks-glue[2135]: Device file /dev/mmcblk0p6 inserted Dec 29 18:07:10 so1905-cbb0 udisks-glue[2135]: Device file /dev/mmcblk0 inserted Dec 29 18:07:10 so1905-cbb0 udisks-glue[2135]: Device file /dev/mmcblk0p4 inserted Dec 29 18:07:10 so1905-cbb0 udisks-glue[2135]: Device file /dev/mmcblk0p3 inserted Dec 29 18:07:10 so1905-cbb0 udisks-glue[2135]: Device file /dev/mmcblk0p2 inserted Dec 29 18:07:10 so1905-cbb0 udisks-glue[2135]: Device file /dev/mmcblk0p8 inserted Dec 29 18:07:10 so1905-cbb0 udisks-glue[2135]: Device file /dev/mmcblk0p1 inserted Dec 29 18:07:10 so1905-cbb0 udisks-glue[2135]: Device file /dev/mmcblk0p7 inserted Dec 29 18:07:10 so1905-cbb0 nmbd[2220]: [2025/12/29 18:07:10.603754, 0] ../../source3/nmbd/nmbd.c:901(main) Dec 29 18:07:10 so1905-cbb0 nmbd[2220]: nmbd version 4.15.13-Ubuntu started. Dec 29 18:07:10 so1905-cbb0 nmbd[2220]: Copyright Andrew Tridgell and the Samba Team 1992-2021 Dec 29 18:07:10 so1905-cbb0 nmbd[2220]: [2025/12/29 18:07:10.633338, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) Dec 29 18:07:10 so1905-cbb0 nmbd[2220]: started asyncdns process 2271 Dec 29 18:07:10 so1905-cbb0 display[2137]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf Dec 29 18:07:10 so1905-cbb0 display[2137]: 文件大小: 11364916 字节 Dec 29 18:07:10 so1905-cbb0 systemd[1]: Started Samba NMB Daemon. Dec 29 18:07:10 so1905-cbb0 display[2137]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf (大小: 50px) Dec 29 18:07:10 so1905-cbb0 systemd[1]: Starting Samba SMB Daemon... Dec 29 18:07:10 so1905-cbb0 display[2137]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf Dec 29 18:07:10 so1905-cbb0 display[2137]: 文件大小: 11364916 字节 Dec 29 18:07:10 so1905-cbb0 display[2137]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf (大小: 36px) Dec 29 18:07:10 so1905-cbb0 display[2137]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf Dec 29 18:07:10 so1905-cbb0 display[2137]: 文件大小: 11364916 字节 Dec 29 18:07:10 so1905-cbb0 display[2137]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf (大小: 40px) Dec 29 18:07:10 so1905-cbb0 display[2137]: setImageSrc: this=0x1ecd278, str=/volumio/display/assets/source-icon/streaming.png Dec 29 18:07:10 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 29 18:07:10 so1905-cbb0 display[2137]: setImageSrc: this=0x1ed1810, str=/volumio/display/assets/source-icon/bt.png Dec 29 18:07:10 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/bt.png, size=11779, buffer[0]=89 Dec 29 18:07:10 so1905-cbb0 display[2137]: setImageSrc: this=0x1ed1940, str=/volumio/display/assets/source-icon/aux.png Dec 29 18:07:10 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/aux.png, size=10326, buffer[0]=89 Dec 29 18:07:10 so1905-cbb0 display[2137]: setImageSrc: this=0x1ed1df0, str=/volumio/display/assets/source-icon/opt.png Dec 29 18:07:10 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/opt.png, size=8229, buffer[0]=89 Dec 29 18:07:11 so1905-cbb0 display[2137]: setImageSrc: this=0x1ed2098, str=/volumio/display/assets/source-icon/opt.png Dec 29 18:07:11 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/opt.png, size=8229, buffer[0]=89 Dec 29 18:07:11 so1905-cbb0 display[2137]: setImageSrc: this=0x1ed23b0, str=/volumio/display/assets/source-icon/hdmi-arc.png Dec 29 18:07:11 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/hdmi-arc.png, size=7908, buffer[0]=89 Dec 29 18:07:11 so1905-cbb0 display[2137]: setImageSrc: this=0x1ed2c80, str=/volumio/display/assets/source-icon/usb.png Dec 29 18:07:11 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/usb.png, size=7652, buffer[0]=89 Dec 29 18:07:11 so1905-cbb0 display[2137]: setImageSrc: this=0x1ecdd98, str=/volumio/display/assets/source-icon/music-library.png Dec 29 18:07:11 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/music-library.png, size=22848, buffer[0]=89 Dec 29 18:07:11 so1905-cbb0 systemd[1]: Started Dispatcher daemon for systemd-networkd. Dec 29 18:07:11 so1905-cbb0 smbd[2274]: [2025/12/29 18:07:11.693349, 0] ../../source3/smbd/server.c:1734(main) Dec 29 18:07:11 so1905-cbb0 smbd[2274]: smbd version 4.15.13-Ubuntu started. Dec 29 18:07:11 so1905-cbb0 smbd[2274]: Copyright Andrew Tridgell and the Samba Team 1992-2021 Dec 29 18:07:12 so1905-cbb0 systemd[1]: Started Samba SMB Daemon. Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: [2025/12/29 18:07:12.689004, 0] ../../source3/nmbd/nmbd_mynames.c:104(my_name_register_failed) Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: my_name_register_failed: Failed to register my name VOLUMIO<20> on subnet 192.168.2.112. Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: [2025/12/29 18:07:12.689609, 0] ../../source3/nmbd/nmbd_namelistdb.c:319(standard_fail_register) Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: standard_fail_register: Failed to register/refresh name VOLUMIO<20> on subnet 192.168.2.112 Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: [2025/12/29 18:07:12.689975, 0] ../../source3/nmbd/nmbd_mynames.c:104(my_name_register_failed) Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: my_name_register_failed: Failed to register my name VOLUMIO<03> on subnet 192.168.2.112. Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: [2025/12/29 18:07:12.690308, 0] ../../source3/nmbd/nmbd_namelistdb.c:319(standard_fail_register) Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: standard_fail_register: Failed to register/refresh name VOLUMIO<03> on subnet 192.168.2.112 Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: [2025/12/29 18:07:12.690626, 0] ../../source3/nmbd/nmbd_mynames.c:104(my_name_register_failed) Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: my_name_register_failed: Failed to register my name VOLUMIO<00> on subnet 192.168.2.112. Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: [2025/12/29 18:07:12.690932, 0] ../../source3/nmbd/nmbd_namelistdb.c:319(standard_fail_register) Dec 29 18:07:12 so1905-cbb0 nmbd[2220]: standard_fail_register: Failed to register/refresh name VOLUMIO<00> on subnet 192.168.2.112 Dec 29 18:07:13 so1905-cbb0 set-cpufreq[2132]: Setting ondemand scheduler for all CPUs Dec 29 18:07:13 so1905-cbb0 systemd[1]: ondemand.service: Succeeded. Dec 29 18:07:13 so1905-cbb0 smbd[2274]: [2025/12/29 18:07:13.096857, 0] ../../source3/smbd/server.c:1082(smbd_open_one_socket) Dec 29 18:07:13 so1905-cbb0 smbd[2274]: smbd_open_one_socket: open_socket_in failed: Address family not supported by protocol Dec 29 18:07:13 so1905-cbb0 smbd[2274]: [2025/12/29 18:07:13.116904, 0] ../../source3/smbd/server.c:1082(smbd_open_one_socket) Dec 29 18:07:13 so1905-cbb0 smbd[2274]: smbd_open_one_socket: open_socket_in failed: Address family not supported by protocol Dec 29 18:07:13 so1905-cbb0 node[2246]: WIRELESS: No wireless interface, exiting Dec 29 18:07:13 so1905-cbb0 systemd[1]: wireless.service: Control process exited, code=exited, status=1/FAILURE Dec 29 18:07:13 so1905-cbb0 systemd[1]: wireless.service: Failed with result 'exit-code'. Dec 29 18:07:13 so1905-cbb0 systemd[1]: Failed to start Wireless Services. Dec 29 18:07:13 so1905-cbb0 systemd[1]: Started Server OTA Download Service. Dec 29 18:07:13 so1905-cbb0 systemd[1]: Started Volumio Backend Module. Dec 29 18:07:15 so1905-cbb0 mpd[2214]: Dec 29 18:07 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 29 18:07:15 so1905-cbb0 mpd[2214]: Dec 29 18:07 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Dec 29 18:07:15 so1905-cbb0 mpd[2214]: Dec 29 18:07 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Dec 29 18:07:15 so1905-cbb0 systemd[1]: Started Music Player Daemon. Dec 29 18:07:15 so1905-cbb0 systemd[1]: Reached target Multi-User System. Dec 29 18:07:15 so1905-cbb0 systemd[1]: Reached target Graphical Interface. Dec 29 18:07:15 so1905-cbb0 systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 29 18:07:16 so1905-cbb0 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 29 18:07:16 so1905-cbb0 systemd[1]: Finished Update UTMP about System Runlevel Changes. Dec 29 18:07:16 so1905-cbb0 systemd[1]: Startup finished in 3.959s (kernel) + 15.385s (userspace) = 19.344s. Dec 29 18:07:18 so1905-cbb0 node[2290]: Remote version data: { serverVersion: '1.5.6.30', Dec 29 18:07:18 so1905-cbb0 node[2290]: serverUrl: Dec 29 18:07:18 so1905-cbb0 node[2290]: 'https://ota.synaudio.org/server/1905/volumio_1.5.6.30.tar.gz', Dec 29 18:07:18 so1905-cbb0 node[2290]: md5: '5ebcc31243490bcc26b2f86378ca6c09' } Dec 29 18:07:18 so1905-cbb0 node[2290]: No update required. Dec 29 18:07:18 so1905-cbb0 volumio[2291]: info: ------------------------------------------- Dec 29 18:07:18 so1905-cbb0 volumio[2291]: info: ----- Synaudio ---- Dec 29 18:07:18 so1905-cbb0 volumio[2291]: info: ------------------------------------------- Dec 29 18:07:18 so1905-cbb0 volumio[2291]: info: ----- System startup ---- Dec 29 18:07:18 so1905-cbb0 volumio[2291]: info: ------------------------------------------- Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Found new core plugin music_service/cdplayer. Adding it Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Configured plugin music_service/cdplayer cannot be loaded. Removing from configuration Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Plugin folders cleanup Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Scanning into folder /volumio/app/plugins/ Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Scanning category audio_interface Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Scanning category miscellanea Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Scanning category music_service Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Scanning category plugins.json Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Scanning category system_controller Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Scanning category user_interface Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Scanning into folder /data/plugins/ Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Plugin folders cleanup completed Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: ------------------------------------------- Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: ----- Core plugins startup ---- Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: ------------------------------------------- Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Loading plugins from folder /volumio/app/plugins/ Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Adding plugin upnp to MyMusic Plugins Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Loading plugins from folder /data/plugins/ Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Loading plugin "system"... Dec 29 18:07:20 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/system_controller/system/index.js Dec 29 18:07:20 so1905-cbb0 volumio[2291]: info: Loading plugin "appearance"... Dec 29 18:07:20 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/miscellanea/appearance/index.js Dec 29 18:07:21 so1905-cbb0 volumio[2291]: info: Loading plugin "network"... Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/system_controller/network/index.js Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [network] Refreshing Cached IP Addresses Dec 29 18:07:21 so1905-cbb0 volumio[2291]: ControllerNetwork autoStartNetworkConfig false Dec 29 18:07:21 so1905-cbb0 volumio[2291]: ControllerNetwork getNetworkHardwares Dec 29 18:07:21 so1905-cbb0 volumio[2291]: info: Loading plugin "services"... Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/system_controller/services/index.js Dec 29 18:07:21 so1905-cbb0 volumio[2291]: info: Loading plugin "alsa_controller"... Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/audio_interface/alsa_controller/index.js Dec 29 18:07:21 so1905-cbb0 volumio[2291]: info: Applying required configuration parameters for plugin alsa_controller Dec 29 18:07:21 so1905-cbb0 sudo[2325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 18:07:21 so1905-cbb0 sudo[2325]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:21 so1905-cbb0 sudo[2327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 18:07:21 so1905-cbb0 sudo[2330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 18:07:21 so1905-cbb0 sudo[2331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 18:07:21 so1905-cbb0 sudo[2325]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:21 so1905-cbb0 sudo[2331]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:21 so1905-cbb0 sudo[2327]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:21 so1905-cbb0 sudo[2330]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:21 so1905-cbb0 sudo[2331]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:21 so1905-cbb0 sudo[2330]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:21 so1905-cbb0 sudo[2327]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [alsa_controller] Creating shared var alsa.outputdevice='2' Dec 29 18:07:21 so1905-cbb0 volumio[2291]: info: Loading plugin "wizard"... Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/miscellanea/wizard/index.js Dec 29 18:07:21 so1905-cbb0 volumio[2291]: info: Loading plugin "volumio_command_line_client"... Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/system_controller/volumio_command_line_client/index.js Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/getvolumedb.sh.template Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/setvolumedb.sh.template Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/getvolume.sh.template Dec 29 18:07:21 so1905-cbb0 volumio[2291]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/setvolume.sh.template Dec 29 18:07:21 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:22 so1905-cbb0 volumio[2291]: info: Loading plugin "upnp"... Dec 29 18:07:22 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/audio_interface/upnp/index.js Dec 29 18:07:22 so1905-cbb0 volumio[2291]: info: [1767002842034] Starting Upmpd Daemon Dec 29 18:07:22 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 29 18:07:22 so1905-cbb0 volumio[2291]: info: Loading plugin "my_music"... Dec 29 18:07:22 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/miscellanea/my_music/index.js Dec 29 18:07:22 so1905-cbb0 volumio[2291]: info: Loading plugin "mpd"... Dec 29 18:07:22 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/mpd/index.js Dec 29 18:07:22 so1905-cbb0 volumio[2291]: [mpd] MPD: starting udev watcher for USB partitions Dec 29 18:07:22 so1905-cbb0 volumio[2291]: [mpd] Creating MPD Configuration file Dec 29 18:07:22 so1905-cbb0 volumio[2291]: info: Loading plugin "upnp_browser"... Dec 29 18:07:22 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/upnp_browser/index.js Dec 29 18:07:22 so1905-cbb0 sudo[2378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 29 18:07:22 so1905-cbb0 sudo[2380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 29 18:07:22 so1905-cbb0 sudo[2378]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:22 so1905-cbb0 sudo[2380]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:22 so1905-cbb0 sudo[2378]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:23 so1905-cbb0 systemd[1]: Stopping Music Player Daemon... Dec 29 18:07:23 so1905-cbb0 systemd[1]: mpd.service: Succeeded. Dec 29 18:07:23 so1905-cbb0 systemd[1]: Stopped Music Player Daemon. Dec 29 18:07:23 so1905-cbb0 systemd[1]: Starting Music Player Daemon... Dec 29 18:07:23 so1905-cbb0 display[2137]: setImageSrc: this=0x1ffa3a0, str=/volumio/display/assets/source-icon/bt.png Dec 29 18:07:23 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/bt.png, size=11779, buffer[0]=89 Dec 29 18:07:23 so1905-cbb0 display[2137]: setImageSrc: this=0x1efb828, str=/volumio/display/assets/albumart.jpg Dec 29 18:07:23 so1905-cbb0 display[2137]: read file /volumio/display/assets/albumart.jpg, size=77672, buffer[0]=ff Dec 29 18:07:23 so1905-cbb0 display[2137]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF Dec 29 18:07:23 so1905-cbb0 display[2137]: Attempting to process with stb_image... Dec 29 18:07:23 so1905-cbb0 display[2137]: stb_image successfully loaded: 855x855, channels=3 Dec 29 18:07:23 so1905-cbb0 volumio[2291]: info: Loading plugin "networkfs"... Dec 29 18:07:23 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/system_controller/networkfs/index.js Dec 29 18:07:23 so1905-cbb0 display[2137]: Successfully processed with stb_image Dec 29 18:07:23 so1905-cbb0 display[2137]: Loading default image: /volumio/display/assets/albumart.jpg Dec 29 18:07:23 so1905-cbb0 display[2137]: Loaded default image from file: /volumio/display/assets/albumart.jpg, size=77672 Dec 29 18:07:23 so1905-cbb0 display[2137]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF Dec 29 18:07:23 so1905-cbb0 display[2137]: Attempting to process with stb_image... Dec 29 18:07:23 so1905-cbb0 volumio[2291]: [networkfs] Starting IP address watcher Dec 29 18:07:24 so1905-cbb0 volumio[2291]: [networkfs] Started network interface ip monitor watcher Dec 29 18:07:24 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 29 18:07:24 so1905-cbb0 volumio[2291]: info: Loading plugin "alarm-clock"... Dec 29 18:07:24 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/miscellanea/alarm-clock/index.js Dec 29 18:07:24 so1905-cbb0 display[2137]: stb_image successfully loaded: 855x855, channels=3 Dec 29 18:07:24 so1905-cbb0 display[2137]: Successfully processed with stb_image Dec 29 18:07:24 so1905-cbb0 display[2137]: Default image loaded successfully Dec 29 18:07:24 so1905-cbb0 display[2137]: setImageSrc: this=0x1efa720, str=/volumio/display/assets/status-icon/wifi-error.png Dec 29 18:07:24 so1905-cbb0 display[2137]: read file /volumio/display/assets/status-icon/wifi-error.png, size=1494, buffer[0]=89 Dec 29 18:07:24 so1905-cbb0 display[2137]: setImageSrc: this=0x1efa918, str=/volumio/display/assets/status-icon/eth-error.png Dec 29 18:07:24 so1905-cbb0 display[2137]: read file /volumio/display/assets/status-icon/eth-error.png, size=936, buffer[0]=89 Dec 29 18:07:24 so1905-cbb0 display[2137]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Dec 29 18:07:24 so1905-cbb0 display[2137]: 文件大小: 6344 字节 Dec 29 18:07:24 so1905-cbb0 display[2137]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 40px) Dec 29 18:07:24 so1905-cbb0 display[2137]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf Dec 29 18:07:24 so1905-cbb0 display[2137]: 文件大小: 11495876 字节 Dec 29 18:07:24 so1905-cbb0 display[2137]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf (大小: 40px) Dec 29 18:07:24 so1905-cbb0 display[2137]: setInnerAlign: image_desc is null Dec 29 18:07:24 so1905-cbb0 volumio[2291]: info: Loading plugin "airplay_emulation"... Dec 29 18:07:24 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/airplay_emulation/index.js Dec 29 18:07:24 so1905-cbb0 display[2137]: setImageSrc: this=0x1ffb050, str=/volumio/display/assets/source-icon/streaming.png Dec 29 18:07:24 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 29 18:07:24 so1905-cbb0 volumio[2291]: 执行命令出错: Error: Command failed: /usr/bin/dbus-send --system --dest=org.freedesktop.DBus --type=method_call --print-reply /org/freedesktop/DBus org.freedesktop.DBus.ListNames | grep org.gnome.ShairportSync Dec 29 18:07:24 so1905-cbb0 volumio[2291]: [airplay_emulation] Starting Shairport Sync Dec 29 18:07:24 so1905-cbb0 volumio[2291]: [airplay_emulation] [AirPlay] Started coverart directory watcher Dec 29 18:07:24 so1905-cbb0 volumio[2291]: info: Loading plugin "last_100"... Dec 29 18:07:24 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/last_100/index.js Dec 29 18:07:24 so1905-cbb0 volumio[2291]: info: Loading plugin "spop"... Dec 29 18:07:24 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/spop/index.js Dec 29 18:07:24 so1905-cbb0 display[2137]: setImageSrc: this=0x2000d40, str=/volumio/display/assets/source-icon/streaming.png Dec 29 18:07:24 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 29 18:07:25 so1905-cbb0 display[2137]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Dec 29 18:07:25 so1905-cbb0 display[2137]: 文件大小: 6344 字节 Dec 29 18:07:25 so1905-cbb0 display[2137]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 100px) Dec 29 18:07:25 so1905-cbb0 display[2137]: setImageSrc: this=0x1ffb6f0, str=/volumio/display/assets/source-icon/streaming.png Dec 29 18:07:25 so1905-cbb0 display[2137]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 29 18:07:25 so1905-cbb0 mpd[2394]: Dec 29 18:07 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 29 18:07:25 so1905-cbb0 mpd[2394]: Dec 29 18:07 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Dec 29 18:07:25 so1905-cbb0 mpd[2394]: Dec 29 18:07 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Dec 29 18:07:25 so1905-cbb0 systemd[1]: Started Music Player Daemon. Dec 29 18:07:25 so1905-cbb0 sudo[2380]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:25 so1905-cbb0 volumio[2291]: info: Loading plugin "webradio"... Dec 29 18:07:25 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/webradio/index.js Dec 29 18:07:27 so1905-cbb0 volumio[2291]: info: Loading plugin "yandex_browser"... Dec 29 18:07:27 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/yandex_browser/index.js Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [yandex_browser] Yandex plugin started Dec 29 18:07:28 so1905-cbb0 volumio[2291]: error: ATTENTION!!!: Plugin yandex_browser does not return adequate promise from onVolumioStart: please update! Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: Loading plugin "i2s_dacs"... Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/system_controller/i2s_dacs/index.js Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [i2s_dacs] I2S DAC not set, start Auto-detection Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: Loading plugin "volumiodiscovery"... Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/system_controller/volumiodiscovery/index.js Dec 29 18:07:28 so1905-cbb0 volumio[2291]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 29 18:07:28 so1905-cbb0 volumio[2291]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 29 18:07:28 so1905-cbb0 node[2291]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 29 18:07:28 so1905-cbb0 volumio[2291]: *** WARNING *** For more information see Dec 29 18:07:28 so1905-cbb0 volumio[2291]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 29 18:07:28 so1905-cbb0 volumio[2291]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 29 18:07:28 so1905-cbb0 volumio[2291]: *** WARNING *** For more information see Dec 29 18:07:28 so1905-cbb0 node[2291]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 29 18:07:28 so1905-cbb0 node[2291]: *** WARNING *** For more information see Dec 29 18:07:28 so1905-cbb0 node[2291]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 29 18:07:28 so1905-cbb0 node[2291]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 29 18:07:28 so1905-cbb0 node[2291]: *** WARNING *** For more information see Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [volumiodiscovery] Discovery: Started advertising with name: SO1905-cbb0 Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: Loading plugin "outputs"... Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/audio_interface/outputs/index.js Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: Loading plugin "albumart"... Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/miscellanea/albumart/index.js Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: Plugin example_plugin is not enabled Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: Loading plugin "inputs"... Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/inputs/index.js Dec 29 18:07:28 so1905-cbb0 volumio[2291]: info: Loading plugin "pandora"... Dec 29 18:07:28 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/pandora/index.js Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Applying required configuration parameters for plugin pandora Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Loading plugin "podcast"... Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/podcast/index.js Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [podcast] ControllerPodcast::constructor Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Loading plugin "qobuz"... Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/qobuz/index.js Dec 29 18:07:29 so1905-cbb0 volumio[2291]: error: ATTENTION!!!: Plugin qobuz does not return adequate promise from onVolumioStart: please update! Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Loading plugin "tidal"... Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/music_service/tidal/index.js Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [tidal] [1767002849669] ControllerTidalPlugin::constructor Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: [1767002849671] ControllerTidalPlugin::onVolumioStart Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Plugin volspotconnect2 is not enabled Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Loading plugin "updater_comm"... Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/system_controller/updater_comm/index.js Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Plugin mpdemulation is not enabled Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Loading plugin "rest_api"... Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/user_interface/rest_api/index.js Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: Loading plugin "websocket"... Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [ require ] /volumio/app/plugins/user_interface/websocket/index.js Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: ___________ START PLUGINS ___________ Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: [1767002849989] CoreMusicLibrary::Adding element Media Servers Dec 29 18:07:29 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:29 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: SSDP Client initialized. Dec 29 18:07:30 so1905-cbb0 volumio[2291]: Starting initial SSDP search... Dec 29 18:07:30 so1905-cbb0 volumio[2291]: Discovering on interface: lo Dec 29 18:07:30 so1905-cbb0 volumio[2291]: Discovering on interface: eth0 Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [airplay_emulation] Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850144] CoreMusicLibrary::Adding element Last_100 Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [spop] Creating Spotify config file Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850178] CoreMusicLibrary::Adding element Webradio Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [yandex_browser] Yandex plugin started Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850210] ControllerYandexPlugin::addToBrowseSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850212] CoreMusicLibrary::Adding element Yandex Music Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:printToastMessage Dec 29 18:07:30 so1905-cbb0 volumio[2291]: error: Plugin yandex_browser does not return adequate promise from onStart: please update! Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850229] CoreMusicLibrary::Adding element Pandora Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [pandora] [1767002850236] ControllerPandora::initializeMQTT Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [pandora] [1767002850237] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850254] CoreMusicLibrary::Adding element Podcast Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850261] CoreMusicLibrary::Adding element Qobuz Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850275] ControllerTidalPlugin::onStart Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850283] ControllerTidalPlugin::addToBrowseSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: [1767002850285] CoreMusicLibrary::Adding element Tidal Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: Loading i18n strings for locale en Dec 29 18:07:30 so1905-cbb0 volumio[2291]: Updating browse sources language Dec 29 18:07:30 so1905-cbb0 volumio[2291]: Cannot find translation for sourceMedia Servers Dec 29 18:07:30 so1905-cbb0 volumio[2291]: Cannot find translation for sourceYandex Music Dec 29 18:07:30 so1905-cbb0 volumio[2291]: Cannot find translation for sourcePodcast Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::initPlayerControls Dec 29 18:07:30 so1905-cbb0 kernel: usb0-vbus: disabling Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: BOOT COMPLETED Dec 29 18:07:30 so1905-cbb0 volumio[2291]: [Metrics] CommandRouter: 11s 774.02ms Dec 29 18:07:30 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 18:07:30 so1905-cbb0 kernel: sunxi-spdif 2036000.spdif: active: 1 Dec 29 18:07:35 so1905-cbb0 volumio[2291]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 29 18:07:35 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::Close All Modals sent Dec 29 18:07:35 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:35 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::Close All Modals sent Dec 29 18:07:35 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:35 so1905-cbb0 volumio[2291]: Express server listening on port 3000 Dec 29 18:07:35 so1905-cbb0 volumio[2291]: [Metrics] WebUI: 17s 965.14ms Dec 29 18:07:35 so1905-cbb0 volumio[2291]: (node:2291) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Dec 29 18:07:36 so1905-cbb0 volumio[2291]: [pandora] [1767002856059] ControllerPandora::validateAndSetAccountOptions Dec 29 18:07:36 so1905-cbb0 volumio[2291]: [pandora] [1767002856061] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Dec 29 18:07:36 so1905-cbb0 volumio[2291]: info: CoreStateMachine::resetVolumioState Dec 29 18:07:36 so1905-cbb0 volumio[2291]: info: CoreStateMachine::getcurrentVolume Dec 29 18:07:36 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioRetrievevolume Dec 29 18:07:36 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 18:07:36 so1905-cbb0 sudo[2432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 18:07:36 so1905-cbb0 volumio[2291]: [i2s_dacs] Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 29 18:07:36 so1905-cbb0 sudo[2432]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:36 so1905-cbb0 sudo[2434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 18:07:36 so1905-cbb0 sudo[2432]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:36 so1905-cbb0 sudo[2434]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:36 so1905-cbb0 sudo[2434]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:36 so1905-cbb0 volumio[2291]: [networkfs] IP address changed from "" to "192.168.2.112" Dec 29 18:07:36 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 29 18:07:36 so1905-cbb0 sudo[2461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 18:07:36 so1905-cbb0 sudo[2461]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:37 so1905-cbb0 sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 18:07:37 so1905-cbb0 sudo[2469]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:37 so1905-cbb0 sudo[2461]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:37 so1905-cbb0 sudo[2477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 18:07:37 so1905-cbb0 volumio[2291]: [networkfs] Connecting to wireless device: undefined Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: this.stateMachine.currentVolume: null, vol: 0 Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:37 so1905-cbb0 sudo[2477]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:37 so1905-cbb0 volumio[2291]: [airplay_emulation] [AirPlay] Received volume update: {"vol":0,"mute":false,"disableVolumeControl":false} Dec 29 18:07:37 so1905-cbb0 volumio[2291]: [airplay_emulation] Sending DBus command: /usr/bin/dbus-send --system --print-reply --dest=org.gnome.ShairportSync "/org/gnome/ShairportSync" org.gnome.ShairportSync.RemoteControl.SetAirplayVolume double:-30.00 Dec 29 18:07:37 so1905-cbb0 sudo[2489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 18:07:37 so1905-cbb0 sudo[2469]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:37 so1905-cbb0 sudo[2489]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreStateMachine::pushState Dec 29 18:07:37 so1905-cbb0 sudo[2499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 18:07:37 so1905-cbb0 sudo[2477]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 18:07:37 so1905-cbb0 sudo[2499]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:37 so1905-cbb0 volumio[2291]: [rest_api] API:pushState Dec 29 18:07:37 so1905-cbb0 sudo[2489]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreStateMachine::updateTrackBlock Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CorePlayQueue::getTrackBlock Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioRetrievevolume Dec 29 18:07:37 so1905-cbb0 sudo[2499]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:37 so1905-cbb0 volumio[2291]: [mpd] MPD Permissions set Dec 29 18:07:37 so1905-cbb0 volumio[2291]: ControllerNetwork getNetworkHardwares wlan0 undefined Dec 29 18:07:37 so1905-cbb0 volumio[2291]: ControllerNetwork getNetworkHardwares eth0 { interface: 'eth0:', Dec 29 18:07:37 so1905-cbb0 volumio[2291]: address: 'fe:73:c0:25:75:94', Dec 29 18:07:37 so1905-cbb0 volumio[2291]: ipv4_address: '192.168.2.112', Dec 29 18:07:37 so1905-cbb0 volumio[2291]: ipv4_broadcast: '192.168.2.255', Dec 29 18:07:37 so1905-cbb0 volumio[2291]: ipv4_subnet_mask: '255.255.255.0', Dec 29 18:07:37 so1905-cbb0 volumio[2291]: up: true, Dec 29 18:07:37 so1905-cbb0 volumio[2291]: broadcast: true, Dec 29 18:07:37 so1905-cbb0 volumio[2291]: running: true, Dec 29 18:07:37 so1905-cbb0 volumio[2291]: multicast: true } Dec 29 18:07:37 so1905-cbb0 volumio[2291]: [network] ControllerNetwork onWireless start Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 29 18:07:37 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 29 18:07:38 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 29 18:07:38 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 29 18:07:38 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 29 18:07:38 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [mpd] MPD running with PID2394 Dec 29 18:07:38 so1905-cbb0 volumio[2291]: ,establishing connection Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [i2s_dacs] Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 29 18:07:38 so1905-cbb0 volumio[2291]: sudo: /usr/sbin/i2cdetect: command not found Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [airplay_emulation] DBus command failed: Command failed: /usr/bin/dbus-send --system --print-reply --dest=org.gnome.ShairportSync "/org/gnome/ShairportSync" org.gnome.ShairportSync.RemoteControl.SetAirplayVolume double:-30.00 Dec 29 18:07:38 so1905-cbb0 volumio[2291]: Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files Dec 29 18:07:38 so1905-cbb0 volumio[2291]: { stdout: '', Dec 29 18:07:38 so1905-cbb0 volumio[2291]: stderr: Dec 29 18:07:38 so1905-cbb0 volumio[2291]: 'Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files\n' } Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [rest_api] API:emitFavourites Dec 29 18:07:38 so1905-cbb0 volumio[2543]: Forking 1 albumart workers Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [spop] Spotify config file written Dec 29 18:07:38 so1905-cbb0 volumio[2291]: sendCommand: Command { name: 'playlistinfo', args: [] } Dec 29 18:07:38 so1905-cbb0 sudo[2568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart go-librespot-daemon.service Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [mpd] MPD error: false == true Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [mpd] false == true Dec 29 18:07:38 so1905-cbb0 volumio[2291]: sendCommand: Command { name: 'search album ""', args: [] } Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [mpd] MPD error: false == true Dec 29 18:07:38 so1905-cbb0 volumio[2291]: [mpd] false == true Dec 29 18:07:39 so1905-cbb0 sudo[2568]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 29 18:07:39 so1905-cbb0 volumio[2291]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 29 18:07:39 so1905-cbb0 systemd[1]: Started go-librespot Daemon. Dec 29 18:07:39 so1905-cbb0 volumio[2291]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 29 18:07:39 so1905-cbb0 sudo[2568]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:39 so1905-cbb0 go-librespot[2583]: go-librespot daemon starting... Dec 29 18:07:39 so1905-cbb0 volumio[2291]: [spop] No need to fix Spotify hosts Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 18:07:39 so1905-cbb0 volumio[2291]: sendCommand: Command { name: 'playlistinfo', args: [] } Dec 29 18:07:39 so1905-cbb0 volumio[2291]: sendCommand: Command { name: 'lsinfo "USB"', args: [] } Dec 29 18:07:39 so1905-cbb0 display[2137]: setImageSrc: this=0x1efa918, str=/volumio/display/assets/status-icon/eth_ok.png Dec 29 18:07:39 so1905-cbb0 display[2137]: read file /volumio/display/assets/status-icon/eth_ok.png, size=990, buffer[0]=89 Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreStateMachine::setRepeat null single undefined Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreStateMachine::pushState Dec 29 18:07:39 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 18:07:39 so1905-cbb0 volumio[2291]: [rest_api] API:pushState Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CoreStateMachine::setRandom null Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CoreStateMachine::pushState Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 18:07:40 so1905-cbb0 volumio[2291]: [rest_api] API:pushState Dec 29 18:07:40 so1905-cbb0 display[2137]: setImageSrc: this=0x1efb828, str=http://127.0.0.1:3000/albumart Dec 29 18:07:40 so1905-cbb0 volumio[2291]: [websocket] Received Get System Version Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 29 18:07:40 so1905-cbb0 go-librespot[2597]: time="2025-12-29T18:07:40+08:00" level=info msg="running go-librespot 0.0.0" Dec 29 18:07:40 so1905-cbb0 go-librespot[2597]: time="2025-12-29T18:07:40+08:00" level=debug msg="app state loaded" Dec 29 18:07:40 so1905-cbb0 go-librespot[2597]: time="2025-12-29T18:07:40+08:00" level=debug msg="stored credentials not found" Dec 29 18:07:40 so1905-cbb0 go-librespot[2597]: time="2025-12-29T18:07:40+08:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 29 18:07:40 so1905-cbb0 sudo[2610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 18:07:40 so1905-cbb0 sudo[2610]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:40 so1905-cbb0 sudo[2620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 18:07:40 so1905-cbb0 sudo[2620]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 29 18:07:40 so1905-cbb0 sudo[2626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CoreCommandRouter::volumioGetQueue Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CoreStateMachine::getQueue Dec 29 18:07:40 so1905-cbb0 volumio[2291]: info: CorePlayQueue::getQueue Dec 29 18:07:40 so1905-cbb0 volumio[2291]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Dec 29 18:07:40 so1905-cbb0 sudo[2626]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:40 so1905-cbb0 sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 18:07:40 so1905-cbb0 volumio[2291]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Dec 29 18:07:40 so1905-cbb0 sudo[2610]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:41 so1905-cbb0 sudo[2643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 18:07:41 so1905-cbb0 volumio[2291]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Dec 29 18:07:41 so1905-cbb0 sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:41 so1905-cbb0 sudo[2620]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:41 so1905-cbb0 sudo[2643]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Dec 29 18:07:41 so1905-cbb0 sudo[2637]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:41 so1905-cbb0 volumio[2291]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Dec 29 18:07:41 so1905-cbb0 sudo[2626]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:41 so1905-cbb0 volumio[2291]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Dec 29 18:07:41 so1905-cbb0 sudo[2643]: pam_unix(sudo:session): session closed for user root Dec 29 18:07:41 so1905-cbb0 volumio[2291]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Dec 29 18:07:41 so1905-cbb0 go-librespot[2597]: time="2025-12-29T18:07:41+08:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 29 18:07:41 so1905-cbb0 go-librespot[2597]: time="2025-12-29T18:07:41+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Dec 29 18:07:41 so1905-cbb0 go-librespot[2597]: time="2025-12-29T18:07:41+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Dec 29 18:07:41 so1905-cbb0 go-librespot[2597]: time="2025-12-29T18:07:41+08:00" level=info msg="zeroconf server listening on port 43233" Dec 29 18:07:41 so1905-cbb0 go-librespot[2597]: 2025/12/29 18:07:41 [zeroconf] no suitable IPv6 interface: listen udp6 [ff02::]:5353: socket: address family not supported by protocol Dec 29 18:07:41 so1905-cbb0 volumio[2291]: [mpd] updateQueue error: null Dec 29 18:07:41 so1905-cbb0 volumio[2291]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 18:07:41 so1905-cbb0 volumio[2291]: { Error: ENOENT: no such file or directory, stat '/mnt/USB/0867-790B' Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at Object.statSync (fs.js:855:3) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at eval (webpack://Volumio2/./app/plugins/music_service/mpd/index.js?:1586:23) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at MpdClient.handleMessage (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:77:3) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at MpdClient.receive (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:68:12) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at Socket.eval (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:43:12) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at Socket.emit (events.js:198:13) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at addChunk (_stream_readable.js:288:12) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at readableAddChunk (_stream_readable.js:265:13) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at Socket.Readable.push (_stream_readable.js:224:10) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: at Pipe.onStreamRead [as onread] (internal/stream_base_commons.js:94:17) Dec 29 18:07:41 so1905-cbb0 volumio[2291]: errno: -2, Dec 29 18:07:41 so1905-cbb0 volumio[2291]: syscall: 'stat', Dec 29 18:07:41 so1905-cbb0 volumio[2291]: code: 'ENOENT', Dec 29 18:07:41 so1905-cbb0 volumio[2291]: path: '/mnt/USB/0867-790B' } Dec 29 18:07:41 so1905-cbb0 volumio[2291]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 18:07:42 so1905-cbb0 volumio[2566]: Starting albumart workers Dec 29 18:07:43 so1905-cbb0 sudo[2709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-29 18:06 Dec 29 18:07:43 so1905-cbb0 sudo[2709]: pam_unix(sudo:session): session opened for user root by (uid=0) NAME="Ubuntu" VERSION="20.04.5 LTS (Focal Fossa)" ID=ubuntu ID_LIKE=debian PRETTY_NAME="Ubuntu 20.04.5 LTS" VERSION_ID="20.04" HOME_URL="https://www.ubuntu.com/" SUPPORT_URL="https://help.ubuntu.com/" BUG_REPORT_URL="https://bugs.launchpad.net/ubuntu/" PRIVACY_POLICY_URL="https://www.ubuntu.com/legal/terms-and-policies/privacy-policy" VERSION_CODENAME=focal UBUNTU_CODENAME=focal BRAND_NAME="PREMIERA" MODEL_NAME="FT1905" IMG_VERSION="1.100.006" VOLUMIO_BUILD_VERSION="" VOLUMIO_ARCH="armv7" VOLUMIO_VERSION=1.5.6.30 VOLUMIO_BUILD_DATE=2025-12-25 11:00:29 VOLUMIO_VARIANT=volumio VOLUMIO_HARDWARE=Generic DT based system