-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Mon 2025-12-15 15:47:45 CST. --
Dec 15 15:47:14 so1905-bfc4 sudo[29491]: volumio : TTY=pts/0 ; PWD=/media/udisk ; USER=root ; COMMAND=/usr/bin/systemctl stop volumio.service
Dec 15 15:47:14 so1905-bfc4 sudo[29491]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Dec 15 15:47:14 so1905-bfc4 systemd[1]: Stopping Volumio Backend Module...
Dec 15 15:47:14 so1905-bfc4 go-librespot[24339]: time="2025-12-15T15:47:14+08:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF"
Dec 15 15:47:14 so1905-bfc4 systemd[1]: volumio.service: Succeeded.
Dec 15 15:47:14 so1905-bfc4 systemd[1]: Stopped Volumio Backend Module.
Dec 15 15:47:14 so1905-bfc4 sudo[29491]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:14 so1905-bfc4 sudo[29501]: volumio : TTY=pts/0 ; PWD=/media/udisk ; USER=root ; COMMAND=/usr/bin/systemctl stop display.service
Dec 15 15:47:14 so1905-bfc4 sudo[29501]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Dec 15 15:47:14 so1905-bfc4 systemd[1]: Stopping display Daemon...
Dec 15 15:47:14 so1905-bfc4 systemd[1]: display.service: Killing process 24085 (lvgljs) with signal SIGKILL.
Dec 15 15:47:14 so1905-bfc4 systemd[1]: display.service: Succeeded.
Dec 15 15:47:14 so1905-bfc4 systemd[1]: Stopped display Daemon.
Dec 15 15:47:14 so1905-bfc4 sudo[29501]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:15 so1905-bfc4 sudo[29511]: volumio : TTY=pts/0 ; PWD=/media/udisk ; USER=root ; COMMAND=/usr/bin/systemctl start display.service
Dec 15 15:47:15 so1905-bfc4 sudo[29511]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Dec 15 15:47:15 so1905-bfc4 systemd[1]: Started display Daemon.
Dec 15 15:47:15 so1905-bfc4 sudo[29511]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:15 so1905-bfc4 display[29518]: lvgl_display daemon starting...
Dec 15 15:47:15 so1905-bfc4 sudo[29523]: volumio : TTY=pts/0 ; PWD=/media/udisk ; USER=root ; COMMAND=/usr/bin/systemctl start volumio.service
Dec 15 15:47:15 so1905-bfc4 sudo[29523]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Dec 15 15:47:15 so1905-bfc4 systemd[1]: Started dynamicswap service.
Dec 15 15:47:15 so1905-bfc4 systemd[1]: Started Volumio Backend Module.
Dec 15 15:47:15 so1905-bfc4 sudo[29523]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:15 so1905-bfc4 systemd[1]: dynamicswap.service: Succeeded.
Dec 15 15:47:15 so1905-bfc4 display[29532]: 初始化FreeType...
Dec 15 15:47:15 so1905-bfc4 display[29532]: FreeType初始化失败
Dec 15 15:47:15 so1905-bfc4 display[29532]: [HeartbeatMonitor] 初始化完成
Dec 15 15:47:16 so1905-bfc4 display[29532]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf
Dec 15 15:47:16 so1905-bfc4 display[29532]: 文件大小: 11364916 字节
Dec 15 15:47:16 so1905-bfc4 display[29532]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf (大小: 50px)
Dec 15 15:47:16 so1905-bfc4 display[29532]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf
Dec 15 15:47:16 so1905-bfc4 display[29532]: 文件大小: 11364916 字节
Dec 15 15:47:16 so1905-bfc4 display[29532]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf (大小: 36px)
Dec 15 15:47:16 so1905-bfc4 display[29532]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf
Dec 15 15:47:16 so1905-bfc4 display[29532]: 文件大小: 11364916 字节
Dec 15 15:47:16 so1905-bfc4 display[29532]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-65-Medium.ttf (大小: 40px)
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d0278, str=/volumio/display/assets/source-icon/streaming.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d4810, str=/volumio/display/assets/source-icon/bt.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/bt.png, size=11779, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d4940, str=/volumio/display/assets/source-icon/aux.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/aux.png, size=10326, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d4df0, str=/volumio/display/assets/source-icon/opt.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/opt.png, size=8229, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d5098, str=/volumio/display/assets/source-icon/opt.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/opt.png, size=8229, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d53b0, str=/volumio/display/assets/source-icon/hdmi-arc.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/hdmi-arc.png, size=7908, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d5c80, str=/volumio/display/assets/source-icon/usb.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/usb.png, size=7652, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d0d98, str=/volumio/display/assets/source-icon/music-library.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/music-library.png, size=22848, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d1280, str=/volumio/display/assets/source-icon/bt.png
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/bt.png, size=11779, buffer[0]=89
Dec 15 15:47:16 so1905-bfc4 display[29532]: setImageSrc: this=0x23d1850, str=/volumio/display/assets/albumart.jpg
Dec 15 15:47:16 so1905-bfc4 display[29532]: read file /volumio/display/assets/albumart.jpg, size=77672, buffer[0]=ff
Dec 15 15:47:16 so1905-bfc4 display[29532]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF
Dec 15 15:47:16 so1905-bfc4 display[29532]: Attempting to process with stb_image...
Dec 15 15:47:17 so1905-bfc4 display[29532]: stb_image successfully loaded: 855x855, channels=3
Dec 15 15:47:17 so1905-bfc4 display[29532]: Successfully processed with stb_image
Dec 15 15:47:17 so1905-bfc4 display[29532]: Loading default image: /volumio/display/assets/albumart.jpg
Dec 15 15:47:17 so1905-bfc4 display[29532]: Loaded default image from file: /volumio/display/assets/albumart.jpg, size=77672
Dec 15 15:47:17 so1905-bfc4 display[29532]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF
Dec 15 15:47:17 so1905-bfc4 display[29532]: Attempting to process with stb_image...
Dec 15 15:47:17 so1905-bfc4 display[29532]: stb_image successfully loaded: 855x855, channels=3
Dec 15 15:47:17 so1905-bfc4 display[29532]: Successfully processed with stb_image
Dec 15 15:47:17 so1905-bfc4 display[29532]: Default image loaded successfully
Dec 15 15:47:17 so1905-bfc4 display[29532]: setImageSrc: this=0x23d1a20, str=/volumio/display/assets/status-icon/wifi-error.png
Dec 15 15:47:17 so1905-bfc4 display[29532]: read file /volumio/display/assets/status-icon/wifi-error.png, size=1494, buffer[0]=89
Dec 15 15:47:17 so1905-bfc4 display[29532]: setImageSrc: this=0x23d2860, str=/volumio/display/assets/status-icon/eth-error.png
Dec 15 15:47:17 so1905-bfc4 display[29532]: read file /volumio/display/assets/status-icon/eth-error.png, size=936, buffer[0]=89
Dec 15 15:47:17 so1905-bfc4 display[29532]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf
Dec 15 15:47:17 so1905-bfc4 display[29532]: 文件大小: 6344 字节
Dec 15 15:47:17 so1905-bfc4 display[29532]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 40px)
Dec 15 15:47:17 so1905-bfc4 display[29532]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf
Dec 15 15:47:17 so1905-bfc4 display[29532]: 文件大小: 11495876 字节
Dec 15 15:47:17 so1905-bfc4 display[29532]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf (大小: 40px)
Dec 15 15:47:17 so1905-bfc4 display[29532]: setInnerAlign: image_desc is null
Dec 15 15:47:17 so1905-bfc4 display[29532]: setImageSrc: this=0x23d6ec8, str=/volumio/display/assets/source-icon/streaming.png
Dec 15 15:47:17 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89
Dec 15 15:47:17 so1905-bfc4 display[29532]: setImageSrc: this=0x23e94c8, str=/volumio/display/assets/source-icon/streaming.png
Dec 15 15:47:17 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89
Dec 15 15:47:17 so1905-bfc4 display[29532]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf
Dec 15 15:47:17 so1905-bfc4 display[29532]: 文件大小: 6344 字节
Dec 15 15:47:17 so1905-bfc4 display[29532]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 100px)
Dec 15 15:47:17 so1905-bfc4 display[29532]: setImageSrc: this=0x23e9bf0, str=/volumio/display/assets/source-icon/streaming.png
Dec 15 15:47:17 so1905-bfc4 display[29532]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89
Dec 15 15:47:19 so1905-bfc4 volumio[29531]: info: -------------------------------------------
Dec 15 15:47:19 so1905-bfc4 volumio[29531]: info: ----- Synaudio ----
Dec 15 15:47:19 so1905-bfc4 volumio[29531]: info: -------------------------------------------
Dec 15 15:47:19 so1905-bfc4 volumio[29531]: info: ----- System startup ----
Dec 15 15:47:19 so1905-bfc4 volumio[29531]: info: -------------------------------------------
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Found new core plugin music_service/cdplayer. Adding it
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Configured plugin music_service/cdplayer cannot be loaded. Removing from configuration
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Plugin folders cleanup
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Scanning into folder /volumio/app/plugins/
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Scanning category audio_interface
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Scanning category miscellanea
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Scanning category music_service
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Scanning category plugins.json
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Scanning category system_controller
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Scanning category user_interface
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Scanning into folder /data/plugins/
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Plugin folders cleanup completed
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: -------------------------------------------
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: ----- Core plugins startup ----
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: -------------------------------------------
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Loading plugins from folder /volumio/app/plugins/
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Adding plugin upnp to MyMusic Plugins
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Adding plugin airplay_emulation to MyMusic Plugins
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Adding plugin upnp_browser to MyMusic Plugins
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Loading plugins from folder /data/plugins/
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Loading plugin "system"...
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/system_controller/system/index.js
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: info: Loading plugin "appearance"...
Dec 15 15:47:21 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/miscellanea/appearance/index.js
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Loading plugin "network"...
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/system_controller/network/index.js
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Refreshing Cached IP Addresses
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: ControllerNetwork autoStartNetworkConfig true
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Loading plugin "services"...
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/system_controller/services/index.js
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Loading plugin "alsa_controller"...
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/audio_interface/alsa_controller/index.js
Dec 15 15:47:22 so1905-bfc4 sudo[29575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 15 15:47:22 so1905-bfc4 sudo[29575]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:22 so1905-bfc4 sudo[29577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Applying required configuration parameters for plugin alsa_controller
Dec 15 15:47:22 so1905-bfc4 sudo[29575]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:22 so1905-bfc4 sudo[29577]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:22 so1905-bfc4 sudo[29577]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Loading plugin "wizard"...
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/miscellanea/wizard/index.js
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Loading plugin "volumio_command_line_client"...
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/system_controller/volumio_command_line_client/index.js
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: /volumio/app/plugins/system_controller/volumio_command_line_client/getvolumedb.sh.template
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: /volumio/app/plugins/system_controller/volumio_command_line_client/setvolumedb.sh.template
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: /volumio/app/plugins/system_controller/volumio_command_line_client/getvolume.sh.template
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: /volumio/app/plugins/system_controller/volumio_command_line_client/setvolume.sh.template
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Loading plugin "upnp"...
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/audio_interface/upnp/index.js
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: [1765784842975] Starting Upmpd Daemon
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Loading plugin "my_music"...
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/miscellanea/my_music/index.js
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: info: Loading plugin "mpd"...
Dec 15 15:47:22 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/mpd/index.js
Dec 15 15:47:23 so1905-bfc4 volumio[29531]: info: MPD: starting udev watcher for USB partitions
Dec 15 15:47:23 so1905-bfc4 volumio[29531]: info: Creating MPD Configuration file
Dec 15 15:47:23 so1905-bfc4 volumio[29531]: info: Loading plugin "upnp_browser"...
Dec 15 15:47:23 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/upnp_browser/index.js
Dec 15 15:47:23 so1905-bfc4 sudo[29605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 15 15:47:23 so1905-bfc4 sudo[29605]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:23 so1905-bfc4 sudo[29609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 15 15:47:23 so1905-bfc4 sudo[29605]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:23 so1905-bfc4 sudo[29609]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:24 so1905-bfc4 systemd[1]: Stopping Music Player Daemon...
Dec 15 15:47:24 so1905-bfc4 systemd[1]: mpd.service: Succeeded.
Dec 15 15:47:24 so1905-bfc4 systemd[1]: Stopped Music Player Daemon.
Dec 15 15:47:24 so1905-bfc4 systemd[1]: Starting Music Player Daemon...
Dec 15 15:47:24 so1905-bfc4 volumio[29531]: info: Loading plugin "networkfs"...
Dec 15 15:47:24 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/system_controller/networkfs/index.js
Dec 15 15:47:24 so1905-bfc4 volumio[29531]: info: Starting IP address watcher
Dec 15 15:47:24 so1905-bfc4 volumio[29531]: info: Started network interface ip monitor watcher
Dec 15 15:47:24 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 15 15:47:24 so1905-bfc4 volumio[29531]: info: Loading plugin "alarm-clock"...
Dec 15 15:47:24 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/miscellanea/alarm-clock/index.js
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: info: Loading plugin "airplay_emulation"...
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/airplay_emulation/index.js
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: Shairport Sync D-Bus 服务已注册。
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: info: Starting Shairport Sync
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: info: [AirPlay] Started coverart directory watcher
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: info: Loading plugin "last_100"...
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/last_100/index.js
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: info: Loading plugin "spop"...
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/spop/index.js
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: info: Loading plugin "webradio"...
Dec 15 15:47:25 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/webradio/index.js
Dec 15 15:47:27 so1905-bfc4 mpd[29621]: Dec 15 15:47 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 15 15:47:27 so1905-bfc4 mpd[29621]: Dec 15 15:47 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Dec 15 15:47:27 so1905-bfc4 mpd[29621]: Dec 15 15:47 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Dec 15 15:47:27 so1905-bfc4 systemd[1]: Started Music Player Daemon.
Dec 15 15:47:27 so1905-bfc4 sudo[29609]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:28 so1905-bfc4 volumio[29531]: info: Loading plugin "yandex_browser"...
Dec 15 15:47:28 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/yandex_browser/index.js
Dec 15 15:47:28 so1905-bfc4 volumio[29531]: info: Yandex plugin started
Dec 15 15:47:28 so1905-bfc4 volumio[29531]: error: ATTENTION!!!: Plugin yandex_browser does not return adequate promise from onVolumioStart: please update!
Dec 15 15:47:28 so1905-bfc4 volumio[29531]: info: Loading plugin "i2s_dacs"...
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/system_controller/i2s_dacs/index.js
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: I2S DAC not set, start Auto-detection
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Loading plugin "volumiodiscovery"...
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/system_controller/volumiodiscovery/index.js
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 15 15:47:29 so1905-bfc4 node[29531]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: *** WARNING *** For more information see
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: *** WARNING *** For more information see
Dec 15 15:47:29 so1905-bfc4 node[29531]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 15 15:47:29 so1905-bfc4 node[29531]: *** WARNING *** For more information see
Dec 15 15:47:29 so1905-bfc4 node[29531]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Dec 15 15:47:29 so1905-bfc4 node[29531]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 15 15:47:29 so1905-bfc4 node[29531]: *** WARNING *** For more information see
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Applying required configuration parameters for plugin volumiodiscovery
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Discovery: Started advertising with name: SO1905-bfc4
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Loading plugin "outputs"...
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/audio_interface/outputs/index.js
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Loading plugin "albumart"...
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/miscellanea/albumart/index.js
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Plugin example_plugin is not enabled
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Loading plugin "inputs"...
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/inputs/index.js
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Loading plugin "pandora"...
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/pandora/index.js
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Applying required configuration parameters for plugin pandora
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Loading plugin "podcast"...
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/podcast/index.js
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: ControllerPodcast::constructor
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: info: Loading plugin "qobuz"...
Dec 15 15:47:29 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/qobuz/index.js
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: error: ATTENTION!!!: Plugin qobuz does not return adequate promise from onVolumioStart: please update!
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Loading plugin "tidal"...
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/music_service/tidal/index.js
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850192] ControllerTidalPlugin::constructor
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850194] ControllerTidalPlugin::onVolumioStart
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Plugin volspotconnect2 is not enabled
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Loading plugin "updater_comm"...
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/system_controller/updater_comm/index.js
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Plugin mpdemulation is not enabled
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Loading plugin "rest_api"...
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/user_interface/rest_api/index.js
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Loading plugin "websocket"...
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: [ require ] /volumio/app/plugins/user_interface/websocket/index.js
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: ___________ START PLUGINS ___________
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850532] CoreMusicLibrary::Adding element Media Servers
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: SSDP Client initialized.
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: Starting initial SSDP search...
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: Discovering on interface: lo
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: Discovering on interface: wlan0
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850692] CoreMusicLibrary::Adding element Last_100
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Creating Spotify config file
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850727] CoreMusicLibrary::Adding element Webradio
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Yandex plugin started
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850752] ControllerYandexPlugin::addToBrowseSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850753] CoreMusicLibrary::Adding element Yandex Music
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: error: Plugin yandex_browser does not return adequate promise from onStart: please update!
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850770] CoreMusicLibrary::Adding element Pandora
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850777] ControllerPandora::initializeMQTT
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850779] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850796] CoreMusicLibrary::Adding element Podcast
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850804] CoreMusicLibrary::Adding element Qobuz
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850818] ControllerTidalPlugin::onStart
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850826] ControllerTidalPlugin::addToBrowseSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: [1765784850828] CoreMusicLibrary::Adding element Tidal
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: Loading i18n strings for locale en
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: Updating browse sources language
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: Cannot find translation for sourceMedia Servers
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: Cannot find translation for sourceYandex Music
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: Cannot find translation for sourcePodcast
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::initPlayerControls
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:30 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: info: BOOT COMPLETED
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: [Metrics] CommandRouter: 11s 156.35ms
Dec 15 15:47:31 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 15 15:47:31 so1905-bfc4 kernel: sunxi-spdif 2036000.spdif: active: 1
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::Close All Modals sent
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::Close All Modals sent
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: Express server listening on port 3000
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: [Metrics] WebUI: 17s 300.43ms
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: (node:29531) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead.
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: info: [1765784856652] ControllerPandora::validateAndSetAccountOptions
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: error: [1765784856655] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings.
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: info: CoreStateMachine::resetVolumioState
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: info: CoreStateMachine::getcurrentVolume
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioRetrievevolume
Dec 15 15:47:36 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 15 15:47:37 so1905-bfc4 sudo[29667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 15 15:47:37 so1905-bfc4 sudo[29667]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:37 so1905-bfc4 sudo[29667]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:37 so1905-bfc4 volumio[29531]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Dec 15 15:47:37 so1905-bfc4 sudo[29671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 15 15:47:37 so1905-bfc4 sudo[29671]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:37 so1905-bfc4 sudo[29671]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:37 so1905-bfc4 volumio[29531]: info: IP address changed from "" to "192.168.2.118"
Dec 15 15:47:37 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Dec 15 15:47:37 so1905-bfc4 sudo[29703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 15 15:47:37 so1905-bfc4 sudo[29698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 15 15:47:37 so1905-bfc4 sudo[29692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 15 15:47:37 so1905-bfc4 sudo[29703]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:37 so1905-bfc4 sudo[29692]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:37 so1905-bfc4 sudo[29698]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:37 so1905-bfc4 sudo[29698]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:37 so1905-bfc4 sudo[29692]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:37 so1905-bfc4 volumio[29531]: info: Connecting to wireless device: undefined
Dec 15 15:47:37 so1905-bfc4 sudo[29703]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:37 so1905-bfc4 sudo[29721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 15 15:47:37 so1905-bfc4 volumio[29531]: info: this.stateMachine.currentVolume: null, vol: 0
Dec 15 15:47:37 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:37 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:37 so1905-bfc4 volumio[29531]: info: [AirPlay] Received volume update: {"vol":0,"mute":false,"disableVolumeControl":false}
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: CoreStateMachine::pushState
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 15:47:38 so1905-bfc4 sudo[29721]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: CoreStateMachine::updateTrackBlock
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: CorePlayQueue::getTrackBlock
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioRetrievevolume
Dec 15 15:47:38 so1905-bfc4 sudo[29732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 15 15:47:38 so1905-bfc4 sudo[29721]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:38 so1905-bfc4 sudo[29732]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:38 so1905-bfc4 sudo[29732]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: MPD Permissions set
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 15 15:47:38 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: [pushCmd] {"index":5,"getInfo":0}
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode
Dec 15 15:47:39 so1905-bfc4 volumio[29757]: Forking 1 albumart workers
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: [pushCmd] {"index":5,"getInfo":0}
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: [pushCmd] {"index":5,"getInfo":0}
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: [pushCmd] {"index":5,"getInfo":0}
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: MPD running with PID29621
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: ,establishing connection
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: sudo: /usr/sbin/i2cdetect: command not found
Dec 15 15:47:39 so1905-bfc4 volumio[29531]: info: Spotify config file written
Dec 15 15:47:40 so1905-bfc4 sudo[29795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart go-librespot-daemon.service
Dec 15 15:47:40 so1905-bfc4 sudo[29795]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:40 so1905-bfc4 systemd[1]: Stopping go-librespot Daemon...
Dec 15 15:47:40 so1905-bfc4 systemd[1]: go-librespot-daemon.service: Succeeded.
Dec 15 15:47:40 so1905-bfc4 systemd[1]: Stopped go-librespot Daemon.
Dec 15 15:47:40 so1905-bfc4 systemd[1]: Started go-librespot Daemon.
Dec 15 15:47:40 so1905-bfc4 sudo[29795]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:40 so1905-bfc4 go-librespot[29802]: go-librespot daemon starting...
Dec 15 15:47:40 so1905-bfc4 volumio[29531]: sendCommand: Command { name: 'playlistinfo', args: [] }
Dec 15 15:47:40 so1905-bfc4 volumio[29531]: error: MPD error: false == true
Dec 15 15:47:40 so1905-bfc4 volumio[29531]: error: false == true
Dec 15 15:47:40 so1905-bfc4 volumio[29531]: sendCommand: Command { name: 'search album ""', args: [] }
Dec 15 15:47:40 so1905-bfc4 volumio[29531]: error: MPD error: false == true
Dec 15 15:47:40 so1905-bfc4 volumio[29531]: error: false == true
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: [pushCmd] {"index":5,"getInfo":0}
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: [pushCmd] {"index":5,"getInfo":0}
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 15 15:47:41 so1905-bfc4 go-librespot[29822]: time="2025-12-15T15:47:41+08:00" level=info msg="running go-librespot 0.0.0"
Dec 15 15:47:41 so1905-bfc4 go-librespot[29822]: time="2025-12-15T15:47:41+08:00" level=debug msg="app state loaded"
Dec 15 15:47:41 so1905-bfc4 go-librespot[29822]: time="2025-12-15T15:47:41+08:00" level=debug msg="stored credentials not found"
Dec 15 15:47:41 so1905-bfc4 go-librespot[29822]: time="2025-12-15T15:47:41+08:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: info: No need to fix Spotify hosts
Dec 15 15:47:41 so1905-bfc4 volumio[29782]: Starting albumart workers
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: sendCommand: Command { name: 'playlistinfo', args: [] }
Dec 15 15:47:41 so1905-bfc4 volumio[29531]: sendCommand: Command { name: 'lsinfo "USB"', args: [] }
Dec 15 15:47:42 so1905-bfc4 display[29532]: setImageSrc: this=0x23d1a20, str=/volumio/display/assets/status-icon/wifi_ok.png
Dec 15 15:47:42 so1905-bfc4 display[29532]: read file /volumio/display/assets/status-icon/wifi_ok.png, size=861, buffer[0]=89
Dec 15 15:47:42 so1905-bfc4 go-librespot[29822]: time="2025-12-15T15:47:42+08:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Dec 15 15:47:42 so1905-bfc4 go-librespot[29822]: time="2025-12-15T15:47:42+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Dec 15 15:47:42 so1905-bfc4 go-librespot[29822]: time="2025-12-15T15:47:42+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Dec 15 15:47:42 so1905-bfc4 go-librespot[29822]: time="2025-12-15T15:47:42+08:00" level=info msg="zeroconf server listening on port 39489"
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: CoreStateMachine::setRepeat null single undefined
Dec 15 15:47:42 so1905-bfc4 go-librespot[29822]: 2025/12/15 15:47:42 [zeroconf] no suitable IPv6 interface: listen udp6 [ff02::]:5353: socket: address family not supported by protocol
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: CoreStateMachine::pushState
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: CoreStateMachine::setRandom null
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: CoreStateMachine::pushState
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 15:47:42 so1905-bfc4 display[29532]: setImageSrc: this=0x23d1850, str=http://127.0.0.1:3000/albumart
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: Received Get System Version
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 15 15:47:42 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Dec 15 15:47:43 so1905-bfc4 sudo[29845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 15 15:47:43 so1905-bfc4 sudo[29853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 15 15:47:43 so1905-bfc4 sudo[29845]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 15 15:47:43 so1905-bfc4 sudo[29853]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: CoreCommandRouter::volumioGetQueue
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: CoreStateMachine::getQueue
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: CorePlayQueue::getQueue
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]}
Dec 15 15:47:43 so1905-bfc4 sudo[29866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]}
Dec 15 15:47:43 so1905-bfc4 sudo[29845]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]}
Dec 15 15:47:43 so1905-bfc4 sudo[29853]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]}
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]}
Dec 15 15:47:43 so1905-bfc4 sudo[29858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 15 15:47:43 so1905-bfc4 sudo[29875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 15 15:47:43 so1905-bfc4 sudo[29866]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]}
Dec 15 15:47:43 so1905-bfc4 volumio[29531]: info: [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]}
Dec 15 15:47:43 so1905-bfc4 sudo[29858]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:43 so1905-bfc4 sudo[29875]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 15:47:43 so1905-bfc4 sudo[29866]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:43 so1905-bfc4 sudo[29875]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:43 so1905-bfc4 sudo[29858]: pam_unix(sudo:session): session closed for user root
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: error: updateQueue error: null
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: { Error: ENOENT: no such file or directory, stat 'USB/udisk'
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at Object.statSync (fs.js:855:3)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at eval (webpack://Volumio2/./app/plugins/music_service/mpd/index.js?:1583:23)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at MpdClient.handleMessage (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:77:3)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at MpdClient.receive (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:68:12)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at Socket.eval (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:43:12)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at Socket.emit (events.js:198:13)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at addChunk (_stream_readable.js:288:12)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at readableAddChunk (_stream_readable.js:265:13)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at Socket.Readable.push (_stream_readable.js:224:10)
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: at Pipe.onStreamRead [as onread] (internal/stream_base_commons.js:94:17) errno: -2, syscall: 'stat', code: 'ENOENT', path: 'USB/udisk' }
Dec 15 15:47:44 so1905-bfc4 volumio[29531]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 15 15:47:45 so1905-bfc4 sudo[29923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-15 15:46
Dec 15 15:47:45 so1905-bfc4 sudo[29923]: 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