-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Tue 2025-12-23 09:03:43 CST. -- Dec 23 09:03:18 so1905-b6d5 systemd-timesyncd[2160]: Initial synchronization to time server 185.125.190.58:123 (ntp.ubuntu.com). Dec 23 09:03:18 so1905-b6d5 udhcpc[2592]: wlan0: bound: IP=192.168.23.129/255.255.255.0 router=192.168.23.1 domain="" dns="211.136.192.6 120.196.165.24" lease=7200 Dec 23 09:03:18 so1905-b6d5 sudo[2582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 23 09:03:18 so1905-b6d5 node[2207]: trying... Dec 23 09:03:18 so1905-b6d5 sudo[2400]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:18 so1905-b6d5 sudo[2580]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:18 so1905-b6d5 systemd[1]: Starting Daily apt upgrade and clean activities... Dec 23 09:03:18 so1905-b6d5 sudo[2582]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:18 so1905-b6d5 systemd[1]: Starting Message of the Day... Dec 23 09:03:18 so1905-b6d5 systemd[1]: Starting Rotate log files... Dec 23 09:03:18 so1905-b6d5 systemd[1]: motd-news.service: Succeeded. Dec 23 09:03:18 so1905-b6d5 sudo[2601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r wlan0 Dec 23 09:03:18 so1905-b6d5 systemd[1]: Finished Message of the Day. Dec 23 09:03:18 so1905-b6d5 display[2188]: setImageSrc: this=0x2c29c30, str=/volumio/display/assets/source-icon/bt.png Dec 23 09:03:18 so1905-b6d5 display[2188]: read file /volumio/display/assets/source-icon/bt.png, size=11779, buffer[0]=89 Dec 23 09:03:19 so1905-b6d5 sudo[2601]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:19 so1905-b6d5 systemd[1]: Starting Music Player Daemon... Dec 23 09:03:19 so1905-b6d5 sudo[2601]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:19 so1905-b6d5 node[2207]: Connected to: ----FORTEX Dec 23 09:03:19 so1905-b6d5 node[2207]: ---- Dec 23 09:03:19 so1905-b6d5 display[2188]: setImageSrc: this=0x2b30860, str=/volumio/display/assets/albumart.jpg Dec 23 09:03:19 so1905-b6d5 display[2188]: read file /volumio/display/assets/albumart.jpg, size=77672, buffer[0]=ff Dec 23 09:03:19 so1905-b6d5 display[2188]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF Dec 23 09:03:19 so1905-b6d5 display[2188]: Attempting to process with stb_image... Dec 23 09:03:19 so1905-b6d5 sudo[2625]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 09:03:19 so1905-b6d5 node[2207]: trying... Dec 23 09:03:19 so1905-b6d5 smbd[2578]: [2025/12/23 09:03:19.714758, 0] ../../source3/smbd/server.c:1734(main) Dec 23 09:03:19 so1905-b6d5 smbd[2578]: smbd version 4.15.13-Ubuntu started. Dec 23 09:03:19 so1905-b6d5 smbd[2578]: Copyright Andrew Tridgell and the Samba Team 1992-2021 Dec 23 09:03:19 so1905-b6d5 sudo[2625]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:19 so1905-b6d5 sudo[2625]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:19 so1905-b6d5 mpd[2616]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.29' not found (required by /usr/bin/mpd) Dec 23 09:03:19 so1905-b6d5 mpd[2616]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.30' not found (required by /usr/bin/mpd) Dec 23 09:03:19 so1905-b6d5 mpd[2616]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `CXXABI_1.3.13' not found (required by /usr/bin/mpd) Dec 23 09:03:19 so1905-b6d5 mpd[2616]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.33' not found (required by /usr/bin/mpd) Dec 23 09:03:19 so1905-b6d5 mpd[2616]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.32' not found (required by /usr/bin/mpd) Dec 23 09:03:19 so1905-b6d5 mpd[2616]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.34' not found (required by /usr/bin/mpd) Dec 23 09:03:19 so1905-b6d5 display[2188]: stb_image successfully loaded: 855x855, channels=3 Dec 23 09:03:19 so1905-b6d5 sudo[2630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r wlan0 Dec 23 09:03:19 so1905-b6d5 display[2188]: Successfully processed with stb_image Dec 23 09:03:19 so1905-b6d5 display[2188]: Loading default image: /volumio/display/assets/albumart.jpg Dec 23 09:03:19 so1905-b6d5 display[2188]: Loaded default image from file: /volumio/display/assets/albumart.jpg, size=77672 Dec 23 09:03:19 so1905-b6d5 display[2188]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF Dec 23 09:03:19 so1905-b6d5 display[2188]: Attempting to process with stb_image... Dec 23 09:03:20 so1905-b6d5 sudo[2630]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:20 so1905-b6d5 systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:20 so1905-b6d5 systemd[1]: mpd.service: Failed with result 'exit-code'. Dec 23 09:03:20 so1905-b6d5 systemd[1]: Failed to start Music Player Daemon. Dec 23 09:03:20 so1905-b6d5 sudo[2630]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:20 so1905-b6d5 systemd[1]: Started Samba SMB Daemon. Dec 23 09:03:20 so1905-b6d5 sudo[2582]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:20 so1905-b6d5 systemd[1]: Reached target Multi-User System. Dec 23 09:03:20 so1905-b6d5 systemd[1]: Reached target Graphical Interface. Dec 23 09:03:20 so1905-b6d5 systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 23 09:03:20 so1905-b6d5 node[2207]: Connected to: ----FORTEX Dec 23 09:03:20 so1905-b6d5 node[2207]: ---- Dec 23 09:03:20 so1905-b6d5 display[2188]: stb_image successfully loaded: 855x855, channels=3 Dec 23 09:03:20 so1905-b6d5 node[2207]: ... joined AP, wlan0 IPv4 is 192.168.23.129, ipV6 is undefined Dec 23 09:03:20 so1905-b6d5 node[2207]: It's done! AP Dec 23 09:03:20 so1905-b6d5 display[2188]: Successfully processed with stb_image Dec 23 09:03:20 so1905-b6d5 display[2188]: Default image loaded successfully Dec 23 09:03:20 so1905-b6d5 display[2188]: setImageSrc: this=0x2b2f720, str=/volumio/display/assets/status-icon/wifi-error.png Dec 23 09:03:20 so1905-b6d5 display[2188]: read file /volumio/display/assets/status-icon/wifi-error.png, size=1494, buffer[0]=89 Dec 23 09:03:20 so1905-b6d5 display[2188]: setImageSrc: this=0x2b2f918, str=/volumio/display/assets/status-icon/eth-error.png Dec 23 09:03:20 so1905-b6d5 display[2188]: read file /volumio/display/assets/status-icon/eth-error.png, size=936, buffer[0]=89 Dec 23 09:03:20 so1905-b6d5 sudo[2653]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 09:03:20 so1905-b6d5 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 23 09:03:20 so1905-b6d5 systemd[1]: Finished Update UTMP about System Runlevel Changes. Dec 23 09:03:20 so1905-b6d5 sudo[2653]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:20 so1905-b6d5 display[2188]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Dec 23 09:03:20 so1905-b6d5 display[2188]: 文件大小: 6344 字节 Dec 23 09:03:20 so1905-b6d5 display[2188]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 40px) Dec 23 09:03:20 so1905-b6d5 sudo[2653]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:20 so1905-b6d5 display[2188]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf Dec 23 09:03:20 so1905-b6d5 display[2188]: 文件大小: 11495876 字节 Dec 23 09:03:20 so1905-b6d5 display[2188]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf (大小: 40px) Dec 23 09:03:20 so1905-b6d5 systemd[1]: Started go-librespot Daemon. Dec 23 09:03:20 so1905-b6d5 display[2188]: setInnerAlign: image_desc is null Dec 23 09:03:20 so1905-b6d5 node[2207]: ... joined AP, wlan0 IPv4 is 192.168.23.129, ipV6 is undefined Dec 23 09:03:20 so1905-b6d5 node[2207]: It's done! AP Dec 23 09:03:20 so1905-b6d5 go-librespot[2670]: go-librespot daemon starting... Dec 23 09:03:20 so1905-b6d5 systemd[1]: Stopping go-librespot Daemon... Dec 23 09:03:20 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Succeeded. Dec 23 09:03:20 so1905-b6d5 systemd[1]: Stopped go-librespot Daemon. Dec 23 09:03:20 so1905-b6d5 volumio[2285]: info: Loading plugin "networkfs"... Dec 23 09:03:20 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/system_controller/networkfs/index.js Dec 23 09:03:20 so1905-b6d5 systemd[1]: Started go-librespot Daemon. Dec 23 09:03:20 so1905-b6d5 go-librespot[2684]: go-librespot daemon starting... Dec 23 09:03:21 so1905-b6d5 volumio[2285]: info: Starting IP address watcher Dec 23 09:03:21 so1905-b6d5 display[2188]: setImageSrc: this=0x2c2b6a0, str=/volumio/display/assets/source-icon/streaming.png Dec 23 09:03:21 so1905-b6d5 display[2188]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 23 09:03:21 so1905-b6d5 volumio[2285]: info: Started network interface ip monitor watcher Dec 23 09:03:21 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 23 09:03:21 so1905-b6d5 volumio[2285]: info: Loading plugin "alarm-clock"... Dec 23 09:03:21 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/miscellanea/alarm-clock/index.js Dec 23 09:03:21 so1905-b6d5 display[2188]: setImageSrc: this=0x2c312c8, str=/volumio/display/assets/source-icon/streaming.png Dec 23 09:03:21 so1905-b6d5 display[2188]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 23 09:03:21 so1905-b6d5 display[2188]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Dec 23 09:03:21 so1905-b6d5 display[2188]: 文件大小: 6344 字节 Dec 23 09:03:21 so1905-b6d5 display[2188]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 100px) Dec 23 09:03:21 so1905-b6d5 display[2188]: setImageSrc: this=0x2b08d90, str=/volumio/display/assets/source-icon/streaming.png Dec 23 09:03:21 so1905-b6d5 display[2188]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Dec 23 09:03:21 so1905-b6d5 smbd[2578]: [2025/12/23 09:03:21.405322, 0] ../../source3/smbd/server.c:1082(smbd_open_one_socket) Dec 23 09:03:21 so1905-b6d5 smbd[2578]: smbd_open_one_socket: open_socket_in failed: Address family not supported by protocol Dec 23 09:03:21 so1905-b6d5 smbd[2578]: [2025/12/23 09:03:21.418315, 0] ../../source3/smbd/server.c:1082(smbd_open_one_socket) Dec 23 09:03:21 so1905-b6d5 smbd[2578]: smbd_open_one_socket: open_socket_in failed: Address family not supported by protocol Dec 23 09:03:21 so1905-b6d5 kernel: [SNDCODEC][sunxi_check_hs_detect_status][191]:plugin --> switch:1 Dec 23 09:03:21 so1905-b6d5 volumio[2285]: info: Loading plugin "airplay_emulation"... Dec 23 09:03:21 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/airplay_emulation/index.js Dec 23 09:03:21 so1905-b6d5 go-librespot[2694]: time="2025-12-23T09:03:21+08:00" level=info msg="running go-librespot 0.0.0" Dec 23 09:03:21 so1905-b6d5 go-librespot[2694]: time="2025-12-23T09:03:21+08:00" level=fatal msg="failed creating app" error="failed unmarshalling state file: unexpected end of JSON input" Dec 23 09:03:21 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:21 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 23 09:03:21 so1905-b6d5 volumio[2285]: 执行命令出错: 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 23 09:03:21 so1905-b6d5 volumio[2285]: info: Starting Shairport Sync Dec 23 09:03:21 so1905-b6d5 volumio[2285]: info: [AirPlay] Started coverart directory watcher Dec 23 09:03:21 so1905-b6d5 volumio[2285]: info: Loading plugin "last_100"... Dec 23 09:03:21 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/last_100/index.js Dec 23 09:03:22 so1905-b6d5 volumio[2285]: info: Loading plugin "spop"... Dec 23 09:03:22 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/spop/index.js Dec 23 09:03:22 so1905-b6d5 volumio[2285]: info: Loading plugin "webradio"... Dec 23 09:03:22 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/webradio/index.js Dec 23 09:03:22 so1905-b6d5 kernel: [SNDCODEC][sunxi_check_hs_detect_status][222]:plugout --> switch:0 Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: [2025/12/23 09:03:23.158907, 0] ../../source3/nmbd/nmbd_workgroupdb.c:279(dump_workgroups) Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: dump_workgroups() Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: dump workgroup on subnet 192.168.23.129: netmask= 255.255.255.0: Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: WORKGROUP(1) current master browser = UNKNOWN Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: VOLUMIO 40809a03 (Volumio Audiophile Music Player) Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: [2025/12/23 09:03:23.159800, 0] ../../source3/nmbd/nmbd_workgroupdb.c:279(dump_workgroups) Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: dump_workgroups() Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: dump workgroup on subnet UNICAST_SUBNET: netmask= 192.168.23.129: Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: WORKGROUP(1) current master browser = UNKNOWN Dec 23 09:03:23 so1905-b6d5 nmbd[2256]: VOLUMIO 40809a03 (Volumio Audiophile Music Player) Dec 23 09:03:23 so1905-b6d5 systemd[1]: logrotate.service: Succeeded. Dec 23 09:03:23 so1905-b6d5 systemd[1]: Finished Rotate log files. Dec 23 09:03:24 so1905-b6d5 volumio[2285]: info: Loading plugin "yandex_browser"... Dec 23 09:03:24 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/yandex_browser/index.js Dec 23 09:03:24 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Dec 23 09:03:25 so1905-b6d5 systemd[1]: Stopped go-librespot Daemon. Dec 23 09:03:25 so1905-b6d5 systemd[1]: Started go-librespot Daemon. Dec 23 09:03:25 so1905-b6d5 go-librespot[2711]: go-librespot daemon starting... Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Yandex plugin started Dec 23 09:03:25 so1905-b6d5 go-librespot[2713]: time="2025-12-23T09:03:25+08:00" level=info msg="running go-librespot 0.0.0" Dec 23 09:03:25 so1905-b6d5 go-librespot[2713]: time="2025-12-23T09:03:25+08:00" level=fatal msg="failed creating app" error="failed unmarshalling state file: unexpected end of JSON input" Dec 23 09:03:25 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:25 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 23 09:03:25 so1905-b6d5 volumio[2285]: error: ATTENTION!!!: Plugin yandex_browser does not return adequate promise from onVolumioStart: please update! Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Loading plugin "i2s_dacs"... Dec 23 09:03:25 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/system_controller/i2s_dacs/index.js Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: I2S DAC not set, start Auto-detection Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Loading plugin "volumiodiscovery"... Dec 23 09:03:25 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/system_controller/volumiodiscovery/index.js Dec 23 09:03:25 so1905-b6d5 volumio[2285]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 23 09:03:25 so1905-b6d5 volumio[2285]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 23 09:03:25 so1905-b6d5 node[2285]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 23 09:03:25 so1905-b6d5 volumio[2285]: *** WARNING *** For more information see Dec 23 09:03:25 so1905-b6d5 volumio[2285]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 23 09:03:25 so1905-b6d5 volumio[2285]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 23 09:03:25 so1905-b6d5 volumio[2285]: *** WARNING *** For more information see Dec 23 09:03:25 so1905-b6d5 node[2285]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 23 09:03:25 so1905-b6d5 node[2285]: *** WARNING *** For more information see Dec 23 09:03:25 so1905-b6d5 node[2285]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 23 09:03:25 so1905-b6d5 node[2285]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 23 09:03:25 so1905-b6d5 node[2285]: *** WARNING *** For more information see Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Discovery: Started advertising with name: SO1905-b6d5 Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Loading plugin "outputs"... Dec 23 09:03:25 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/audio_interface/outputs/index.js Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Loading plugin "albumart"... Dec 23 09:03:25 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/miscellanea/albumart/index.js Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Plugin example_plugin is not enabled Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Loading plugin "inputs"... Dec 23 09:03:25 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/inputs/index.js Dec 23 09:03:25 so1905-b6d5 volumio[2285]: info: Loading plugin "pandora"... Dec 23 09:03:25 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/pandora/index.js Dec 23 09:03:26 so1905-b6d5 kernel: usb0-vbus: disabling Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: Applying required configuration parameters for plugin pandora Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: Loading plugin "podcast"... Dec 23 09:03:26 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/podcast/index.js Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: ControllerPodcast::constructor Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: Loading plugin "qobuz"... Dec 23 09:03:26 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/qobuz/index.js Dec 23 09:03:26 so1905-b6d5 volumio[2285]: error: ATTENTION!!!: Plugin qobuz does not return adequate promise from onVolumioStart: please update! Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: Loading plugin "tidal"... Dec 23 09:03:26 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/music_service/tidal/index.js Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: [1766451806816] ControllerTidalPlugin::constructor Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: [1766451806819] ControllerTidalPlugin::onVolumioStart Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: Plugin volspotconnect2 is not enabled Dec 23 09:03:26 so1905-b6d5 volumio[2285]: info: Loading plugin "updater_comm"... Dec 23 09:03:26 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/system_controller/updater_comm/index.js Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: Plugin mpdemulation is not enabled Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: Loading plugin "rest_api"... Dec 23 09:03:27 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/user_interface/rest_api/index.js Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: Loading plugin "websocket"... Dec 23 09:03:27 so1905-b6d5 volumio[2285]: [ require ] /volumio/app/plugins/user_interface/websocket/index.js Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: ___________ START PLUGINS ___________ Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807161] CoreMusicLibrary::Adding element Media Servers Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: SSDP Client initialized. Dec 23 09:03:27 so1905-b6d5 volumio[2285]: Starting initial SSDP search... Dec 23 09:03:27 so1905-b6d5 volumio[2285]: Discovering on interface: lo Dec 23 09:03:27 so1905-b6d5 volumio[2285]: Discovering on interface: wlan0 Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807305] CoreMusicLibrary::Adding element Last_100 Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: Creating Spotify config file Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807357] CoreMusicLibrary::Adding element Webradio Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: Yandex plugin started Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807390] ControllerYandexPlugin::addToBrowseSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807392] CoreMusicLibrary::Adding element Yandex Music Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: error: Plugin yandex_browser does not return adequate promise from onStart: please update! Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807408] CoreMusicLibrary::Adding element Pandora Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807415] ControllerPandora::initializeMQTT Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807417] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807435] CoreMusicLibrary::Adding element Podcast Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807443] CoreMusicLibrary::Adding element Qobuz Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807457] ControllerTidalPlugin::onStart Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807465] ControllerTidalPlugin::addToBrowseSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: [1766451807467] CoreMusicLibrary::Adding element Tidal Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: Loading i18n strings for locale en Dec 23 09:03:27 so1905-b6d5 volumio[2285]: Updating browse sources language Dec 23 09:03:27 so1905-b6d5 volumio[2285]: Cannot find translation for sourceMedia Servers Dec 23 09:03:27 so1905-b6d5 volumio[2285]: Cannot find translation for sourceYandex Music Dec 23 09:03:27 so1905-b6d5 volumio[2285]: Cannot find translation for sourcePodcast Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::initPlayerControls Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: BOOT COMPLETED Dec 23 09:03:27 so1905-b6d5 volumio[2285]: [Metrics] CommandRouter: 13s 645.24ms Dec 23 09:03:27 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 09:03:27 so1905-b6d5 kernel: sunxi-spdif 2036000.spdif: active: 1 Dec 23 09:03:28 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Dec 23 09:03:28 so1905-b6d5 systemd[1]: Stopped go-librespot Daemon. Dec 23 09:03:28 so1905-b6d5 systemd[1]: Started go-librespot Daemon. Dec 23 09:03:28 so1905-b6d5 go-librespot[2734]: go-librespot daemon starting... Dec 23 09:03:28 so1905-b6d5 go-librespot[2736]: time="2025-12-23T09:03:28+08:00" level=info msg="running go-librespot 0.0.0" Dec 23 09:03:28 so1905-b6d5 go-librespot[2736]: time="2025-12-23T09:03:28+08:00" level=fatal msg="failed creating app" error="failed unmarshalling state file: unexpected end of JSON input" Dec 23 09:03:29 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:29 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 23 09:03:32 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Dec 23 09:03:32 so1905-b6d5 systemd[1]: Stopped go-librespot Daemon. Dec 23 09:03:32 so1905-b6d5 systemd[1]: Started go-librespot Daemon. Dec 23 09:03:32 so1905-b6d5 go-librespot[2742]: go-librespot daemon starting... Dec 23 09:03:32 so1905-b6d5 go-librespot[2744]: time="2025-12-23T09:03:32+08:00" level=info msg="running go-librespot 0.0.0" Dec 23 09:03:32 so1905-b6d5 go-librespot[2744]: time="2025-12-23T09:03:32+08:00" level=fatal msg="failed creating app" error="failed unmarshalling state file: unexpected end of JSON input" Dec 23 09:03:32 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:32 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 23 09:03:33 so1905-b6d5 volumio[2285]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::Close All Modals sent Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::Close All Modals sent Dec 23 09:03:33 so1905-b6d5 volumio[2285]: Express server listening on port 3000 Dec 23 09:03:33 so1905-b6d5 volumio[2285]: [Metrics] WebUI: 19s 929.11ms Dec 23 09:03:33 so1905-b6d5 volumio[2285]: (node:2285) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: [1766451813245] ControllerPandora::validateAndSetAccountOptions Dec 23 09:03:33 so1905-b6d5 volumio[2285]: error: [1766451813248] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: CoreStateMachine::resetVolumioState Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: CoreStateMachine::getcurrentVolume Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioRetrievevolume Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 09:03:33 so1905-b6d5 sudo[2762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 09:03:33 so1905-b6d5 sudo[2762]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:33 so1905-b6d5 sudo[2764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 09:03:33 so1905-b6d5 sudo[2762]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:33 so1905-b6d5 volumio[2285]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 23 09:03:33 so1905-b6d5 sudo[2764]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:33 so1905-b6d5 sudo[2764]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: IP address changed from "" to "192.168.23.129" Dec 23 09:03:33 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 23 09:03:34 so1905-b6d5 sudo[2796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 23 09:03:34 so1905-b6d5 sudo[2796]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:34 so1905-b6d5 sudo[2790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 23 09:03:34 so1905-b6d5 sudo[2796]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:34 so1905-b6d5 sudo[2790]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: Connecting to wireless device: undefined Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: this.stateMachine.currentVolume: null, vol: 0 Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:34 so1905-b6d5 sudo[2803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: [AirPlay] Received volume update: {"vol":0,"mute":false,"disableVolumeControl":false} Dec 23 09:03:34 so1905-b6d5 sudo[2790]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:34 so1905-b6d5 sudo[2811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 09:03:34 so1905-b6d5 sudo[2803]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:34 so1905-b6d5 sudo[2811]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: CoreStateMachine::pushState Dec 23 09:03:34 so1905-b6d5 sudo[2803]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 09:03:34 so1905-b6d5 sudo[2811]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:34 so1905-b6d5 sudo[2820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: CoreStateMachine::updateTrackBlock Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: CorePlayQueue::getTrackBlock Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::volumioRetrievevolume Dec 23 09:03:34 so1905-b6d5 sudo[2820]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:34 so1905-b6d5 sudo[2820]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:34 so1905-b6d5 volumio[2285]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Dec 23 09:03:34 so1905-b6d5 volumio[2285]: Job for mpd.service failed because the control process exited with error code. Dec 23 09:03:34 so1905-b6d5 volumio[2285]: See "systemctl status mpd.service" and "journalctl -xe" for details. Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: MPD Permissions set Dec 23 09:03:34 so1905-b6d5 systemd[1]: Starting Music Player Daemon... Dec 23 09:03:34 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 23 09:03:35 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 23 09:03:35 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 23 09:03:35 so1905-b6d5 mpd[2866]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.29' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2866]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.30' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2866]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `CXXABI_1.3.13' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2866]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.33' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2866]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.32' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2866]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.34' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:35 so1905-b6d5 systemd[1]: mpd.service: Failed with result 'exit-code'. Dec 23 09:03:35 so1905-b6d5 systemd[1]: Failed to start Music Player Daemon. Dec 23 09:03:35 so1905-b6d5 systemd[1]: Starting Music Player Daemon... Dec 23 09:03:35 so1905-b6d5 mpd[2871]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.29' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2871]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.30' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2871]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `CXXABI_1.3.13' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2871]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.33' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2871]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.32' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 mpd[2871]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.34' not found (required by /usr/bin/mpd) Dec 23 09:03:35 so1905-b6d5 systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:35 so1905-b6d5 systemd[1]: mpd.service: Failed with result 'exit-code'. Dec 23 09:03:35 so1905-b6d5 systemd[1]: Failed to start Music Player Daemon. Dec 23 09:03:35 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Dec 23 09:03:35 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 23 09:03:35 so1905-b6d5 systemd[1]: Stopped go-librespot Daemon. Dec 23 09:03:35 so1905-b6d5 volumio[2285]: info: [pushCmd] {"index":5,"getInfo":0} Dec 23 09:03:35 so1905-b6d5 systemd[1]: Started go-librespot Daemon. Dec 23 09:03:35 so1905-b6d5 go-librespot[2873]: go-librespot daemon starting... Dec 23 09:03:35 so1905-b6d5 systemd[1]: Starting Music Player Daemon... Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: network , pushNetworkConfiguredStatus Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: pushNetworkConfiguredResult ok {"status":"success","ssid":"FORTEX"} Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: Push network configured result Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: pushNetworkConfiguredResult Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: network , pushNetworkConfiguredStatus Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: pushNetworkConfiguredResult ok {"status":"success","ssid":"FORTEX"} Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: Push network configured result Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: pushNetworkConfiguredResult Dec 23 09:03:36 so1905-b6d5 mpd[2876]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.29' not found (required by /usr/bin/mpd) Dec 23 09:03:36 so1905-b6d5 mpd[2876]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.30' not found (required by /usr/bin/mpd) Dec 23 09:03:36 so1905-b6d5 mpd[2876]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `CXXABI_1.3.13' not found (required by /usr/bin/mpd) Dec 23 09:03:36 so1905-b6d5 mpd[2876]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.33' not found (required by /usr/bin/mpd) Dec 23 09:03:36 so1905-b6d5 mpd[2876]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.32' not found (required by /usr/bin/mpd) Dec 23 09:03:36 so1905-b6d5 mpd[2876]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.34' not found (required by /usr/bin/mpd) Dec 23 09:03:36 so1905-b6d5 systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:36 so1905-b6d5 systemd[1]: mpd.service: Failed with result 'exit-code'. Dec 23 09:03:36 so1905-b6d5 systemd[1]: Failed to start Music Player Daemon. Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 23 09:03:36 so1905-b6d5 volumio[2285]: sudo: /usr/sbin/i2cdetect: command not found Dec 23 09:03:36 so1905-b6d5 systemd[1]: Starting Music Player Daemon... Dec 23 09:03:36 so1905-b6d5 volumio[2285]: error: 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 23 09:03:36 so1905-b6d5 volumio[2285]: Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files Dec 23 09:03:36 so1905-b6d5 volumio[2285]: {"stdout":"","stderr":"Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files\n"} Dec 23 09:03:36 so1905-b6d5 go-librespot[2879]: time="2025-12-23T09:03:36+08:00" level=info msg="running go-librespot 0.0.0" Dec 23 09:03:36 so1905-b6d5 go-librespot[2879]: time="2025-12-23T09:03:36+08:00" level=fatal msg="failed creating app" error="failed unmarshalling state file: unexpected end of JSON input" Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: Spotify config file written Dec 23 09:03:36 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:36 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 23 09:03:36 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 09:03:36 so1905-b6d5 sudo[2894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart go-librespot-daemon.service Dec 23 09:03:36 so1905-b6d5 kernel: sunxi-spdif 2036000.spdif: active: 1 Dec 23 09:03:36 so1905-b6d5 sudo[2894]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 09:03:36 so1905-b6d5 systemd[1]: Stopped go-librespot Daemon. Dec 23 09:03:36 so1905-b6d5 systemd[1]: Started go-librespot Daemon. Dec 23 09:03:36 so1905-b6d5 sudo[2894]: pam_unix(sudo:session): session closed for user root Dec 23 09:03:37 so1905-b6d5 go-librespot[2902]: go-librespot daemon starting... Dec 23 09:03:37 so1905-b6d5 mpd[2887]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.29' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2887]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.30' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2887]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `CXXABI_1.3.13' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2887]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.33' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2887]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.32' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2887]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.34' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:37 so1905-b6d5 systemd[1]: mpd.service: Failed with result 'exit-code'. Dec 23 09:03:37 so1905-b6d5 systemd[1]: Failed to start Music Player Daemon. Dec 23 09:03:37 so1905-b6d5 systemd[1]: Starting Music Player Daemon... Dec 23 09:03:37 so1905-b6d5 mpd[2907]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.29' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2907]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `GLIBCXX_3.4.30' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2907]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libstdc++.so.6: version `CXXABI_1.3.13' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2907]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.33' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2907]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.32' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 mpd[2907]: /usr/bin/mpd: /lib/arm-linux-gnueabihf/libc.so.6: version `GLIBC_2.34' not found (required by /usr/bin/mpd) Dec 23 09:03:37 so1905-b6d5 systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:37 so1905-b6d5 systemd[1]: mpd.service: Failed with result 'exit-code'. Dec 23 09:03:37 so1905-b6d5 systemd[1]: Failed to start Music Player Daemon. Dec 23 09:03:37 so1905-b6d5 systemd[1]: mpd.service: Start request repeated too quickly. Dec 23 09:03:37 so1905-b6d5 systemd[1]: mpd.service: Failed with result 'exit-code'. Dec 23 09:03:37 so1905-b6d5 systemd[1]: Failed to start Music Player Daemon. Dec 23 09:03:37 so1905-b6d5 systemd[1]: mpd.socket: Failed with result 'service-start-limit-hit'. Dec 23 09:03:37 so1905-b6d5 go-librespot[2908]: time="2025-12-23T09:03:37+08:00" level=info msg="running go-librespot 0.0.0" Dec 23 09:03:37 so1905-b6d5 go-librespot[2908]: time="2025-12-23T09:03:37+08:00" level=fatal msg="failed creating app" error="failed unmarshalling state file: unexpected end of JSON input" Dec 23 09:03:37 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:37 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 23 09:03:37 so1905-b6d5 volumio[2855]: Forking 1 albumart workers Dec 23 09:03:38 so1905-b6d5 volumio[2285]: Playing WAVE '/volumio/app/wifi_connected.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 23 09:03:38 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::Close All Modals sent Dec 23 09:03:38 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 09:03:38 so1905-b6d5 kernel: sunxi-spdif 2036000.spdif: active: 1 Dec 23 09:03:39 so1905-b6d5 volumio[2914]: Starting albumart workers Dec 23 09:03:40 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Dec 23 09:03:40 so1905-b6d5 systemd[1]: Stopped go-librespot Daemon. Dec 23 09:03:40 so1905-b6d5 systemd[1]: Started go-librespot Daemon. Dec 23 09:03:40 so1905-b6d5 go-librespot[2932]: go-librespot daemon starting... Dec 23 09:03:40 so1905-b6d5 volumio[2285]: Playing WAVE '/volumio/app/wifi_connected.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 23 09:03:40 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::Close All Modals sent Dec 23 09:03:41 so1905-b6d5 go-librespot[2934]: time="2025-12-23T09:03:41+08:00" level=info msg="running go-librespot 0.0.0" Dec 23 09:03:41 so1905-b6d5 go-librespot[2934]: time="2025-12-23T09:03:41+08:00" level=fatal msg="failed creating app" error="failed unmarshalling state file: unexpected end of JSON input" Dec 23 09:03:41 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 23 09:03:41 so1905-b6d5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: [pushCmd] {"index":5,"getInfo":0} Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: [pushCmd] {"index":5,"getInfo":0} Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 09:03:41 so1905-b6d5 volumio[2285]: info: No need to fix Spotify hosts Dec 23 09:03:42 so1905-b6d5 volumio[2285]: error: MPD error: Error: read ECONNRESET Dec 23 09:03:42 so1905-b6d5 volumio[2285]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 09:03:42 so1905-b6d5 volumio[2285]: TypeError: err.includes is not a function Dec 23 09:03:42 so1905-b6d5 volumio[2285]: at MpdClient.eval (webpack://Volumio2/./app/plugins/music_service/mpd/index.js?:861:13) Dec 23 09:03:42 so1905-b6d5 volumio[2285]: at MpdClient.emit (events.js:198:13) Dec 23 09:03:42 so1905-b6d5 volumio[2285]: at Socket.eval (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:49:12) Dec 23 09:03:42 so1905-b6d5 volumio[2285]: at Socket.emit (events.js:198:13) Dec 23 09:03:42 so1905-b6d5 volumio[2285]: at emitErrorNT (internal/streams/destroy.js:91:8) Dec 23 09:03:42 so1905-b6d5 volumio[2285]: at emitErrorAndCloseNT (internal/streams/destroy.js:59:3) Dec 23 09:03:42 so1905-b6d5 volumio[2285]: at process._tickCallback (internal/process/next_tick.js:63:19) Dec 23 09:03:42 so1905-b6d5 volumio[2285]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 09:03:43 so1905-b6d5 sudo[2964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-23 09:02 Dec 23 09:03:43 so1905-b6d5 sudo[2964]: 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.4.20 VOLUMIO_BUILD_DATE=2025-12-05 14:21:17 VOLUMIO_VARIANT=volumio VOLUMIO_HARDWARE=Generic DT based system