-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Tue 2026-01-13 10:39:14 CST. -- Jan 13 10:38:51 so1905-bfc4 systemd-timesyncd[2153]: Initial synchronization to time server 91.189.91.157:123 (ntp.ubuntu.com). Jan 13 10:38:51 so1905-bfc4 sudo[2665]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 10:38:51 so1905-bfc4 systemd[1]: Started Samba NMB Daemon. Jan 13 10:38:51 so1905-bfc4 udhcpc[2671]: wlan0: configuration failed: nak: address in use Jan 13 10:38:51 so1905-bfc4 sudo[2665]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:38:51 so1905-bfc4 sudo[2665]: pam_unix(sudo:session): session closed for user root Jan 13 10:38:51 so1905-bfc4 systemd[1]: Starting Daily apt download activities... Jan 13 10:38:51 so1905-bfc4 display[2181]: stb_image successfully loaded: 855x855, channels=3 Jan 13 10:38:51 so1905-bfc4 systemd[1]: Starting Online ext4 Metadata Check for All Filesystems... Jan 13 10:38:51 so1905-bfc4 node[2205]: ... joined AP, wlan0 IPv4 is 192.168.2.115, ipV6 is undefined Jan 13 10:38:51 so1905-bfc4 node[2205]: It's done! AP Jan 13 10:38:51 so1905-bfc4 systemd[1]: Starting Discard unused blocks on filesystems from /etc/fstab... Jan 13 10:38:51 so1905-bfc4 systemd[1]: Starting Message of the Day... Jan 13 10:38:51 so1905-bfc4 display[2181]: Successfully processed with stb_image Jan 13 10:38:51 so1905-bfc4 display[2181]: Default image loaded successfully Jan 13 10:38:51 so1905-bfc4 systemd[1]: Starting Samba SMB Daemon... Jan 13 10:38:51 so1905-bfc4 display[2181]: setImageSrc: this=0x32da790, str=/volumio/display/assets/status-icon/wifi-error.png Jan 13 10:38:51 so1905-bfc4 systemd[1]: Starting Hostname Service... Jan 13 10:38:51 so1905-bfc4 display[2181]: read file /volumio/display/assets/status-icon/wifi-error.png, size=1494, buffer[0]=89 Jan 13 10:38:51 so1905-bfc4 display[2181]: setImageSrc: this=0x32dcae0, str=/volumio/display/assets/status-icon/eth-error.png Jan 13 10:38:51 so1905-bfc4 display[2181]: read file /volumio/display/assets/status-icon/eth-error.png, size=936, buffer[0]=89 Jan 13 10:38:51 so1905-bfc4 systemd[1]: Starting Rotate log files... Jan 13 10:38:51 so1905-bfc4 systemd[1]: e2scrub_all.service: Succeeded. Jan 13 10:38:51 so1905-bfc4 systemd[1]: Finished Online ext4 Metadata Check for All Filesystems. Jan 13 10:38:51 so1905-bfc4 display[2181]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Jan 13 10:38:51 so1905-bfc4 display[2181]: 文件大小: 6344 字节 Jan 13 10:38:51 so1905-bfc4 systemd[1]: motd-news.service: Succeeded. Jan 13 10:38:51 so1905-bfc4 display[2181]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 40px) Jan 13 10:38:51 so1905-bfc4 display[2181]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf Jan 13 10:38:51 so1905-bfc4 display[2181]: 文件大小: 11495876 字节 Jan 13 10:38:51 so1905-bfc4 systemd[1]: Finished Message of the Day. Jan 13 10:38:52 so1905-bfc4 display[2181]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf (大小: 40px) Jan 13 10:38:52 so1905-bfc4 display[2181]: setInnerAlign: image_desc is null Jan 13 10:38:52 so1905-bfc4 systemd[1]: Started go-librespot Daemon. Jan 13 10:38:52 so1905-bfc4 go-librespot[2703]: go-librespot daemon starting... Jan 13 10:38:52 so1905-bfc4 volumio[2343]: info: Loading plugin "airplay_emulation"... Jan 13 10:38:52 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/airplay_emulation/index.js Jan 13 10:38:52 so1905-bfc4 display[2181]: setImageSrc: this=0x33d53d8, str=/volumio/display/assets/source-icon/streaming.png Jan 13 10:38:52 so1905-bfc4 display[2181]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Jan 13 10:38:52 so1905-bfc4 dbus-daemon[2169]: [system] Successfully activated service 'org.freedesktop.hostname1' Jan 13 10:38:52 so1905-bfc4 volumio[2343]: 执行命令出错: 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 Jan 13 10:38:52 so1905-bfc4 systemd[1]: Started Hostname Service. Jan 13 10:38:52 so1905-bfc4 display[2181]: setImageSrc: this=0x33ebf48, str=/volumio/display/assets/source-icon/streaming.png Jan 13 10:38:52 so1905-bfc4 display[2181]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Jan 13 10:38:52 so1905-bfc4 volumio[2343]: [airplay_emulation] Starting Shairport Sync Jan 13 10:38:52 so1905-bfc4 volumio[2343]: [airplay_emulation] [AirPlay] Started coverart directory watcher Jan 13 10:38:52 so1905-bfc4 volumio[2343]: info: Loading plugin "last_100"... Jan 13 10:38:52 so1905-bfc4 display[2181]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Jan 13 10:38:52 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/last_100/index.js Jan 13 10:38:52 so1905-bfc4 volumio[2343]: info: Loading plugin "spop"... Jan 13 10:38:52 so1905-bfc4 display[2181]: 文件大小: 6344 字节 Jan 13 10:38:52 so1905-bfc4 display[2181]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 100px) Jan 13 10:38:52 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/spop/index.js Jan 13 10:38:53 so1905-bfc4 display[2181]: setImageSrc: this=0x33ec7f0, str=/volumio/display/assets/source-icon/streaming.png Jan 13 10:38:53 so1905-bfc4 display[2181]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Jan 13 10:38:53 so1905-bfc4 smbd[2699]: [2026/01/13 10:38:53.274784, 0] ../../source3/smbd/server.c:1734(main) Jan 13 10:38:53 so1905-bfc4 smbd[2699]: smbd version 4.15.13-Ubuntu started. Jan 13 10:38:53 so1905-bfc4 smbd[2699]: Copyright Andrew Tridgell and the Samba Team 1992-2021 Jan 13 10:38:53 so1905-bfc4 volumio[2343]: info: Loading plugin "webradio"... Jan 13 10:38:53 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/webradio/index.js Jan 13 10:38:54 so1905-bfc4 go-librespot[2709]: time="2026-01-13T10:38:54+08:00" level=info msg="running go-librespot 0.0.0" Jan 13 10:38:54 so1905-bfc4 go-librespot[2709]: time="2026-01-13T10:38:54+08:00" level=debug msg="app state loaded" Jan 13 10:38:54 so1905-bfc4 go-librespot[2709]: time="2026-01-13T10:38:54+08:00" level=debug msg="stored credentials not found" Jan 13 10:38:54 so1905-bfc4 go-librespot[2709]: time="2026-01-13T10:38:54+08:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 13 10:38:54 so1905-bfc4 fstrim[2680]: /: 2 GiB (2127990784 bytes) trimmed on /dev/mmcblk0p5 Jan 13 10:38:54 so1905-bfc4 fstrim[2680]: /mnt/UDISK: 2.7 GiB (2931605504 bytes) trimmed on /dev/mmcblk0p9 Jan 13 10:38:54 so1905-bfc4 systemd[1]: fstrim.service: Succeeded. Jan 13 10:38:54 so1905-bfc4 systemd[1]: Finished Discard unused blocks on filesystems from /etc/fstab. Jan 13 10:38:54 so1905-bfc4 systemd[1]: Started Samba SMB Daemon. Jan 13 10:38:55 so1905-bfc4 mpd[2648]: Jan 13 10:38 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 13 10:38:55 so1905-bfc4 mpd[2648]: Jan 13 10:38 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jan 13 10:38:55 so1905-bfc4 mpd[2648]: Jan 13 10:38 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jan 13 10:38:55 so1905-bfc4 systemd[1]: Started Music Player Daemon. Jan 13 10:38:55 so1905-bfc4 sudo[2620]: pam_unix(sudo:session): session closed for user root Jan 13 10:38:55 so1905-bfc4 systemd[1]: Reached target Multi-User System. Jan 13 10:38:55 so1905-bfc4 systemd[1]: Reached target Graphical Interface. Jan 13 10:38:55 so1905-bfc4 systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 13 10:38:55 so1905-bfc4 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 13 10:38:55 so1905-bfc4 systemd[1]: Finished Update UTMP about System Runlevel Changes. Jan 13 10:38:55 so1905-bfc4 go-librespot[2709]: time="2026-01-13T10:38:55+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-gew4.spotify.com:80]" Jan 13 10:38:55 so1905-bfc4 go-librespot[2709]: time="2026-01-13T10:38:55+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jan 13 10:38:55 so1905-bfc4 go-librespot[2709]: time="2026-01-13T10:38:55+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jan 13 10:38:56 so1905-bfc4 go-librespot[2709]: time="2026-01-13T10:38:56+08:00" level=info msg="zeroconf server listening on port 36109" Jan 13 10:38:56 so1905-bfc4 go-librespot[2709]: 2026/01/13 10:38:56 [zeroconf] no suitable IPv6 interface: listen udp6 [ff02::]:5353: socket: address family not supported by protocol Jan 13 10:38:56 so1905-bfc4 smbd[2699]: [2026/01/13 10:38:56.172567, 0] ../../source3/smbd/server.c:1082(smbd_open_one_socket) Jan 13 10:38:56 so1905-bfc4 smbd[2699]: smbd_open_one_socket: open_socket_in failed: Address family not supported by protocol Jan 13 10:38:56 so1905-bfc4 smbd[2699]: [2026/01/13 10:38:56.198375, 0] ../../source3/smbd/server.c:1082(smbd_open_one_socket) Jan 13 10:38:56 so1905-bfc4 smbd[2699]: smbd_open_one_socket: open_socket_in failed: Address family not supported by protocol Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: [2026/01/13 10:38:57.030532, 0] ../../source3/nmbd/nmbd_workgroupdb.c:279(dump_workgroups) Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: dump_workgroups() Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: dump workgroup on subnet 192.168.2.115: netmask= 255.255.255.0: Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: WORKGROUP(1) current master browser = UNKNOWN Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: VOLUMIO 40809a03 (Volumio Audiophile Music Player) Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: [2026/01/13 10:38:57.031328, 0] ../../source3/nmbd/nmbd_workgroupdb.c:279(dump_workgroups) Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: dump_workgroups() Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: dump workgroup on subnet UNICAST_SUBNET: netmask= 192.168.2.115: Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: WORKGROUP(1) current master browser = UNKNOWN Jan 13 10:38:57 so1905-bfc4 nmbd[2259]: VOLUMIO 40809a03 (Volumio Audiophile Music Player) Jan 13 10:38:57 so1905-bfc4 systemd[1]: logrotate.service: Succeeded. Jan 13 10:38:57 so1905-bfc4 systemd[1]: Finished Rotate log files. Jan 13 10:38:57 so1905-bfc4 kernel: usb0-vbus: disabling Jan 13 10:38:57 so1905-bfc4 volumio[2343]: info: Loading plugin "yandex_browser"... Jan 13 10:38:57 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/yandex_browser/index.js Jan 13 10:38:58 so1905-bfc4 avahi-daemon[2164]: Withdrawing address record for 192.168.2.115 on wlan0. Jan 13 10:38:58 so1905-bfc4 avahi-daemon[2164]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.2.115. Jan 13 10:38:58 so1905-bfc4 systemd-timesyncd[2153]: No network connectivity, watching for changes. Jan 13 10:38:58 so1905-bfc4 systemd-timesyncd[2153]: Network configuration changed, trying to establish connection. Jan 13 10:38:58 so1905-bfc4 avahi-daemon[2164]: Interface wlan0.IPv4 no longer relevant for mDNS. Jan 13 10:38:58 so1905-bfc4 avahi-daemon[2164]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.2.118. Jan 13 10:38:58 so1905-bfc4 avahi-daemon[2164]: New relevant interface wlan0.IPv4 for mDNS. Jan 13 10:38:58 so1905-bfc4 avahi-daemon[2164]: Registering new address record for 192.168.2.118 on wlan0.IPv4. Jan 13 10:38:58 so1905-bfc4 udhcpc[2747]: wlan0: bound: IP=192.168.2.118/255.255.255.0 router=192.168.2.1 domain="lan" dns="192.168.2.1" lease=43200 Jan 13 10:38:58 so1905-bfc4 sudo[2435]: pam_unix(sudo:session): session closed for user root Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [yandex_browser] Yandex plugin started Jan 13 10:38:58 so1905-bfc4 volumio[2343]: error: ATTENTION!!!: Plugin yandex_browser does not return adequate promise from onVolumioStart: please update! Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: Loading plugin "i2s_dacs"... Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/system_controller/i2s_dacs/index.js Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [i2s_dacs] I2S DAC not set, start Auto-detection Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: Loading plugin "volumiodiscovery"... Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/system_controller/volumiodiscovery/index.js Jan 13 10:38:58 so1905-bfc4 volumio[2343]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 13 10:38:58 so1905-bfc4 volumio[2343]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 13 10:38:58 so1905-bfc4 node[2343]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 13 10:38:58 so1905-bfc4 volumio[2343]: *** WARNING *** For more information see Jan 13 10:38:58 so1905-bfc4 volumio[2343]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 13 10:38:58 so1905-bfc4 volumio[2343]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 13 10:38:58 so1905-bfc4 volumio[2343]: *** WARNING *** For more information see Jan 13 10:38:58 so1905-bfc4 node[2343]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 13 10:38:58 so1905-bfc4 node[2343]: *** WARNING *** For more information see Jan 13 10:38:58 so1905-bfc4 node[2343]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 13 10:38:58 so1905-bfc4 node[2343]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 13 10:38:58 so1905-bfc4 node[2343]: *** WARNING *** For more information see Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [volumiodiscovery] Discovery: Started advertising with name: SO1905-bfc4 Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: Loading plugin "outputs"... Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/audio_interface/outputs/index.js Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: Loading plugin "albumart"... Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/miscellanea/albumart/index.js Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: Plugin example_plugin is not enabled Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: Loading plugin "inputs"... Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/inputs/index.js Jan 13 10:38:58 so1905-bfc4 volumio[2343]: info: Loading plugin "pandora"... Jan 13 10:38:58 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/pandora/index.js Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Applying required configuration parameters for plugin pandora Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Loading plugin "podcast"... Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/podcast/index.js Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [podcast] ControllerPodcast::constructor Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Loading plugin "qobuz"... Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/qobuz/index.js Jan 13 10:38:59 so1905-bfc4 volumio[2343]: error: ATTENTION!!!: Plugin qobuz does not return adequate promise from onVolumioStart: please update! Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Loading plugin "tidal"... Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/music_service/tidal/index.js Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [tidal] [1768271939606] ControllerTidalPlugin::constructor Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: [1768271939608] ControllerTidalPlugin::onVolumioStart Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Plugin volspotconnect2 is not enabled Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Loading plugin "updater_comm"... Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/system_controller/updater_comm/index.js Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Plugin mpdemulation is not enabled Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Loading plugin "rest_api"... Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/user_interface/rest_api/index.js Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: Loading plugin "websocket"... Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [ require ] /volumio/app/plugins/user_interface/websocket/index.js Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: ___________ START PLUGINS ___________ Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: [1768271939935] CoreMusicLibrary::Adding element Media Servers Jan 13 10:38:59 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:38:59 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:38:59 so1905-bfc4 volumio[2343]: SSDP Client initialized. Jan 13 10:38:59 so1905-bfc4 volumio[2343]: Starting initial SSDP search... Jan 13 10:38:59 so1905-bfc4 volumio[2343]: Discovering on interface: lo Jan 13 10:38:59 so1905-bfc4 volumio[2343]: Discovering on interface: wlan0 Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [airplay_emulation] Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940098] CoreMusicLibrary::Adding element Last_100 Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [spop] Creating Spotify config file Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940137] CoreMusicLibrary::Adding element Webradio Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [yandex_browser] Yandex plugin started Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940160] ControllerYandexPlugin::addToBrowseSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940162] CoreMusicLibrary::Adding element Yandex Music Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:printToastMessage Jan 13 10:39:00 so1905-bfc4 volumio[2343]: error: Plugin yandex_browser does not return adequate promise from onStart: please update! Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940180] CoreMusicLibrary::Adding element Pandora Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [pandora] [1768271940187] ControllerPandora::initializeMQTT Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [pandora] [1768271940189] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940206] CoreMusicLibrary::Adding element Podcast Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940214] CoreMusicLibrary::Adding element Qobuz Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940228] ControllerTidalPlugin::onStart Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940236] ControllerTidalPlugin::addToBrowseSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: [1768271940238] CoreMusicLibrary::Adding element Tidal Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: Loading i18n strings for locale en Jan 13 10:39:00 so1905-bfc4 volumio[2343]: Updating browse sources language Jan 13 10:39:00 so1905-bfc4 volumio[2343]: Cannot find translation for sourceMedia Servers Jan 13 10:39:00 so1905-bfc4 volumio[2343]: Cannot find translation for sourceYandex Music Jan 13 10:39:00 so1905-bfc4 volumio[2343]: Cannot find translation for sourcePodcast Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::initPlayerControls Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: BOOT COMPLETED Jan 13 10:39:00 so1905-bfc4 volumio[2343]: [Metrics] CommandRouter: 15s 41.63ms Jan 13 10:39:00 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 10:39:00 so1905-bfc4 kernel: sunxi-spdif 2036000.spdif: active: 1 Jan 13 10:39:05 so1905-bfc4 volumio[2343]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 13 10:39:05 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::Close All Modals sent Jan 13 10:39:05 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:05 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::Close All Modals sent Jan 13 10:39:05 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:05 so1905-bfc4 volumio[2343]: Express server listening on port 3000 Jan 13 10:39:05 so1905-bfc4 volumio[2343]: [Metrics] WebUI: 21s 351.61ms Jan 13 10:39:05 so1905-bfc4 volumio[2343]: (node:2343) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jan 13 10:39:06 so1905-bfc4 volumio[2343]: [pandora] [1768271946025] ControllerPandora::validateAndSetAccountOptions Jan 13 10:39:06 so1905-bfc4 volumio[2343]: [pandora] [1768271946028] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Jan 13 10:39:06 so1905-bfc4 volumio[2343]: info: CoreStateMachine::resetVolumioState Jan 13 10:39:06 so1905-bfc4 volumio[2343]: info: CoreStateMachine::getcurrentVolume Jan 13 10:39:06 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioRetrievevolume Jan 13 10:39:06 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 10:39:06 so1905-bfc4 sudo[2781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 10:39:06 so1905-bfc4 sudo[2779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 13 10:39:06 so1905-bfc4 sudo[2781]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:06 so1905-bfc4 volumio[2343]: [i2s_dacs] Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 13 10:39:06 so1905-bfc4 sudo[2779]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:06 so1905-bfc4 sudo[2781]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:06 so1905-bfc4 sudo[2779]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:06 so1905-bfc4 volumio[2343]: [networkfs] wlan0 IPv4 address event: 5: wlan0 inet 192.168.2.115/24 brd 192.168.2.255 scope global dynamic wlan0\ valid_lft 43200sec preferred_lft 43200sec Jan 13 10:39:06 so1905-bfc4 volumio[2343]: [networkfs] wlan0 address deleted: Deleted 5: wlan0 inet 192.168.2.115/24 brd 192.168.2.255 scope global dynamic wlan0\ valid_lft 43193sec preferred_lft 43193sec Jan 13 10:39:06 so1905-bfc4 volumio[2343]: [networkfs] wlan0 IPv4 address event: 5: wlan0 inet 192.168.2.118/24 brd 192.168.2.255 scope global wlan0\ valid_lft forever preferred_lft forever Jan 13 10:39:06 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jan 13 10:39:06 so1905-bfc4 sudo[2813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 13 10:39:06 so1905-bfc4 sudo[2807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 13 10:39:06 so1905-bfc4 sudo[2813]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:06 so1905-bfc4 sudo[2807]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:06 so1905-bfc4 sudo[2813]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:06 so1905-bfc4 sudo[2807]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:06 so1905-bfc4 sudo[2823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 13 10:39:06 so1905-bfc4 volumio[2343]: [networkfs] Connecting to wireless device: undefined Jan 13 10:39:07 so1905-bfc4 sudo[2843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 10:39:07 so1905-bfc4 sudo[2831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 13 10:39:07 so1905-bfc4 sudo[2843]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:07 so1905-bfc4 sudo[2823]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:07 so1905-bfc4 sudo[2843]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:07 so1905-bfc4 sudo[2831]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:07 so1905-bfc4 sudo[2831]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:07 so1905-bfc4 sudo[2823]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:07 so1905-bfc4 volumio[2343]: [networkfs] IP address changed from "" to "192.168.2.118" Jan 13 10:39:07 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jan 13 10:39:07 so1905-bfc4 sudo[2880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 13 10:39:07 so1905-bfc4 sudo[2872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 13 10:39:07 so1905-bfc4 sudo[2872]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:07 so1905-bfc4 volumio[2343]: [networkfs] Connecting to wireless device: undefined Jan 13 10:39:07 so1905-bfc4 volumio[2343]: info: this.stateMachine.currentVolume: null, vol: 0 Jan 13 10:39:07 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:07 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:07 so1905-bfc4 volumio[2343]: [airplay_emulation] [AirPlay] Received volume update: {"vol":0,"mute":false,"disableVolumeControl":false} Jan 13 10:39:07 so1905-bfc4 sudo[2880]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:07 so1905-bfc4 volumio[2343]: [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 Jan 13 10:39:07 so1905-bfc4 sudo[2880]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:07 so1905-bfc4 sudo[2872]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:07 so1905-bfc4 sudo[2885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 13 10:39:07 so1905-bfc4 sudo[2899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 10:39:07 so1905-bfc4 sudo[2885]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:07 so1905-bfc4 volumio[2343]: info: CoreStateMachine::pushState Jan 13 10:39:07 so1905-bfc4 sudo[2895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 13 10:39:07 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 10:39:07 so1905-bfc4 sudo[2895]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:07 so1905-bfc4 sudo[2899]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:07 so1905-bfc4 sudo[2885]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:07 so1905-bfc4 volumio[2343]: [rest_api] API:pushState Jan 13 10:39:07 so1905-bfc4 sudo[2895]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:07 so1905-bfc4 sudo[2899]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:08 so1905-bfc4 volumio[2343]: info: CoreStateMachine::updateTrackBlock Jan 13 10:39:08 so1905-bfc4 volumio[2343]: info: CorePlayQueue::getTrackBlock Jan 13 10:39:08 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::volumioRetrievevolume Jan 13 10:39:08 so1905-bfc4 volumio[2343]: [mpd] MPD Permissions set Jan 13 10:39:08 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 13 10:39:08 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 10:39:08 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 13 10:39:09 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 13 10:39:09 so1905-bfc4 volumio[2944]: Forking 1 albumart workers Jan 13 10:39:09 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: network , pushNetworkConfiguredStatus Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [network] pushNetworkConfiguredResult { status: 'success', message: 'ok', ssid: 'VeriderTech' } Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [network] Push network configured result Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [network] pushNetworkConfiguredResult callbackIp: networkSsid: VeriderTech Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [mpd] MPD running with PID2648 Jan 13 10:39:09 so1905-bfc4 volumio[2343]: ,establishing connection Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [i2s_dacs] Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jan 13 10:39:09 so1905-bfc4 volumio[2343]: sudo: /usr/sbin/i2cdetect: command not found Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [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 Jan 13 10:39:09 so1905-bfc4 volumio[2343]: Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files Jan 13 10:39:09 so1905-bfc4 volumio[2343]: { stdout: '', Jan 13 10:39:09 so1905-bfc4 volumio[2343]: stderr: Jan 13 10:39:09 so1905-bfc4 volumio[2343]: 'Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files\n' } Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:09 so1905-bfc4 volumio[2343]: [spop] Spotify config file written Jan 13 10:39:09 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 10:39:09 so1905-bfc4 sudo[2973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart go-librespot-daemon.service Jan 13 10:39:09 so1905-bfc4 sudo[2973]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 10:39:09 so1905-bfc4 systemd[1]: Stopping go-librespot Daemon... Jan 13 10:39:09 so1905-bfc4 kernel: sunxi-spdif 2036000.spdif: active: 1 Jan 13 10:39:09 so1905-bfc4 systemd[1]: go-librespot-daemon.service: Succeeded. Jan 13 10:39:09 so1905-bfc4 systemd[1]: Stopped go-librespot Daemon. Jan 13 10:39:09 so1905-bfc4 systemd[1]: Started go-librespot Daemon. Jan 13 10:39:09 so1905-bfc4 sudo[2973]: pam_unix(sudo:session): session closed for user root Jan 13 10:39:09 so1905-bfc4 go-librespot[2981]: go-librespot daemon starting... Jan 13 10:39:10 so1905-bfc4 go-librespot[2986]: time="2026-01-13T10:39:10+08:00" level=info msg="running go-librespot 0.0.0" Jan 13 10:39:10 so1905-bfc4 go-librespot[2986]: time="2026-01-13T10:39:10+08:00" level=debug msg="app state loaded" Jan 13 10:39:10 so1905-bfc4 go-librespot[2986]: time="2026-01-13T10:39:10+08:00" level=debug msg="stored credentials not found" Jan 13 10:39:10 so1905-bfc4 go-librespot[2986]: time="2026-01-13T10:39:10+08:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 13 10:39:11 so1905-bfc4 go-librespot[2986]: time="2026-01-13T10:39:11+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]" Jan 13 10:39:11 so1905-bfc4 go-librespot[2986]: time="2026-01-13T10:39:11+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]" Jan 13 10:39:11 so1905-bfc4 go-librespot[2986]: time="2026-01-13T10:39:11+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]" Jan 13 10:39:11 so1905-bfc4 go-librespot[2986]: time="2026-01-13T10:39:11+08:00" level=info msg="zeroconf server listening on port 37445" Jan 13 10:39:11 so1905-bfc4 go-librespot[2986]: 2026/01/13 10:39:11 [zeroconf] no suitable IPv6 interface: listen udp6 [ff02::]:5353: socket: address family not supported by protocol Jan 13 10:39:11 so1905-bfc4 volumio[2961]: Starting albumart workers Jan 13 10:39:11 so1905-bfc4 volumio[2343]: Playing WAVE '/volumio/app/wifi_connected.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 13 10:39:11 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::Close All Modals sent Jan 13 10:39:11 so1905-bfc4 volumio[2343]: [rest_api] API:emitFavourites Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 13 10:39:12 so1905-bfc4 volumio[2343]: sendCommand: Command { name: 'playlistinfo', args: [] } Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [mpd] MPD error: false == true Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [mpd] false == true Jan 13 10:39:12 so1905-bfc4 volumio[2343]: sendCommand: Command { name: 'search album ""', args: [] } Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [mpd] MPD error: false == true Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [mpd] false == true Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [rest_api] API:printToastMessage Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [spop] No need to fix Spotify hosts Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 10:39:12 so1905-bfc4 volumio[2343]: sendCommand: Command { name: 'playlistinfo', args: [] } Jan 13 10:39:12 so1905-bfc4 volumio[2343]: sendCommand: Command { name: 'lsinfo "USB"', args: [] } Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: network , emitWirelessEvent Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [network] emitWirelessEvent ap Jan 13 10:39:12 so1905-bfc4 volumio[2343]: [network] onceEventMap not found ap Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 10:39:12 so1905-bfc4 systemd[1]: Started Wireless Services. Jan 13 10:39:12 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 13 10:39:13 so1905-bfc4 systemd-timesyncd[2153]: Network configuration changed, trying to establish connection. Jan 13 10:39:13 so1905-bfc4 systemd-timesyncd[2153]: Initial synchronization to time server 91.189.91.157:123 (ntp.ubuntu.com). Jan 13 10:39:13 so1905-bfc4 volumio[2343]: info: CoreStateMachine::setRepeat null single undefined Jan 13 10:39:13 so1905-bfc4 volumio[2343]: info: CoreStateMachine::pushState Jan 13 10:39:13 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 10:39:13 so1905-bfc4 volumio[2343]: [rest_api] API:pushState Jan 13 10:39:13 so1905-bfc4 volumio[2343]: info: CoreStateMachine::setRandom null Jan 13 10:39:13 so1905-bfc4 volumio[2343]: info: CoreStateMachine::pushState Jan 13 10:39:13 so1905-bfc4 volumio[2343]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 10:39:13 so1905-bfc4 volumio[2343]: [rest_api] API:pushState Jan 13 10:39:13 so1905-bfc4 volumio[2343]: [mpd] updateQueue error: null Jan 13 10:39:13 so1905-bfc4 volumio[2343]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 10:39:13 so1905-bfc4 volumio[2343]: { Error: ENOENT: no such file or directory, stat '/mnt/USB/udisk' Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at Object.statSync (fs.js:855:3) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at eval (webpack://Volumio2/./app/plugins/music_service/mpd/index.js?:1586:23) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at MpdClient.handleMessage (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:77:3) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at MpdClient.receive (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:68:12) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at Socket.eval (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:43:12) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at Socket.emit (events.js:198:13) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at addChunk (_stream_readable.js:288:12) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at readableAddChunk (_stream_readable.js:265:13) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at Socket.Readable.push (_stream_readable.js:224:10) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: at Pipe.onStreamRead [as onread] (internal/stream_base_commons.js:94:17) Jan 13 10:39:13 so1905-bfc4 volumio[2343]: errno: -2, Jan 13 10:39:13 so1905-bfc4 volumio[2343]: syscall: 'stat', Jan 13 10:39:13 so1905-bfc4 volumio[2343]: code: 'ENOENT', Jan 13 10:39:13 so1905-bfc4 volumio[2343]: path: '/mnt/USB/udisk' } Jan 13 10:39:13 so1905-bfc4 volumio[2343]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 10:39:14 so1905-bfc4 sudo[3032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-13 10:38 Jan 13 10:39:14 so1905-bfc4 sudo[3032]: 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