-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Wed 2025-12-31 09:17:20 CST. -- Dec 31 09:16:56 so1905-ff03 systemd-timesyncd[2158]: Initial synchronization to time server 185.125.190.58:123 (ntp.ubuntu.com). Dec 31 09:16:56 so1905-ff03 sudo[2537]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:16:56 so1905-ff03 sudo[2542]: pam_unix(sudo:session): session closed for user root Dec 31 09:16:56 so1905-ff03 nmbd[2249]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.23.150 for name WORKGROUP<1d>. Dec 31 09:16:56 so1905-ff03 nmbd[2249]: This response was from IP 192.168.23.83, reporting an IP address of 192.168.23.83. Dec 31 09:16:56 so1905-ff03 nmbd[2249]: [2025/12/31 09:16:56.277860, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 31 09:16:56 so1905-ff03 nmbd[2249]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.23.150 for name WORKGROUP<1d>. Dec 31 09:16:56 so1905-ff03 nmbd[2249]: This response was from IP 192.168.23.83, reporting an IP address of 192.168.23.83. Dec 31 09:16:56 so1905-ff03 sudo[2537]: pam_unix(sudo:session): session closed for user root Dec 31 09:16:56 so1905-ff03 systemd[1]: Starting Daily apt download activities... Dec 31 09:16:56 so1905-ff03 systemd[1]: Started go-librespot Daemon. Dec 31 09:16:56 so1905-ff03 systemd[1]: Starting Message of the Day... Dec 31 09:16:56 so1905-ff03 go-librespot[2578]: go-librespot daemon starting... Dec 31 09:16:56 so1905-ff03 systemd[1]: Starting Rotate log files... Dec 31 09:16:56 so1905-ff03 systemd[1]: motd-news.service: Succeeded. Dec 31 09:16:56 so1905-ff03 systemd[1]: Finished Message of the Day. Dec 31 09:16:56 so1905-ff03 volumio[2334]: [alsa_controller] Creating shared var alsa.outputdevice='2' Dec 31 09:16:56 so1905-ff03 volumio[2334]: info: Loading plugin "wizard"... Dec 31 09:16:56 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/miscellanea/wizard/index.js Dec 31 09:16:56 so1905-ff03 volumio[2334]: info: Loading plugin "volumio_command_line_client"... Dec 31 09:16:56 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/system_controller/volumio_command_line_client/index.js Dec 31 09:16:57 so1905-ff03 volumio[2334]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/getvolumedb.sh.template Dec 31 09:16:57 so1905-ff03 volumio[2334]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/setvolumedb.sh.template Dec 31 09:16:57 so1905-ff03 volumio[2334]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/getvolume.sh.template Dec 31 09:16:57 so1905-ff03 volumio[2334]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/setvolume.sh.template Dec 31 09:16:57 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:16:57 so1905-ff03 smbd[2570]: [2025/12/31 09:16:57.117485, 0] ../../source3/smbd/server.c:1734(main) Dec 31 09:16:57 so1905-ff03 smbd[2570]: smbd version 4.15.13-Ubuntu started. Dec 31 09:16:57 so1905-ff03 smbd[2570]: Copyright Andrew Tridgell and the Samba Team 1992-2021 Dec 31 09:16:57 so1905-ff03 display[2188]: setImageSrc: this=0x2ef2c30, str=/volumio/display/assets/source-icon/bt.png Dec 31 09:16:57 so1905-ff03 display[2188]: read file /volumio/display/assets/source-icon/bt.png, size=11779, buffer[0]=89 Dec 31 09:16:57 so1905-ff03 udhcpc[2594]: wlan0: bound: IP=192.168.23.150/255.255.255.0 router=192.168.23.1 domain="" dns="211.136.192.6 120.196.165.24" lease=7200 Dec 31 09:16:57 so1905-ff03 sudo[2413]: pam_unix(sudo:session): session closed for user root Dec 31 09:16:57 so1905-ff03 volumio[2334]: info: Loading plugin "upnp"... Dec 31 09:16:57 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/audio_interface/upnp/index.js Dec 31 09:16:57 so1905-ff03 display[2188]: setImageSrc: this=0x2df9860, str=/volumio/display/assets/albumart.jpg Dec 31 09:16:57 so1905-ff03 volumio[2334]: info: [1767143817464] Starting Upmpd Daemon Dec 31 09:16:57 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 31 09:16:57 so1905-ff03 volumio[2334]: info: Loading plugin "my_music"... Dec 31 09:16:57 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/miscellanea/my_music/index.js Dec 31 09:16:57 so1905-ff03 display[2188]: read file /volumio/display/assets/albumart.jpg, size=77672, buffer[0]=ff Dec 31 09:16:57 so1905-ff03 display[2188]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF Dec 31 09:16:57 so1905-ff03 display[2188]: Attempting to process with stb_image... Dec 31 09:16:57 so1905-ff03 volumio[2334]: info: Loading plugin "mpd"... Dec 31 09:16:57 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/mpd/index.js Dec 31 09:16:57 so1905-ff03 kernel: [SNDCODEC][sunxi_check_hs_detect_status][191]:plugin --> switch:1 Dec 31 09:16:57 so1905-ff03 display[2188]: stb_image successfully loaded: 855x855, channels=3 Dec 31 09:16:57 so1905-ff03 display[2188]: Successfully processed with stb_image Dec 31 09:16:57 so1905-ff03 display[2188]: Loading default image: /volumio/display/assets/albumart.jpg Dec 31 09:16:57 so1905-ff03 display[2188]: Loaded default image from file: /volumio/display/assets/albumart.jpg, size=77672 Dec 31 09:16:57 so1905-ff03 display[2188]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF Dec 31 09:16:57 so1905-ff03 display[2188]: Attempting to process with stb_image... Dec 31 09:16:57 so1905-ff03 systemd[1]: Started Samba SMB Daemon. Dec 31 09:16:57 so1905-ff03 systemd[1]: Reached target Multi-User System. Dec 31 09:16:57 so1905-ff03 systemd[1]: Reached target Graphical Interface. Dec 31 09:16:57 so1905-ff03 go-librespot[2606]: time="2025-12-31T09:16:57+08:00" level=info msg="running go-librespot 0.0.0" Dec 31 09:16:57 so1905-ff03 go-librespot[2606]: time="2025-12-31T09:16:57+08:00" level=debug msg="app state loaded" Dec 31 09:16:57 so1905-ff03 go-librespot[2606]: time="2025-12-31T09:16:57+08:00" level=debug msg="stored credentials not found" Dec 31 09:16:57 so1905-ff03 systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 31 09:16:57 so1905-ff03 go-librespot[2606]: time="2025-12-31T09:16:57+08:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 31 09:16:58 so1905-ff03 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 31 09:16:58 so1905-ff03 systemd[1]: Finished Update UTMP about System Runlevel Changes. Dec 31 09:16:58 so1905-ff03 display[2188]: stb_image successfully loaded: 855x855, channels=3 Dec 31 09:16:58 so1905-ff03 display[2188]: Successfully processed with stb_image Dec 31 09:16:58 so1905-ff03 display[2188]: Default image loaded successfully Dec 31 09:16:58 so1905-ff03 display[2188]: setImageSrc: this=0x2df8720, str=/volumio/display/assets/status-icon/wifi-error.png Dec 31 09:16:58 so1905-ff03 display[2188]: read file /volumio/display/assets/status-icon/wifi-error.png, size=1494, buffer[0]=89 Dec 31 09:16:58 so1905-ff03 display[2188]: setImageSrc: this=0x2df8918, str=/volumio/display/assets/status-icon/eth-error.png Dec 31 09:16:58 so1905-ff03 display[2188]: read file /volumio/display/assets/status-icon/eth-error.png, size=936, buffer[0]=89 Dec 31 09:16:58 so1905-ff03 display[2188]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Dec 31 09:16:58 so1905-ff03 display[2188]: 文件大小: 6344 字节 Dec 31 09:16:58 so1905-ff03 display[2188]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 40px) Dec 31 09:16:58 so1905-ff03 display[2188]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf Dec 31 09:16:58 so1905-ff03 display[2188]: 文件大小: 11495876 字节 Dec 31 09:16:58 so1905-ff03 display[2188]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf (大小: 40px) Dec 31 09:16:58 so1905-ff03 display[2188]: setInnerAlign: image_desc is null Dec 31 09:16:58 so1905-ff03 smbd[2570]: [2025/12/31 09:16:58.848562, 0] ../../source3/smbd/server.c:1082(smbd_open_one_socket) Dec 31 09:16:58 so1905-ff03 smbd[2570]: smbd_open_one_socket: open_socket_in failed: Address family not supported by protocol Dec 31 09:16:58 so1905-ff03 volumio[2334]: [mpd] MPD: starting udev watcher for USB partitions Dec 31 09:16:58 so1905-ff03 volumio[2334]: [mpd] Creating MPD Configuration file Dec 31 09:16:58 so1905-ff03 smbd[2570]: [2025/12/31 09:16:58.867428, 0] ../../source3/smbd/server.c:1082(smbd_open_one_socket) Dec 31 09:16:58 so1905-ff03 smbd[2570]: smbd_open_one_socket: open_socket_in failed: Address family not supported by protocol Dec 31 09:16:58 so1905-ff03 volumio[2334]: info: Loading plugin "upnp_browser"... Dec 31 09:16:58 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/upnp_browser/index.js Dec 31 09:16:58 so1905-ff03 go-librespot[2606]: time="2025-12-31T09:16:58+08:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 31 09:16:58 so1905-ff03 go-librespot[2606]: time="2025-12-31T09:16:58+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 31 09:16:58 so1905-ff03 go-librespot[2606]: time="2025-12-31T09:16:58+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 31 09:16:59 so1905-ff03 sudo[2621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 31 09:16:59 so1905-ff03 go-librespot[2606]: time="2025-12-31T09:16:59+08:00" level=info msg="zeroconf server listening on port 34289" Dec 31 09:16:59 so1905-ff03 go-librespot[2606]: 2025/12/31 09:16:59 [zeroconf] no suitable IPv6 interface: listen udp6 [ff02::]:5353: socket: address family not supported by protocol Dec 31 09:16:59 so1905-ff03 display[2188]: setImageSrc: this=0x2ef46a0, str=/volumio/display/assets/source-icon/streaming.png Dec 31 09:16:59 so1905-ff03 display[2188]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 31 09:16:59 so1905-ff03 sudo[2621]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:16:59 so1905-ff03 sudo[2623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 31 09:16:59 so1905-ff03 sudo[2621]: pam_unix(sudo:session): session closed for user root Dec 31 09:16:59 so1905-ff03 sudo[2623]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:16:59 so1905-ff03 display[2188]: setImageSrc: this=0x2efa2c8, str=/volumio/display/assets/source-icon/streaming.png Dec 31 09:16:59 so1905-ff03 display[2188]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 31 09:16:59 so1905-ff03 systemd[1]: Stopping Music Player Daemon... Dec 31 09:16:59 so1905-ff03 display[2188]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Dec 31 09:16:59 so1905-ff03 display[2188]: 文件大小: 6344 字节 Dec 31 09:16:59 so1905-ff03 display[2188]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 100px) Dec 31 09:16:59 so1905-ff03 display[2188]: setImageSrc: this=0x2dd1d90, str=/volumio/display/assets/source-icon/streaming.png Dec 31 09:16:59 so1905-ff03 display[2188]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 31 09:16:59 so1905-ff03 systemd[1]: mpd.service: Succeeded. Dec 31 09:16:59 so1905-ff03 systemd[1]: Stopped Music Player Daemon. Dec 31 09:16:59 so1905-ff03 systemd[1]: Starting Music Player Daemon... Dec 31 09:16:59 so1905-ff03 kernel: [SNDCODEC][sunxi_check_hs_detect_status][222]:plugout --> switch:0 Dec 31 09:17:00 so1905-ff03 volumio[2334]: info: Loading plugin "networkfs"... Dec 31 09:17:00 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/system_controller/networkfs/index.js Dec 31 09:17:00 so1905-ff03 volumio[2334]: [networkfs] Starting IP address watcher Dec 31 09:17:00 so1905-ff03 volumio[2334]: [networkfs] Started network interface ip monitor watcher Dec 31 09:17:00 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 31 09:17:00 so1905-ff03 volumio[2334]: info: Loading plugin "alarm-clock"... Dec 31 09:17:00 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/miscellanea/alarm-clock/index.js Dec 31 09:17:00 so1905-ff03 volumio[2334]: info: Loading plugin "airplay_emulation"... Dec 31 09:17:00 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/airplay_emulation/index.js Dec 31 09:17:00 so1905-ff03 volumio[2334]: 执行命令出错: 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 31 09:17:00 so1905-ff03 volumio[2334]: [airplay_emulation] Starting Shairport Sync Dec 31 09:17:01 so1905-ff03 volumio[2334]: [airplay_emulation] [AirPlay] Started coverart directory watcher Dec 31 09:17:01 so1905-ff03 volumio[2334]: info: Loading plugin "last_100"... Dec 31 09:17:01 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/last_100/index.js Dec 31 09:17:01 so1905-ff03 volumio[2334]: info: Loading plugin "spop"... Dec 31 09:17:01 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/spop/index.js Dec 31 09:17:01 so1905-ff03 mpd[2641]: Dec 31 09:17 : exception: bind to '/run/mpd/socket' failed (continuing anyway, because binding to '/run/mpd/socket' succeeded): Failed to bind socket: Address already in use Dec 31 09:17:01 so1905-ff03 mpd[2641]: Dec 31 09:17 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 31 09:17:01 so1905-ff03 systemd[1]: Started Music Player Daemon. Dec 31 09:17:01 so1905-ff03 sudo[2623]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:01 so1905-ff03 volumio[2334]: info: Loading plugin "webradio"... Dec 31 09:17:01 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/webradio/index.js Dec 31 09:17:02 so1905-ff03 nmbd[2249]: [2025/12/31 09:17:02.115067, 0] ../../source3/nmbd/nmbd_workgroupdb.c:279(dump_workgroups) Dec 31 09:17:02 so1905-ff03 nmbd[2249]: dump_workgroups() Dec 31 09:17:02 so1905-ff03 nmbd[2249]: dump workgroup on subnet 192.168.23.150: netmask= 255.255.255.0: Dec 31 09:17:02 so1905-ff03 nmbd[2249]: WORKGROUP(1) current master browser = UNKNOWN Dec 31 09:17:02 so1905-ff03 nmbd[2249]: VOLUMIO 40809a03 (Volumio Audiophile Music Player) Dec 31 09:17:02 so1905-ff03 nmbd[2249]: [2025/12/31 09:17:02.115926, 0] ../../source3/nmbd/nmbd_workgroupdb.c:279(dump_workgroups) Dec 31 09:17:02 so1905-ff03 nmbd[2249]: dump_workgroups() Dec 31 09:17:02 so1905-ff03 nmbd[2249]: dump workgroup on subnet UNICAST_SUBNET: netmask= 192.168.23.150: Dec 31 09:17:02 so1905-ff03 nmbd[2249]: WORKGROUP(1) current master browser = UNKNOWN Dec 31 09:17:02 so1905-ff03 nmbd[2249]: VOLUMIO 40809a03 (Volumio Audiophile Music Player) Dec 31 09:17:02 so1905-ff03 systemd[1]: logrotate.service: Succeeded. Dec 31 09:17:02 so1905-ff03 systemd[1]: Finished Rotate log files. Dec 31 09:17:04 so1905-ff03 kernel: usb0-vbus: disabling Dec 31 09:17:04 so1905-ff03 volumio[2334]: info: Loading plugin "yandex_browser"... Dec 31 09:17:04 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/yandex_browser/index.js Dec 31 09:17:04 so1905-ff03 volumio[2334]: [yandex_browser] Yandex plugin started Dec 31 09:17:04 so1905-ff03 volumio[2334]: error: ATTENTION!!!: Plugin yandex_browser does not return adequate promise from onVolumioStart: please update! Dec 31 09:17:04 so1905-ff03 volumio[2334]: info: Loading plugin "i2s_dacs"... Dec 31 09:17:04 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/system_controller/i2s_dacs/index.js Dec 31 09:17:04 so1905-ff03 volumio[2334]: [i2s_dacs] I2S DAC not set, start Auto-detection Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Loading plugin "volumiodiscovery"... Dec 31 09:17:05 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/system_controller/volumiodiscovery/index.js Dec 31 09:17:05 so1905-ff03 volumio[2334]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 31 09:17:05 so1905-ff03 volumio[2334]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 31 09:17:05 so1905-ff03 volumio[2334]: *** WARNING *** For more information see Dec 31 09:17:05 so1905-ff03 volumio[2334]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 31 09:17:05 so1905-ff03 volumio[2334]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 31 09:17:05 so1905-ff03 volumio[2334]: *** WARNING *** For more information see Dec 31 09:17:05 so1905-ff03 node[2334]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 31 09:17:05 so1905-ff03 node[2334]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 31 09:17:05 so1905-ff03 node[2334]: *** WARNING *** For more information see Dec 31 09:17:05 so1905-ff03 node[2334]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 31 09:17:05 so1905-ff03 node[2334]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 31 09:17:05 so1905-ff03 node[2334]: *** WARNING *** For more information see Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 31 09:17:05 so1905-ff03 volumio[2334]: [volumiodiscovery] Discovery: Started advertising with name: SO1905-ff03 Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Loading plugin "outputs"... Dec 31 09:17:05 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/audio_interface/outputs/index.js Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Loading plugin "albumart"... Dec 31 09:17:05 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/miscellanea/albumart/index.js Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Plugin example_plugin is not enabled Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Loading plugin "inputs"... Dec 31 09:17:05 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/inputs/index.js Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Loading plugin "pandora"... Dec 31 09:17:05 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/pandora/index.js Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Applying required configuration parameters for plugin pandora Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Loading plugin "podcast"... Dec 31 09:17:05 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/podcast/index.js Dec 31 09:17:05 so1905-ff03 volumio[2334]: [podcast] ControllerPodcast::constructor Dec 31 09:17:05 so1905-ff03 volumio[2334]: info: Loading plugin "qobuz"... Dec 31 09:17:05 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/qobuz/index.js Dec 31 09:17:06 so1905-ff03 volumio[2334]: error: ATTENTION!!!: Plugin qobuz does not return adequate promise from onVolumioStart: please update! Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: Loading plugin "tidal"... Dec 31 09:17:06 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/music_service/tidal/index.js Dec 31 09:17:06 so1905-ff03 volumio[2334]: [tidal] [1767143826167] ControllerTidalPlugin::constructor Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826169] ControllerTidalPlugin::onVolumioStart Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: Plugin volspotconnect2 is not enabled Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: Loading plugin "updater_comm"... Dec 31 09:17:06 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/system_controller/updater_comm/index.js Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: Plugin mpdemulation is not enabled Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: Loading plugin "rest_api"... Dec 31 09:17:06 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/user_interface/rest_api/index.js Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: Loading plugin "websocket"... Dec 31 09:17:06 so1905-ff03 volumio[2334]: [ require ] /volumio/app/plugins/user_interface/websocket/index.js Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: ___________ START PLUGINS ___________ Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826501] CoreMusicLibrary::Adding element Media Servers Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: SSDP Client initialized. Dec 31 09:17:06 so1905-ff03 volumio[2334]: Starting initial SSDP search... Dec 31 09:17:06 so1905-ff03 volumio[2334]: Discovering on interface: lo Dec 31 09:17:06 so1905-ff03 volumio[2334]: Discovering on interface: wlan0 Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:06 so1905-ff03 volumio[2334]: [airplay_emulation] Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826641] CoreMusicLibrary::Adding element Last_100 Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: [spop] Creating Spotify config file Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826684] CoreMusicLibrary::Adding element Webradio Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 31 09:17:06 so1905-ff03 volumio[2334]: [yandex_browser] Yandex plugin started Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826707] ControllerYandexPlugin::addToBrowseSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826709] CoreMusicLibrary::Adding element Yandex Music Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:printToastMessage Dec 31 09:17:06 so1905-ff03 volumio[2334]: error: Plugin yandex_browser does not return adequate promise from onStart: please update! Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826726] CoreMusicLibrary::Adding element Pandora Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: [pandora] [1767143826733] ControllerPandora::initializeMQTT Dec 31 09:17:06 so1905-ff03 volumio[2334]: [pandora] [1767143826734] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826751] CoreMusicLibrary::Adding element Podcast Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826759] CoreMusicLibrary::Adding element Qobuz Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826774] ControllerTidalPlugin::onStart Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826782] ControllerTidalPlugin::addToBrowseSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: [1767143826783] CoreMusicLibrary::Adding element Tidal Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: Loading i18n strings for locale en Dec 31 09:17:06 so1905-ff03 volumio[2334]: Updating browse sources language Dec 31 09:17:06 so1905-ff03 volumio[2334]: Cannot find translation for sourceMedia Servers Dec 31 09:17:06 so1905-ff03 volumio[2334]: Cannot find translation for sourceYandex Music Dec 31 09:17:06 so1905-ff03 volumio[2334]: Cannot find translation for sourcePodcast Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:17:06 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::initPlayerControls Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:06 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 31 09:17:07 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:07 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:07 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:07 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:07 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:07 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:17:07 so1905-ff03 volumio[2334]: info: BOOT COMPLETED Dec 31 09:17:07 so1905-ff03 volumio[2334]: [Metrics] CommandRouter: 13s 883.20ms Dec 31 09:17:07 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:17:07 so1905-ff03 kernel: sunxi-spdif 2036000.spdif: active: 1 Dec 31 09:17:12 so1905-ff03 volumio[2334]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 31 09:17:12 so1905-ff03 volumio[2334]: info: CoreCommandRouter::Close All Modals sent Dec 31 09:17:12 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:12 so1905-ff03 volumio[2334]: info: CoreCommandRouter::Close All Modals sent Dec 31 09:17:12 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:12 so1905-ff03 volumio[2334]: Express server listening on port 3000 Dec 31 09:17:12 so1905-ff03 volumio[2334]: [Metrics] WebUI: 20s 204.72ms Dec 31 09:17:12 so1905-ff03 volumio[2334]: (node:2334) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Dec 31 09:17:12 so1905-ff03 volumio[2334]: [pandora] [1767143832554] ControllerPandora::validateAndSetAccountOptions Dec 31 09:17:12 so1905-ff03 volumio[2334]: [pandora] [1767143832557] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Dec 31 09:17:12 so1905-ff03 volumio[2334]: info: CoreStateMachine::resetVolumioState Dec 31 09:17:12 so1905-ff03 volumio[2334]: info: CoreStateMachine::getcurrentVolume Dec 31 09:17:12 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioRetrievevolume Dec 31 09:17:12 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:17:12 so1905-ff03 sudo[2685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 31 09:17:12 so1905-ff03 volumio[2334]: [i2s_dacs] Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 31 09:17:12 so1905-ff03 sudo[2687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 31 09:17:12 so1905-ff03 sudo[2685]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:17:12 so1905-ff03 sudo[2687]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:17:13 so1905-ff03 sudo[2685]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:13 so1905-ff03 sudo[2687]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:13 so1905-ff03 volumio[2334]: [networkfs] IP address changed from "" to "192.168.23.150" Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 31 09:17:13 so1905-ff03 sudo[2710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 31 09:17:13 so1905-ff03 sudo[2710]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:17:13 so1905-ff03 sudo[2710]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:13 so1905-ff03 sudo[2718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 31 09:17:13 so1905-ff03 volumio[2334]: [networkfs] Connecting to wireless device: undefined Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: this.stateMachine.currentVolume: null, vol: 0 Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:13 so1905-ff03 volumio[2334]: [airplay_emulation] [AirPlay] Received volume update: {"vol":0,"mute":false,"disableVolumeControl":false} Dec 31 09:17:13 so1905-ff03 volumio[2334]: [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 31 09:17:13 so1905-ff03 sudo[2736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 31 09:17:13 so1905-ff03 sudo[2718]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:17:13 so1905-ff03 sudo[2725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: CoreStateMachine::pushState Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 09:17:13 so1905-ff03 volumio[2334]: [rest_api] API:pushState Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: CoreStateMachine::updateTrackBlock Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: CorePlayQueue::getTrackBlock Dec 31 09:17:13 so1905-ff03 volumio[2334]: info: CoreCommandRouter::volumioRetrievevolume Dec 31 09:17:13 so1905-ff03 sudo[2718]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:13 so1905-ff03 sudo[2736]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:17:13 so1905-ff03 sudo[2725]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:17:13 so1905-ff03 sudo[2736]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:13 so1905-ff03 sudo[2740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 31 09:17:13 so1905-ff03 sudo[2725]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:14 so1905-ff03 sudo[2740]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:17:14 so1905-ff03 sudo[2740]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:14 so1905-ff03 volumio[2334]: [mpd] MPD Permissions set Dec 31 09:17:14 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 31 09:17:14 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:17:14 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 31 09:17:14 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 31 09:17:14 so1905-ff03 volumio[2334]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 31 09:17:14 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: network , pushNetworkConfiguredStatus Dec 31 09:17:14 so1905-ff03 volumio[2334]: [network] pushNetworkConfiguredResult { status: 'success', message: 'ok', ssid: 'FORTEX_5G' } Dec 31 09:17:14 so1905-ff03 volumio[2334]: [network] Push network configured result Dec 31 09:17:14 so1905-ff03 volumio[2334]: [network] pushNetworkConfiguredResult callbackIp: networkSsid: FORTEX_5G Dec 31 09:17:14 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:15 so1905-ff03 volumio[2334]: [mpd] MPD running with PID2641 Dec 31 09:17:15 so1905-ff03 volumio[2334]: ,establishing connection Dec 31 09:17:15 so1905-ff03 volumio[2334]: [i2s_dacs] Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 31 09:17:15 so1905-ff03 volumio[2334]: sudo: /usr/sbin/i2cdetect: command not found Dec 31 09:17:15 so1905-ff03 volumio[2334]: [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 31 09:17:15 so1905-ff03 volumio[2334]: Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files Dec 31 09:17:15 so1905-ff03 volumio[2334]: { stdout: '', Dec 31 09:17:15 so1905-ff03 volumio[2334]: stderr: Dec 31 09:17:15 so1905-ff03 volumio[2334]: 'Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files\n' } Dec 31 09:17:15 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:15 so1905-ff03 volumio[2334]: [spop] Spotify config file written Dec 31 09:17:15 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:17:15 so1905-ff03 sudo[2800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart go-librespot-daemon.service Dec 31 09:17:15 so1905-ff03 kernel: sunxi-spdif 2036000.spdif: active: 1 Dec 31 09:17:15 so1905-ff03 sudo[2800]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 31 09:17:15 so1905-ff03 systemd[1]: Stopping go-librespot Daemon... Dec 31 09:17:15 so1905-ff03 systemd[1]: go-librespot-daemon.service: Succeeded. Dec 31 09:17:15 so1905-ff03 systemd[1]: Stopped go-librespot Daemon. Dec 31 09:17:15 so1905-ff03 systemd[1]: Started go-librespot Daemon. Dec 31 09:17:15 so1905-ff03 sudo[2800]: pam_unix(sudo:session): session closed for user root Dec 31 09:17:15 so1905-ff03 go-librespot[2810]: go-librespot daemon starting... Dec 31 09:17:15 so1905-ff03 volumio[2772]: Forking 1 albumart workers Dec 31 09:17:15 so1905-ff03 go-librespot[2821]: time="2025-12-31T09:17:15+08:00" level=info msg="running go-librespot 0.0.0" Dec 31 09:17:15 so1905-ff03 go-librespot[2821]: time="2025-12-31T09:17:15+08:00" level=debug msg="app state loaded" Dec 31 09:17:15 so1905-ff03 go-librespot[2821]: time="2025-12-31T09:17:15+08:00" level=debug msg="stored credentials not found" Dec 31 09:17:15 so1905-ff03 go-librespot[2821]: time="2025-12-31T09:17:15+08:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 31 09:17:16 so1905-ff03 go-librespot[2821]: time="2025-12-31T09:17:16+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-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 31 09:17:16 so1905-ff03 go-librespot[2821]: time="2025-12-31T09:17:16+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 31 09:17:16 so1905-ff03 go-librespot[2821]: time="2025-12-31T09:17:16+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 31 09:17:16 so1905-ff03 go-librespot[2821]: time="2025-12-31T09:17:16+08:00" level=info msg="zeroconf server listening on port 34423" Dec 31 09:17:16 so1905-ff03 go-librespot[2821]: 2025/12/31 09:17:16 [zeroconf] no suitable IPv6 interface: listen udp6 [ff02::]:5353: socket: address family not supported by protocol Dec 31 09:17:17 so1905-ff03 volumio[2334]: Playing WAVE '/volumio/app/wifi_connected.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 31 09:17:17 so1905-ff03 volumio[2334]: info: CoreCommandRouter::Close All Modals sent Dec 31 09:17:17 so1905-ff03 volumio[2334]: [rest_api] API:emitFavourites Dec 31 09:17:17 so1905-ff03 volumio[2814]: Starting albumart workers Dec 31 09:17:18 so1905-ff03 volumio[2334]: sendCommand: Command { name: 'playlistinfo', args: [] } Dec 31 09:17:18 so1905-ff03 volumio[2334]: [mpd] MPD error: false == true Dec 31 09:17:18 so1905-ff03 volumio[2334]: [mpd] false == true Dec 31 09:17:18 so1905-ff03 volumio[2334]: sendCommand: Command { name: 'search album ""', args: [] } Dec 31 09:17:18 so1905-ff03 volumio[2334]: [mpd] MPD error: false == true Dec 31 09:17:18 so1905-ff03 volumio[2334]: [mpd] false == true Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 31 09:17:18 so1905-ff03 volumio[2334]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 31 09:17:18 so1905-ff03 volumio[2334]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 31 09:17:18 so1905-ff03 volumio[2334]: [rest_api] API:printToastMessage Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:17:18 so1905-ff03 volumio[2334]: [spop] No need to fix Spotify hosts Dec 31 09:17:18 so1905-ff03 volumio[2334]: sendCommand: Command { name: 'playlistinfo', args: [] } Dec 31 09:17:18 so1905-ff03 volumio[2334]: sendCommand: Command { name: 'lsinfo "USB"', args: [] } Dec 31 09:17:18 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 31 09:17:19 so1905-ff03 volumio[2334]: [websocket] [pushCmd] {"index":5,"getInfo":0} Dec 31 09:17:19 so1905-ff03 volumio[2334]: info: CoreStateMachine::setRepeat false single undefined Dec 31 09:17:19 so1905-ff03 volumio[2334]: info: CoreStateMachine::pushState Dec 31 09:17:19 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 09:17:19 so1905-ff03 volumio[2334]: [rest_api] API:pushState Dec 31 09:17:19 so1905-ff03 volumio[2334]: info: CoreStateMachine::setRandom false Dec 31 09:17:19 so1905-ff03 volumio[2334]: info: CoreStateMachine::pushState Dec 31 09:17:19 so1905-ff03 volumio[2334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 09:17:19 so1905-ff03 volumio[2334]: [rest_api] API:pushState Dec 31 09:17:19 so1905-ff03 volumio[2334]: [mpd] updateQueue error: null Dec 31 09:17:19 so1905-ff03 volumio[2334]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 31 09:17:19 so1905-ff03 volumio[2334]: { Error: ENOENT: no such file or directory, stat '/mnt/USB/848E-C1AC' Dec 31 09:17:19 so1905-ff03 volumio[2334]: at Object.statSync (fs.js:855:3) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at eval (webpack://Volumio2/./app/plugins/music_service/mpd/index.js?:1586:23) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at MpdClient.handleMessage (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:77:3) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at MpdClient.receive (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:68:12) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at Socket.eval (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:43:12) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at Socket.emit (events.js:198:13) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at addChunk (_stream_readable.js:288:12) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at readableAddChunk (_stream_readable.js:265:13) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at Socket.Readable.push (_stream_readable.js:224:10) Dec 31 09:17:19 so1905-ff03 volumio[2334]: at Pipe.onStreamRead [as onread] (internal/stream_base_commons.js:94:17) Dec 31 09:17:19 so1905-ff03 volumio[2334]: errno: -2, Dec 31 09:17:19 so1905-ff03 volumio[2334]: syscall: 'stat', Dec 31 09:17:19 so1905-ff03 volumio[2334]: code: 'ENOENT', Dec 31 09:17:19 so1905-ff03 volumio[2334]: path: '/mnt/USB/848E-C1AC' } Dec 31 09:17:19 so1905-ff03 volumio[2334]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 31 09:17:20 so1905-ff03 sudo[2868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-31 09:16 Dec 31 09:17:20 so1905-ff03 sudo[2868]: 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