-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Wed 2026-01-28 11:05:29 CST. -- Jan 28 11:04:00 so1905-ff03 node[2403]: Remote version data: { serverVersion: '1.5.7.40', Jan 28 11:04:00 so1905-ff03 node[2403]: serverUrl: Jan 28 11:04:00 so1905-ff03 node[2403]: 'https://ota.synaudio.org/server/1905/volumio_1.5.7.40.tar.gz', Jan 28 11:04:00 so1905-ff03 node[2403]: md5: '76a08f0996a75f1578c3e5472fc4c298' } Jan 28 11:04:00 so1905-ff03 node[2403]: No update required. Jan 28 11:04:01 so1905-ff03 volumio[2404]: info: ------------------------------------------- Jan 28 11:04:01 so1905-ff03 volumio[2404]: info: ----- Synaudio ---- Jan 28 11:04:01 so1905-ff03 volumio[2404]: info: ------------------------------------------- Jan 28 11:04:01 so1905-ff03 volumio[2404]: info: ----- System startup ---- Jan 28 11:04:01 so1905-ff03 volumio[2404]: info: ------------------------------------------- Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Found new core plugin music_service/cdplayer. Adding it Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Configured plugin music_service/cdplayer cannot be loaded. Removing from configuration Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Plugin folders cleanup Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Scanning into folder /volumio/app/plugins/ Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Scanning category audio_interface Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Scanning category miscellanea Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Scanning category music_service Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Scanning category plugins.json Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Scanning category system_controller Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Scanning category user_interface Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Scanning into folder /data/plugins/ Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Plugin folders cleanup completed Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: ------------------------------------------- Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: ----- Core plugins startup ---- Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: ------------------------------------------- Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Loading plugins from folder /volumio/app/plugins/ Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Adding plugin upnp to MyMusic Plugins Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Loading plugins from folder /data/plugins/ Jan 28 11:04:02 so1905-ff03 volumio[2404]: info: Loading plugin "system"... Jan 28 11:04:03 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/system_controller/system/index.js Jan 28 11:04:03 so1905-ff03 volumio[2404]: info: Loading plugin "appearance"... Jan 28 11:04:03 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/miscellanea/appearance/index.js Jan 28 11:04:03 so1905-ff03 display[2171]: setImageSrc: this=0x39ea1f0, str=/volumio/display/assets/source-icon/bt.png Jan 28 11:04:03 so1905-ff03 display[2171]: read file /volumio/display/assets/source-icon/bt.png, size=11779, buffer[0]=89 Jan 28 11:04:03 so1905-ff03 display[2171]: setImageSrc: this=0x38f6650, str=/volumio/display/assets/albumart.jpg Jan 28 11:04:03 so1905-ff03 display[2171]: read file /volumio/display/assets/albumart.jpg, size=77672, buffer[0]=ff Jan 28 11:04:03 so1905-ff03 display[2171]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF Jan 28 11:04:03 so1905-ff03 display[2171]: Attempting to process with stb_image... Jan 28 11:04:03 so1905-ff03 display[2171]: stb_image successfully loaded: 855x855, channels=3 Jan 28 11:04:03 so1905-ff03 display[2171]: Successfully processed with stb_image Jan 28 11:04:03 so1905-ff03 display[2171]: Loading default image: /volumio/display/assets/albumart.jpg Jan 28 11:04:03 so1905-ff03 display[2171]: Loaded default image from file: /volumio/display/assets/albumart.jpg, size=77672 Jan 28 11:04:03 so1905-ff03 display[2171]: GetJPGDesc: Processing JPEG file, size=77672, buffer[0]=0xFF Jan 28 11:04:03 so1905-ff03 display[2171]: Attempting to process with stb_image... Jan 28 11:04:03 so1905-ff03 sshd[2462]: rexec line 6: Deprecated option UsePrivilegeSeparation Jan 28 11:04:03 so1905-ff03 sshd[2462]: rexec line 7: Deprecated option KeyRegenerationInterval Jan 28 11:04:03 so1905-ff03 sshd[2462]: rexec line 8: Deprecated option ServerKeyBits Jan 28 11:04:03 so1905-ff03 sshd[2462]: rexec line 14: Deprecated option RSAAuthentication Jan 28 11:04:03 so1905-ff03 sshd[2462]: rexec line 17: Deprecated option RhostsRSAAuthentication Jan 28 11:04:03 so1905-ff03 display[2171]: stb_image successfully loaded: 855x855, channels=3 Jan 28 11:04:03 so1905-ff03 display[2171]: Successfully processed with stb_image Jan 28 11:04:03 so1905-ff03 display[2171]: Default image loaded successfully Jan 28 11:04:04 so1905-ff03 display[2171]: setImageSrc: this=0x38f6800, str=/volumio/display/assets/status-icon/wifi-error.png Jan 28 11:04:04 so1905-ff03 display[2171]: read file /volumio/display/assets/status-icon/wifi-error.png, size=1494, buffer[0]=89 Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: Loading plugin "network"... Jan 28 11:04:04 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/system_controller/network/index.js Jan 28 11:04:04 so1905-ff03 display[2171]: setImageSrc: this=0x38f6988, str=/volumio/display/assets/status-icon/eth-error.png Jan 28 11:04:04 so1905-ff03 display[2171]: read file /volumio/display/assets/status-icon/eth-error.png, size=936, buffer[0]=89 Jan 28 11:04:04 so1905-ff03 sshd[2462]: reprocess config line 14: Deprecated option RSAAuthentication Jan 28 11:04:04 so1905-ff03 sshd[2462]: reprocess config line 17: Deprecated option RhostsRSAAuthentication Jan 28 11:04:04 so1905-ff03 display[2171]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Jan 28 11:04:04 so1905-ff03 display[2171]: 文件大小: 6344 字节 Jan 28 11:04:04 so1905-ff03 display[2171]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 40px) Jan 28 11:04:04 so1905-ff03 volumio[2404]: [network] Refreshing Cached IP Addresses Jan 28 11:04:04 so1905-ff03 display[2171]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf Jan 28 11:04:04 so1905-ff03 display[2171]: 文件大小: 11495876 字节 Jan 28 11:04:04 so1905-ff03 display[2171]: FreeType字体加载成功: /volumio/display/fonts/AlibabaPuHuiTi-3-45-Light.ttf (大小: 40px) Jan 28 11:04:04 so1905-ff03 sudo[2466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:04:04 so1905-ff03 display[2171]: setInnerAlign: image_desc is null Jan 28 11:04:04 so1905-ff03 sudo[2466]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:04 so1905-ff03 sudo[2466]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:04 so1905-ff03 volumio[2404]: ControllerNetwork autoStartNetworkConfig true Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: Loading plugin "services"... Jan 28 11:04:04 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/system_controller/services/index.js Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: Loading plugin "alsa_controller"... Jan 28 11:04:04 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/audio_interface/alsa_controller/index.js Jan 28 11:04:04 so1905-ff03 sudo[2474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: Applying required configuration parameters for plugin alsa_controller Jan 28 11:04:04 so1905-ff03 sudo[2474]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:04 so1905-ff03 sudo[2474]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:04 so1905-ff03 display[2171]: setImageSrc: this=0x39f0340, str=/volumio/display/assets/source-icon/streaming.png Jan 28 11:04:04 so1905-ff03 display[2171]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Jan 28 11:04:04 so1905-ff03 volumio[2404]: [alsa_controller] Creating shared var alsa.outputdevice='2' Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: Loading plugin "wizard"... Jan 28 11:04:04 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/miscellanea/wizard/index.js Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: Loading plugin "volumio_command_line_client"... Jan 28 11:04:04 so1905-ff03 display[2171]: setImageSrc: this=0x3a071e0, str=/volumio/display/assets/source-icon/streaming.png Jan 28 11:04:04 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/system_controller/volumio_command_line_client/index.js Jan 28 11:04:04 so1905-ff03 display[2171]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Jan 28 11:04:04 so1905-ff03 volumio[2404]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/getvolumedb.sh.template Jan 28 11:04:04 so1905-ff03 sshd[2462]: Accepted password for volumio from 192.168.23.148 port 59159 ssh2 Jan 28 11:04:04 so1905-ff03 volumio[2404]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/setvolumedb.sh.template Jan 28 11:04:04 so1905-ff03 volumio[2404]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/getvolume.sh.template Jan 28 11:04:04 so1905-ff03 volumio[2404]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/setvolume.sh.template Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:04 so1905-ff03 sshd[2462]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Jan 28 11:04:04 so1905-ff03 display[2171]: FreeType字体文件存在, 开始加载: /volumio/display/fonts/iconfont.ttf Jan 28 11:04:04 so1905-ff03 display[2171]: 文件大小: 6344 字节 Jan 28 11:04:04 so1905-ff03 display[2171]: FreeType字体加载成功: /volumio/display/fonts/iconfont.ttf (大小: 100px) Jan 28 11:04:04 so1905-ff03 systemd-logind[2169]: New session c2 of user volumio. Jan 28 11:04:04 so1905-ff03 systemd[1]: Started Session c2 of user volumio. Jan 28 11:04:04 so1905-ff03 display[2171]: setImageSrc: this=0x3a07f30, str=/volumio/display/assets/source-icon/streaming.png Jan 28 11:04:04 so1905-ff03 display[2171]: read file /volumio/display/assets/source-icon/streaming.png, size=12136, buffer[0]=89 Jan 28 11:04:04 so1905-ff03 sshd[2498]: rexec line 6: Deprecated option UsePrivilegeSeparation Jan 28 11:04:04 so1905-ff03 sshd[2498]: rexec line 7: Deprecated option KeyRegenerationInterval Jan 28 11:04:04 so1905-ff03 sshd[2498]: rexec line 8: Deprecated option ServerKeyBits Jan 28 11:04:04 so1905-ff03 sshd[2498]: rexec line 14: Deprecated option RSAAuthentication Jan 28 11:04:04 so1905-ff03 sshd[2498]: rexec line 17: Deprecated option RhostsRSAAuthentication Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: Loading plugin "upnp"... Jan 28 11:04:04 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/audio_interface/upnp/index.js Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: [1769569444996] Starting Upmpd Daemon Jan 28 11:04:04 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 11:04:05 so1905-ff03 volumio[2404]: info: Loading plugin "my_music"... Jan 28 11:04:05 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/miscellanea/my_music/index.js Jan 28 11:04:05 so1905-ff03 volumio[2404]: info: Loading plugin "mpd"... Jan 28 11:04:05 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/mpd/index.js Jan 28 11:04:05 so1905-ff03 volumio[2404]: [mpd] MPD: starting udev watcher for USB partitions Jan 28 11:04:05 so1905-ff03 volumio[2404]: [mpd] Creating MPD Configuration file Jan 28 11:04:05 so1905-ff03 sudo[2525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 11:04:05 so1905-ff03 volumio[2404]: info: Loading plugin "upnp_browser"... Jan 28 11:04:05 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/upnp_browser/index.js Jan 28 11:04:05 so1905-ff03 sudo[2525]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:05 so1905-ff03 sudo[2528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 11:04:05 so1905-ff03 sudo[2525]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:05 so1905-ff03 sudo[2528]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:06 so1905-ff03 systemd[1]: Stopping Music Player Daemon... Jan 28 11:04:06 so1905-ff03 systemd[1]: mpd.service: Succeeded. Jan 28 11:04:06 so1905-ff03 systemd[1]: Stopped Music Player Daemon. Jan 28 11:04:06 so1905-ff03 systemd[1]: Starting Music Player Daemon... Jan 28 11:04:06 so1905-ff03 volumio[2404]: info: Loading plugin "networkfs"... Jan 28 11:04:06 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/system_controller/networkfs/index.js Jan 28 11:04:06 so1905-ff03 volumio[2404]: [networkfs] Starting IP address watcher Jan 28 11:04:06 so1905-ff03 volumio[2404]: [networkfs] Started network interface ip monitor watcher Jan 28 11:04:06 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 11:04:06 so1905-ff03 volumio[2404]: info: Loading plugin "alarm-clock"... Jan 28 11:04:06 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/miscellanea/alarm-clock/index.js Jan 28 11:04:07 so1905-ff03 volumio[2404]: info: Loading plugin "airplay_emulation"... Jan 28 11:04:07 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/airplay_emulation/index.js Jan 28 11:04:08 so1905-ff03 volumio[2404]: 执行命令出错: Error: Command failed: /usr/bin/dbus-send --system --dest=org.freedesktop.DBus --type=method_call --print-reply /org/freedesktop/DBus org.freedesktop.DBus.ListNames | grep org.gnome.ShairportSync Jan 28 11:04:08 so1905-ff03 volumio[2404]: [airplay_emulation] Starting Shairport Sync Jan 28 11:04:08 so1905-ff03 volumio[2404]: [airplay_emulation] [AirPlay] Started coverart directory watcher Jan 28 11:04:08 so1905-ff03 volumio[2404]: info: Loading plugin "last_100"... Jan 28 11:04:08 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/last_100/index.js Jan 28 11:04:08 so1905-ff03 volumio[2404]: info: Loading plugin "spop"... Jan 28 11:04:08 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/spop/index.js Jan 28 11:04:08 so1905-ff03 mpd[2541]: Jan 28 11:04 : exception: bind to '/run/mpd/socket' failed (continuing anyway, because binding to '/run/mpd/socket' succeeded): Failed to bind socket: Address already in use Jan 28 11:04:08 so1905-ff03 mpd[2541]: Jan 28 11:04 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 28 11:04:08 so1905-ff03 systemd[1]: Started Music Player Daemon. Jan 28 11:04:08 so1905-ff03 sudo[2528]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:08 so1905-ff03 volumio[2404]: info: Loading plugin "webradio"... Jan 28 11:04:08 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/webradio/index.js Jan 28 11:04:10 so1905-ff03 kernel: usb0-vbus: disabling Jan 28 11:04:10 so1905-ff03 volumio[2404]: info: Loading plugin "yandex_browser"... Jan 28 11:04:10 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/yandex_browser/index.js Jan 28 11:04:11 so1905-ff03 volumio[2404]: [yandex_browser] Yandex plugin started Jan 28 11:04:11 so1905-ff03 volumio[2404]: error: ATTENTION!!!: Plugin yandex_browser does not return adequate promise from onVolumioStart: please update! Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: Loading plugin "i2s_dacs"... Jan 28 11:04:11 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/system_controller/i2s_dacs/index.js Jan 28 11:04:11 so1905-ff03 volumio[2404]: [i2s_dacs] I2S DAC not set, start Auto-detection Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: Loading plugin "volumiodiscovery"... Jan 28 11:04:11 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/system_controller/volumiodiscovery/index.js Jan 28 11:04:11 so1905-ff03 volumio[2404]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 28 11:04:11 so1905-ff03 volumio[2404]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 11:04:11 so1905-ff03 node[2404]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 28 11:04:11 so1905-ff03 volumio[2404]: *** WARNING *** For more information see Jan 28 11:04:11 so1905-ff03 volumio[2404]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 28 11:04:11 so1905-ff03 volumio[2404]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 11:04:11 so1905-ff03 volumio[2404]: *** WARNING *** For more information see Jan 28 11:04:11 so1905-ff03 node[2404]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 11:04:11 so1905-ff03 node[2404]: *** WARNING *** For more information see Jan 28 11:04:11 so1905-ff03 node[2404]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 28 11:04:11 so1905-ff03 node[2404]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 11:04:11 so1905-ff03 node[2404]: *** WARNING *** For more information see Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 28 11:04:11 so1905-ff03 volumio[2404]: [volumiodiscovery] Discovery: Started advertising with name: SO1905-ff03 Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: Loading plugin "outputs"... Jan 28 11:04:11 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/audio_interface/outputs/index.js Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: Loading plugin "albumart"... Jan 28 11:04:11 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/miscellanea/albumart/index.js Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: Plugin example_plugin is not enabled Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: Loading plugin "inputs"... Jan 28 11:04:11 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/inputs/index.js Jan 28 11:04:11 so1905-ff03 volumio[2404]: info: Loading plugin "pandora"... Jan 28 11:04:11 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/pandora/index.js Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Applying required configuration parameters for plugin pandora Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Loading plugin "podcast"... Jan 28 11:04:12 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/podcast/index.js Jan 28 11:04:12 so1905-ff03 volumio[2404]: [podcast] ControllerPodcast::constructor Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Loading plugin "qobuz"... Jan 28 11:04:12 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/qobuz/index.js Jan 28 11:04:12 so1905-ff03 volumio[2404]: error: ATTENTION!!!: Plugin qobuz does not return adequate promise from onVolumioStart: please update! Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Loading plugin "tidal"... Jan 28 11:04:12 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/music_service/tidal/index.js Jan 28 11:04:12 so1905-ff03 volumio[2404]: [tidal] [1769569452597] ControllerTidalPlugin::constructor Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: [1769569452599] ControllerTidalPlugin::onVolumioStart Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Plugin volspotconnect2 is not enabled Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Loading plugin "updater_comm"... Jan 28 11:04:12 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/system_controller/updater_comm/index.js Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Plugin mpdemulation is not enabled Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Loading plugin "rest_api"... Jan 28 11:04:12 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/user_interface/rest_api/index.js Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: Loading plugin "websocket"... Jan 28 11:04:12 so1905-ff03 volumio[2404]: [ require ] /volumio/app/plugins/user_interface/websocket/index.js Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: ___________ START PLUGINS ___________ Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: [1769569452920] CoreMusicLibrary::Adding element Media Servers Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:12 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:12 so1905-ff03 volumio[2404]: SSDP Client initialized. Jan 28 11:04:12 so1905-ff03 volumio[2404]: Starting initial SSDP search... Jan 28 11:04:12 so1905-ff03 volumio[2404]: Discovering on interface: lo Jan 28 11:04:12 so1905-ff03 volumio[2404]: Discovering on interface: eth0 Jan 28 11:04:12 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: [airplay_emulation] Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453080] CoreMusicLibrary::Adding element Last_100 Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:13 so1905-ff03 volumio[2404]: [spop] Creating Spotify config file Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453138] CoreMusicLibrary::Adding element Webradio Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 11:04:13 so1905-ff03 volumio[2404]: [yandex_browser] Yandex plugin started Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453163] ControllerYandexPlugin::addToBrowseSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453165] CoreMusicLibrary::Adding element Yandex Music Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:printToastMessage Jan 28 11:04:13 so1905-ff03 volumio[2404]: error: Plugin yandex_browser does not return adequate promise from onStart: please update! Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453190] CoreMusicLibrary::Adding element Pandora Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:13 so1905-ff03 volumio[2404]: [pandora] [1769569453198] ControllerPandora::initializeMQTT Jan 28 11:04:13 so1905-ff03 volumio[2404]: [pandora] [1769569453199] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453217] CoreMusicLibrary::Adding element Podcast Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453230] CoreMusicLibrary::Adding element Qobuz Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453249] ControllerTidalPlugin::onStart Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453260] ControllerTidalPlugin::addToBrowseSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: [1769569453262] CoreMusicLibrary::Adding element Tidal Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] Loading session from /data/configuration/music_service/tidal/tidal-session-oauth.json... Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] { token_type: { data: 'Bearer' }, Jan 28 11:04:13 so1905-ff03 volumio[2404]: session_id: { data: 'f6e9e73d-b968-42fa-bf37-a37b016f547e' }, Jan 28 11:04:13 so1905-ff03 volumio[2404]: access_token: Jan 28 11:04:13 so1905-ff03 volumio[2404]: { data: Jan 28 11:04:13 so1905-ff03 volumio[2404]: 'eyJraWQiOiJ2OU1GbFhqWSIsImFsZyI6IkVTMjU2In0.eyJ0eXBlIjoibzJfYWNjZXNzIiwidWlkIjoyMDY5ODkyNzQsInNjb3BlIjoid191c3Igcl91c3Igd19zdWIiLCJnVmVyIjowLCJzVmVyIjowLCJjaWQiOjEzMzE5LCJjYyI6IlVTIiwiYXQiOiJJTlRFUk5BTCIsImV4cCI6MTc2OTU4MjYzMSwic2lkIjoiZjZlOWU3M2QtYjk2OC00MmZhLWJmMzctYTM3YjAxNmY1NDdlIiwiaXNzIjoiaHR0cHM6Ly9hdXRoLnRpZGFsLmNvbS92MSJ9.4wpoEqr4WIL6wihhlC2V3KeyO6HY2ZAmNjnHmYKElPhq2HcoDOoBXXZaJ5IShyXCCUnHeOQDj5UfWeOO6vyOSA' }, Jan 28 11:04:13 so1905-ff03 volumio[2404]: refresh_token: Jan 28 11:04:13 so1905-ff03 volumio[2404]: { data: Jan 28 11:04:13 so1905-ff03 volumio[2404]: 'eyJraWQiOiJoUzFKYTdVMCIsImFsZyI6IkVTNTEyIn0.eyJ0eXBlIjoibzJfcmVmcmVzaCIsInVpZCI6MjA2OTg5Mjc0LCJzY29wZSI6Indfc3ViIHJfdXNyIHdfdXNyIiwiY2lkIjoxMzMxOSwic1ZlciI6MCwiZ1ZlciI6MCwiaXNzIjoiaHR0cHM6Ly9hdXRoLnRpZGFsLmNvbS92MSJ9.AfV48j5NB7w4txd9VqRDfGPrfD1wVbWPBlL3HRQ6itL16SIWqP6Na1LErZRpGeC8oYmltj_eKk0hv1E7Jhw85FauAKyZVXZRAf9JdIskiKa8ghZKIjo2Wx6-KAXPyrzRmdfk1lk-VIX9TkMskM9QbRQIDvQPUl3cYCFh5dnPkTA3DWjm' }, Jan 28 11:04:13 so1905-ff03 volumio[2404]: is_pkce: { data: false }, Jan 28 11:04:13 so1905-ff03 volumio[2404]: expiry_time: { data: 1769582632006 } } Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] Bearer eyJraWQiOiJ2OU1GbFhqWSIsImFsZyI6IkVTMjU2In0.eyJ0eXBlIjoibzJfYWNjZXNzIiwidWlkIjoyMDY5ODkyNzQsInNjb3BlIjoid191c3Igcl91c3Igd19zdWIiLCJnVmVyIjowLCJzVmVyIjowLCJjaWQiOjEzMzE5LCJjYyI6IlVTIiwiYXQiOiJJTlRFUk5BTCIsImV4cCI6MTc2OTU4MjYzMSwic2lkIjoiZjZlOWU3M2QtYjk2OC00MmZhLWJmMzctYTM3YjAxNmY1NDdlIiwiaXNzIjoiaHR0cHM6Ly9hdXRoLnRpZGFsLmNvbS92MSJ9.4wpoEqr4WIL6wihhlC2V3KeyO6HY2ZAmNjnHmYKElPhq2HcoDOoBXXZaJ5IShyXCCUnHeOQDj5UfWeOO6vyOSA Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] ===================== params ============== Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] uri https://api.tidal.com/v1/sessions?limit=1000 Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] method GET Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] params {"limit":1000} Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] data {} Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] headers {"User-Agent":"Mozilla/5.0 (Linux; Android 12; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/91.0.4472.114 Safari/537.36","authorization":"Bearer eyJraWQiOiJ2OU1GbFhqWSIsImFsZyI6IkVTMjU2In0.eyJ0eXBlIjoibzJfYWNjZXNzIiwidWlkIjoyMDY5ODkyNzQsInNjb3BlIjoid191c3Igcl91c3Igd19zdWIiLCJnVmVyIjowLCJzVmVyIjowLCJjaWQiOjEzMzE5LCJjYyI6IlVTIiwiYXQiOiJJTlRFUk5BTCIsImV4cCI6MTc2OTU4MjYzMSwic2lkIjoiZjZlOWU3M2QtYjk2OC00MmZhLWJmMzctYTM3YjAxNmY1NDdlIiwiaXNzIjoiaHR0cHM6Ly9hdXRoLnRpZGFsLmNvbS92MSJ9.4wpoEqr4WIL6wihhlC2V3KeyO6HY2ZAmNjnHmYKElPhq2HcoDOoBXXZaJ5IShyXCCUnHeOQDj5UfWeOO6vyOSA"} Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Tidal] ===================== end params ============== Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: Loading i18n strings for locale en Jan 28 11:04:13 so1905-ff03 volumio[2404]: Updating browse sources language Jan 28 11:04:13 so1905-ff03 volumio[2404]: Cannot find translation for sourceMedia Servers Jan 28 11:04:13 so1905-ff03 volumio[2404]: Cannot find translation for sourceYandex Music Jan 28 11:04:13 so1905-ff03 volumio[2404]: Cannot find translation for sourcePodcast Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:04:13 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::initPlayerControls Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: BOOT COMPLETED Jan 28 11:04:13 so1905-ff03 volumio[2404]: [Metrics] CommandRouter: 12s 155.96ms Jan 28 11:04:13 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 11:04:13 so1905-ff03 kernel: sunxi-spdif 2036000.spdif: active: 1 Jan 28 11:04:18 so1905-ff03 volumio[2404]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 28 11:04:18 so1905-ff03 volumio[2404]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:04:18 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:18 so1905-ff03 volumio[2404]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:04:18 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:18 so1905-ff03 volumio[2404]: Express server listening on port 3000 Jan 28 11:04:18 so1905-ff03 volumio[2404]: [Metrics] WebUI: 18s 364.55ms Jan 28 11:04:18 so1905-ff03 volumio[2404]: (node:2404) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jan 28 11:04:19 so1905-ff03 volumio[2404]: [pandora] [1769569459095] ControllerPandora::validateAndSetAccountOptions Jan 28 11:04:19 so1905-ff03 volumio[2404]: [pandora] [1769569459097] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Jan 28 11:04:19 so1905-ff03 volumio[2404]: info: CoreStateMachine::resetVolumioState Jan 28 11:04:19 so1905-ff03 volumio[2404]: info: CoreStateMachine::getcurrentVolume Jan 28 11:04:19 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 11:04:19 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 11:04:19 so1905-ff03 sudo[2580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:04:19 so1905-ff03 sudo[2580]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:19 so1905-ff03 sudo[2580]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:19 so1905-ff03 sudo[2582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:04:19 so1905-ff03 sudo[2582]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:19 so1905-ff03 volumio[2404]: [i2s_dacs] Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 28 11:04:19 so1905-ff03 sudo[2582]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:19 so1905-ff03 volumio[2404]: [networkfs] IP address changed from "" to "192.168.23.164" Jan 28 11:04:19 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jan 28 11:04:20 so1905-ff03 sudo[2608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:04:20 so1905-ff03 sudo[2608]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:20 so1905-ff03 sudo[2616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:04:20 so1905-ff03 sudo[2608]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:20 so1905-ff03 sudo[2625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:04:20 so1905-ff03 sudo[2616]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:20 so1905-ff03 volumio[2404]: [networkfs] Connecting to wireless device: undefined Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: this.stateMachine.currentVolume: null, vol: 0 Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:20 so1905-ff03 volumio[2404]: [airplay_emulation] [AirPlay] Received volume update: {"vol":0,"mute":false,"disableVolumeControl":false} Jan 28 11:04:20 so1905-ff03 sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:04:20 so1905-ff03 volumio[2404]: [airplay_emulation] Sending DBus command: /usr/bin/dbus-send --system --print-reply --dest=org.gnome.ShairportSync "/org/gnome/ShairportSync" org.gnome.ShairportSync.RemoteControl.SetAirplayVolume double:-30.00 Jan 28 11:04:20 so1905-ff03 sudo[2625]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:20 so1905-ff03 sudo[2648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:04:20 so1905-ff03 sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CoreStateMachine::pushState Jan 28 11:04:20 so1905-ff03 sudo[2648]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:20 so1905-ff03 sudo[2616]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 11:04:20 so1905-ff03 sudo[2637]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:20 so1905-ff03 sudo[2625]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:20 so1905-ff03 volumio[2404]: [rest_api] API:pushState Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CoreStateMachine::updateTrackBlock Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CorePlayQueue::getTrackBlock Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 11:04:20 so1905-ff03 sudo[2648]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:20 so1905-ff03 volumio[2404]: [mpd] MPD Permissions set Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 28 11:04:20 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 28 11:04:21 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 28 11:04:21 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 28 11:04:21 so1905-ff03 volumio[2404]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 28 11:04:21 so1905-ff03 volumio[2404]: [mpd] MPD running with PID2541 Jan 28 11:04:21 so1905-ff03 volumio[2404]: ,establishing connection Jan 28 11:04:21 so1905-ff03 volumio[2404]: [i2s_dacs] Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jan 28 11:04:21 so1905-ff03 volumio[2404]: sudo: /usr/sbin/i2cdetect: command not found Jan 28 11:04:21 so1905-ff03 volumio[2404]: [airplay_emulation] DBus command failed: Command failed: /usr/bin/dbus-send --system --print-reply --dest=org.gnome.ShairportSync "/org/gnome/ShairportSync" org.gnome.ShairportSync.RemoteControl.SetAirplayVolume double:-30.00 Jan 28 11:04:21 so1905-ff03 volumio[2404]: Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files Jan 28 11:04:21 so1905-ff03 volumio[2404]: { stdout: '', Jan 28 11:04:21 so1905-ff03 volumio[2404]: stderr: Jan 28 11:04:21 so1905-ff03 volumio[2404]: 'Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files\n' } Jan 28 11:04:21 so1905-ff03 volumio[2404]: [rest_api] API:emitFavourites Jan 28 11:04:21 so1905-ff03 volumio[2404]: [spop] Spotify config file written Jan 28 11:04:21 so1905-ff03 sudo[2710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart go-librespot-daemon.service Jan 28 11:04:21 so1905-ff03 sudo[2710]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:21 so1905-ff03 systemd[1]: Started go-librespot Daemon. Jan 28 11:04:21 so1905-ff03 sudo[2710]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:21 so1905-ff03 go-librespot[2716]: go-librespot daemon starting... Jan 28 11:04:22 so1905-ff03 volumio[2404]: sendCommand: Command { name: 'playlistinfo', args: [] } Jan 28 11:04:22 so1905-ff03 volumio[2404]: [mpd] MPD error: false == true Jan 28 11:04:22 so1905-ff03 volumio[2404]: [mpd] false == true Jan 28 11:04:22 so1905-ff03 volumio[2404]: sendCommand: Command { name: 'search album ""', args: [] } Jan 28 11:04:22 so1905-ff03 volumio[2404]: [mpd] MPD error: false == true Jan 28 11:04:22 so1905-ff03 volumio[2404]: [mpd] false == true Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 28 11:04:22 so1905-ff03 volumio[2404]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 28 11:04:22 so1905-ff03 volumio[2404]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 28 11:04:22 so1905-ff03 volumio[2404]: [spop] No need to fix Spotify hosts Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:22 so1905-ff03 volumio[2692]: Forking 1 albumart workers Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 11:04:22 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:04:22 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:22+08:00" level=info msg="running go-librespot 0.0.0" Jan 28 11:04:22 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:22+08:00" level=debug msg="app state loaded" Jan 28 11:04:22 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:22+08:00" level=debug msg="stored credentials not found" Jan 28 11:04:23 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:23+08:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 28 11:04:23 so1905-ff03 volumio[2404]: sendCommand: Command { name: 'playlistinfo', args: [] } Jan 28 11:04:23 so1905-ff03 volumio[2404]: sendCommand: Command { name: 'lsinfo "USB"', args: [] } Jan 28 11:04:23 so1905-ff03 display[2171]: setImageSrc: this=0x38f6988, str=/volumio/display/assets/status-icon/eth_ok.png Jan 28 11:04:23 so1905-ff03 display[2171]: read file /volumio/display/assets/status-icon/eth_ok.png, size=990, buffer[0]=89 Jan 28 11:04:23 so1905-ff03 volumio[2404]: info: CoreStateMachine::setRepeat false single undefined Jan 28 11:04:23 so1905-ff03 volumio[2404]: info: CoreStateMachine::pushState Jan 28 11:04:23 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 11:04:23 so1905-ff03 volumio[2404]: [rest_api] API:pushState Jan 28 11:04:23 so1905-ff03 volumio[2404]: info: CoreStateMachine::setRandom false Jan 28 11:04:23 so1905-ff03 volumio[2404]: info: CoreStateMachine::pushState Jan 28 11:04:23 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 11:04:23 so1905-ff03 volumio[2404]: [rest_api] API:pushState Jan 28 11:04:23 so1905-ff03 volumio[2404]: [mpd] updateQueue error: null Jan 28 11:04:24 so1905-ff03 display[2171]: setImageSrc: this=0x38f6650, str=http://127.0.0.1:3000/albumart Jan 28 11:04:24 so1905-ff03 volumio[2404]: [websocket] Received Get System Version Jan 28 11:04:24 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 11:04:24 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jan 28 11:04:24 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:24+08:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Jan 28 11:04:24 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:24+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jan 28 11:04:24 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:24+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jan 28 11:04:24 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:24+08:00" level=info msg="zeroconf server listening on port 33921" Jan 28 11:04:24 so1905-ff03 go-librespot[2737]: 2026/01/28 11:04:24 [zeroconf] no suitable IPv6 interface: listen udp6 [ff02::]:5353: socket: address family not supported by protocol Jan 28 11:04:24 so1905-ff03 sudo[2758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:04:24 so1905-ff03 sudo[2766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:04:24 so1905-ff03 sudo[2758]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:25 so1905-ff03 sudo[2766]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:25 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 28 11:04:25 so1905-ff03 sudo[2777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:04:25 so1905-ff03 volumio[2404]: info: CoreCommandRouter::volumioGetQueue Jan 28 11:04:25 so1905-ff03 volumio[2404]: info: CoreStateMachine::getQueue Jan 28 11:04:25 so1905-ff03 volumio[2404]: info: CorePlayQueue::getQueue Jan 28 11:04:25 so1905-ff03 volumio[2404]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Jan 28 11:04:25 so1905-ff03 sudo[2777]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:25 so1905-ff03 sudo[2758]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:25 so1905-ff03 sudo[2785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:04:25 so1905-ff03 volumio[2404]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Jan 28 11:04:25 so1905-ff03 sudo[2791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:04:25 so1905-ff03 volumio[2404]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Jan 28 11:04:25 so1905-ff03 sudo[2791]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:25 so1905-ff03 sudo[2766]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:25 so1905-ff03 sudo[2785]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:25 so1905-ff03 volumio[2404]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Jan 28 11:04:25 so1905-ff03 sudo[2785]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:25 so1905-ff03 sudo[2791]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:25 so1905-ff03 volumio[2729]: Starting albumart workers Jan 28 11:04:25 so1905-ff03 sudo[2777]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:25 so1905-ff03 volumio[2404]: [rest_api] API:printToastMessage Jan 28 11:04:25 so1905-ff03 volumio[2404]: [airplay_emulation] Starting Shairport Sync Jan 28 11:04:25 so1905-ff03 sudo[2837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 28 11:04:25 so1905-ff03 sudo[2837]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:26 so1905-ff03 sudo[2842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 28 11:04:26 so1905-ff03 sudo[2842]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:04:26 so1905-ff03 systemd[1]: Started UPnP Renderer front-end to MPD. Jan 28 11:04:26 so1905-ff03 sudo[2837]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:26 so1905-ff03 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 28 11:04:26 so1905-ff03 sudo[2842]: pam_unix(sudo:session): session closed for user root Jan 28 11:04:26 so1905-ff03 volumio[2404]: Discovery: adding 73c29528-28fb-4e3d-b9e9-da7245145f47 Jan 28 11:04:26 so1905-ff03 volumio[2404]: info: mDNS: Found device SO1905-5f47 Jan 28 11:04:26 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:26 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:26 so1905-ff03 volumio[2404]: [spop] go-librespot daemon successfully initialized Jan 28 11:04:26 so1905-ff03 volumio[2404]: Discovery: adding 79454f80-a2af-4a4e-859c-cf07566b8725 Jan 28 11:04:26 so1905-ff03 volumio[2404]: info: mDNS: Found device SO1905-8725 Jan 28 11:04:27 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:27 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:27 so1905-ff03 volumio[2404]: Discovery: adding c42d06ed-efa3-4b2c-8740-4f5b506aff03 Jan 28 11:04:27 so1905-ff03 volumio[2404]: info: mDNS: Found device SO1905-ff03 Jan 28 11:04:27 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:27 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:27 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:27 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:27 so1905-ff03 volumio[2404]: [airplay_emulation] Shairport-Sync Started Jan 28 11:04:27 so1905-ff03 volumio[2404]: Error adding Membership: Error: addMembership EINVAL Jan 28 11:04:27 so1905-ff03 volumio[2404]: [upnp] Upmpdcli Daemon Started Jan 28 11:04:27 so1905-ff03 volumio[2404]: Discovery: this is already registered, c42d06ed-efa3-4b2c-8740-4f5b506aff03 Jan 28 11:04:27 so1905-ff03 volumio[2404]: info: mDNS: Found device SO1905-ff03 Jan 28 11:04:27 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:27 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:27 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:27 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:27 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:27 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:28 so1905-ff03 volumio[2897]: Generating RSA private key, 4096 bit long modulus (2 primes) Jan 28 11:04:28 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:28 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:29 so1905-ff03 volumio[2404]: [spop] Initializing connection to go-librespot Websocket Jan 28 11:04:29 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:04:29+08:00" level=debug msg="new websocket client" Jan 28 11:04:29 so1905-ff03 volumio[2404]: [spop] Connection to go-librespot Websocket established Jan 28 11:04:30 so1905-ff03 volumio[2897]: ................++++ Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:32 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:32 so1905-ff03 volumio[2404]: [spop] Getting Spotify volume Jan 28 11:04:33 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 28 11:04:33 so1905-ff03 volumio[2404]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 28 11:04:33 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:33 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:33 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:33 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:33 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:33 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:33 so1905-ff03 volumio[2404]: [websocket] [pushSrctotal] {"total":8,"cur":0,"curId":"stream:1","source":[{"id":"stream:1","name":"Streaming","code":"stream","type":0},{"id":"bt:1","name":"Bluetooth","code":"bt","type":4},{"id":"aux:1","name":"AUX","code":"aux","type":6},{"id":"optic:1","name":"DIGITAL OPT1","code":"optic","type":5},{"id":"optic:2","name":"DIGITAL OPT2","code":"optic","type":5},{"id":"arc:1","name":"HDMI ARC","code":"arc","type":5}]} Jan 28 11:04:43 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 11:04:43 so1905-ff03 volumio[2404]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 11:04:48 so1905-ff03 volumio[2897]: .............................................................................................................................................................................++++ Jan 28 11:04:48 so1905-ff03 volumio[2897]: e is 65537 (0x010001) Jan 28 11:04:48 so1905-ff03 volumio[2912]: writing RSA key Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:49 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:49 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:50 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:50 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:50 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:50 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:50 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:50 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:04:50 so1905-ff03 volumio[2404]: error: Could not retrieve plugin audio_interface multiroom Jan 28 11:04:50 so1905-ff03 volumio[2404]: [rest_api] API:pushMultiroomDevices Jan 28 11:05:01 so1905-ff03 sudo[3039]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl restart volumio Jan 28 11:05:01 so1905-ff03 sudo[3039]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Jan 28 11:05:01 so1905-ff03 systemd[1]: Started dynamicswap service. Jan 28 11:05:01 so1905-ff03 systemd[1]: Stopping Volumio Backend Module... Jan 28 11:05:02 so1905-ff03 systemd[1]: dynamicswap.service: Succeeded. Jan 28 11:05:02 so1905-ff03 go-librespot[2737]: time="2026-01-28T11:05:02+08:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Jan 28 11:05:02 so1905-ff03 systemd[1]: volumio.service: Succeeded. Jan 28 11:05:02 so1905-ff03 systemd[1]: Stopped Volumio Backend Module. Jan 28 11:05:02 so1905-ff03 systemd[1]: Started Volumio Backend Module. Jan 28 11:05:02 so1905-ff03 sudo[3039]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:02 so1905-ff03 kernel: sunxi-ehci 4200000.ehci1-controller: ehci_irq: highspeed device disconnect Jan 28 11:05:02 so1905-ff03 kernel: usb 1-1: USB disconnect, device number 2 Jan 28 11:05:02 so1905-ff03 udisks-glue[2170]: Device file /dev/sda1 unmounted from /media/848E-C1AC Jan 28 11:05:02 so1905-ff03 udisks-glue[2170]: Device file /dev/sda1 removed Jan 28 11:05:02 so1905-ff03 udisks-glue[2170]: Device file /dev/sda removed Jan 28 11:05:02 so1905-ff03 systemd[2388]: media-848E\x2dC1AC.mount: Succeeded. Jan 28 11:05:02 so1905-ff03 systemd[1]: media-848E\x2dC1AC.mount: Succeeded. Jan 28 11:05:02 so1905-ff03 udisks-glue[3086]: Updating DB (#1) ... Jan 28 11:05:02 so1905-ff03 udisks-glue[3086]: volume:100% repeat: off random: off single: off consume: off Jan 28 11:05:02 so1905-ff03 udisks-glue[3088]: Updating DB (#1) ... Jan 28 11:05:02 so1905-ff03 udisks-glue[3088]: volume:100% repeat: off random: off single: off consume: off Jan 28 11:05:06 so1905-ff03 volumio[3054]: info: ------------------------------------------- Jan 28 11:05:06 so1905-ff03 volumio[3054]: info: ----- Synaudio ---- Jan 28 11:05:06 so1905-ff03 volumio[3054]: info: ------------------------------------------- Jan 28 11:05:06 so1905-ff03 volumio[3054]: info: ----- System startup ---- Jan 28 11:05:06 so1905-ff03 volumio[3054]: info: ------------------------------------------- Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Found new core plugin music_service/cdplayer. Adding it Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Configured plugin music_service/cdplayer cannot be loaded. Removing from configuration Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Plugin folders cleanup Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Scanning into folder /volumio/app/plugins/ Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Scanning category audio_interface Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Scanning category miscellanea Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Scanning category music_service Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Scanning category plugins.json Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Scanning category system_controller Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Scanning category user_interface Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Scanning into folder /data/plugins/ Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Plugin folders cleanup completed Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: ------------------------------------------- Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: ----- Core plugins startup ---- Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: ------------------------------------------- Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Loading plugins from folder /volumio/app/plugins/ Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Adding plugin upnp to MyMusic Plugins Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Loading plugins from folder /data/plugins/ Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Loading plugin "system"... Jan 28 11:05:07 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/system_controller/system/index.js Jan 28 11:05:07 so1905-ff03 volumio[3054]: info: Loading plugin "appearance"... Jan 28 11:05:07 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/miscellanea/appearance/index.js Jan 28 11:05:08 so1905-ff03 volumio[3054]: info: Loading plugin "network"... Jan 28 11:05:08 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/system_controller/network/index.js Jan 28 11:05:08 so1905-ff03 volumio[3054]: [network] Refreshing Cached IP Addresses Jan 28 11:05:08 so1905-ff03 volumio[3054]: ControllerNetwork autoStartNetworkConfig true Jan 28 11:05:08 so1905-ff03 volumio[3054]: info: Loading plugin "services"... Jan 28 11:05:08 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/system_controller/services/index.js Jan 28 11:05:08 so1905-ff03 volumio[3054]: info: Loading plugin "alsa_controller"... Jan 28 11:05:08 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/audio_interface/alsa_controller/index.js Jan 28 11:05:08 so1905-ff03 sudo[3117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:05:08 so1905-ff03 sudo[3117]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:08 so1905-ff03 volumio[3054]: info: Applying required configuration parameters for plugin alsa_controller Jan 28 11:05:08 so1905-ff03 sudo[3119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:05:08 so1905-ff03 sudo[3117]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:08 so1905-ff03 sudo[3119]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:08 so1905-ff03 sudo[3119]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:08 so1905-ff03 volumio[3054]: [alsa_controller] Creating shared var alsa.outputdevice='2' Jan 28 11:05:08 so1905-ff03 volumio[3054]: info: Loading plugin "wizard"... Jan 28 11:05:08 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/miscellanea/wizard/index.js Jan 28 11:05:08 so1905-ff03 volumio[3054]: info: Loading plugin "volumio_command_line_client"... Jan 28 11:05:08 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/system_controller/volumio_command_line_client/index.js Jan 28 11:05:08 so1905-ff03 volumio[3054]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/getvolumedb.sh.template Jan 28 11:05:08 so1905-ff03 volumio[3054]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/setvolumedb.sh.template Jan 28 11:05:08 so1905-ff03 volumio[3054]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/getvolume.sh.template Jan 28 11:05:08 so1905-ff03 volumio[3054]: [volumio_command_line_client] /volumio/app/plugins/system_controller/volumio_command_line_client/setvolume.sh.template Jan 28 11:05:08 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:09 so1905-ff03 volumio[3054]: info: Loading plugin "upnp"... Jan 28 11:05:09 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/audio_interface/upnp/index.js Jan 28 11:05:09 so1905-ff03 volumio[3054]: info: [1769569509103] Starting Upmpd Daemon Jan 28 11:05:09 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 11:05:09 so1905-ff03 volumio[3054]: info: Loading plugin "my_music"... Jan 28 11:05:09 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/miscellanea/my_music/index.js Jan 28 11:05:09 so1905-ff03 volumio[3054]: info: Loading plugin "mpd"... Jan 28 11:05:09 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/mpd/index.js Jan 28 11:05:09 so1905-ff03 volumio[3054]: [mpd] MPD: starting udev watcher for USB partitions Jan 28 11:05:09 so1905-ff03 volumio[3054]: [mpd] Creating MPD Configuration file Jan 28 11:05:09 so1905-ff03 volumio[3054]: info: Loading plugin "upnp_browser"... Jan 28 11:05:09 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/upnp_browser/index.js Jan 28 11:05:09 so1905-ff03 sudo[3147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 11:05:09 so1905-ff03 sudo[3149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 11:05:09 so1905-ff03 sudo[3149]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:09 so1905-ff03 sudo[3147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:09 so1905-ff03 systemd[1]: Stopping Music Player Daemon... Jan 28 11:05:09 so1905-ff03 sudo[3147]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:10 so1905-ff03 systemd[1]: mpd.service: Succeeded. Jan 28 11:05:10 so1905-ff03 systemd[1]: Stopped Music Player Daemon. Jan 28 11:05:10 so1905-ff03 systemd[1]: Starting Music Player Daemon... Jan 28 11:05:10 so1905-ff03 volumio[3054]: info: Loading plugin "networkfs"... Jan 28 11:05:10 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/system_controller/networkfs/index.js Jan 28 11:05:10 so1905-ff03 volumio[3054]: [networkfs] Starting IP address watcher Jan 28 11:05:10 so1905-ff03 volumio[3054]: [networkfs] Started network interface ip monitor watcher Jan 28 11:05:10 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 11:05:10 so1905-ff03 volumio[3054]: info: Loading plugin "alarm-clock"... Jan 28 11:05:10 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/miscellanea/alarm-clock/index.js Jan 28 11:05:11 so1905-ff03 volumio[3054]: info: Loading plugin "airplay_emulation"... Jan 28 11:05:11 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/airplay_emulation/index.js Jan 28 11:05:11 so1905-ff03 volumio[3054]: Shairport Sync D-Bus 服务已注册。 Jan 28 11:05:11 so1905-ff03 volumio[3054]: [airplay_emulation] Starting Shairport Sync Jan 28 11:05:11 so1905-ff03 volumio[3054]: [airplay_emulation] [AirPlay] Started coverart directory watcher Jan 28 11:05:11 so1905-ff03 volumio[3054]: info: Loading plugin "last_100"... Jan 28 11:05:11 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/last_100/index.js Jan 28 11:05:11 so1905-ff03 volumio[3054]: info: Loading plugin "spop"... Jan 28 11:05:11 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/spop/index.js Jan 28 11:05:12 so1905-ff03 volumio[3054]: info: Loading plugin "webradio"... Jan 28 11:05:12 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/webradio/index.js Jan 28 11:05:12 so1905-ff03 mpd[3163]: Jan 28 11:05 : exception: bind to '/run/mpd/socket' failed (continuing anyway, because binding to '/run/mpd/socket' succeeded): Failed to bind socket: Address already in use Jan 28 11:05:12 so1905-ff03 mpd[3163]: Jan 28 11:05 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 28 11:05:12 so1905-ff03 systemd[1]: Started Music Player Daemon. Jan 28 11:05:12 so1905-ff03 sudo[3149]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:14 so1905-ff03 volumio[3054]: info: Loading plugin "yandex_browser"... Jan 28 11:05:14 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/yandex_browser/index.js Jan 28 11:05:15 so1905-ff03 volumio[3054]: [yandex_browser] Yandex plugin started Jan 28 11:05:15 so1905-ff03 volumio[3054]: error: ATTENTION!!!: Plugin yandex_browser does not return adequate promise from onVolumioStart: please update! Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Loading plugin "i2s_dacs"... Jan 28 11:05:15 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/system_controller/i2s_dacs/index.js Jan 28 11:05:15 so1905-ff03 volumio[3054]: [i2s_dacs] I2S DAC not set, start Auto-detection Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Loading plugin "volumiodiscovery"... Jan 28 11:05:15 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/system_controller/volumiodiscovery/index.js Jan 28 11:05:15 so1905-ff03 volumio[3054]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 28 11:05:15 so1905-ff03 volumio[3054]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 11:05:15 so1905-ff03 node[3054]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 28 11:05:15 so1905-ff03 volumio[3054]: *** WARNING *** For more information see Jan 28 11:05:15 so1905-ff03 volumio[3054]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 28 11:05:15 so1905-ff03 volumio[3054]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 11:05:15 so1905-ff03 volumio[3054]: *** WARNING *** For more information see Jan 28 11:05:15 so1905-ff03 node[3054]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 11:05:15 so1905-ff03 node[3054]: *** WARNING *** For more information see Jan 28 11:05:15 so1905-ff03 node[3054]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 28 11:05:15 so1905-ff03 node[3054]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 11:05:15 so1905-ff03 node[3054]: *** WARNING *** For more information see Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 28 11:05:15 so1905-ff03 volumio[3054]: [volumiodiscovery] Discovery: Started advertising with name: SO1905-ff03 Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Loading plugin "outputs"... Jan 28 11:05:15 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/audio_interface/outputs/index.js Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Loading plugin "albumart"... Jan 28 11:05:15 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/miscellanea/albumart/index.js Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Plugin example_plugin is not enabled Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Loading plugin "inputs"... Jan 28 11:05:15 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/inputs/index.js Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Loading plugin "pandora"... Jan 28 11:05:15 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/pandora/index.js Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Applying required configuration parameters for plugin pandora Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Loading plugin "podcast"... Jan 28 11:05:15 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/podcast/index.js Jan 28 11:05:15 so1905-ff03 volumio[3054]: [podcast] ControllerPodcast::constructor Jan 28 11:05:15 so1905-ff03 volumio[3054]: info: Loading plugin "qobuz"... Jan 28 11:05:15 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/qobuz/index.js Jan 28 11:05:16 so1905-ff03 volumio[3054]: error: ATTENTION!!!: Plugin qobuz does not return adequate promise from onVolumioStart: please update! Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: Loading plugin "tidal"... Jan 28 11:05:16 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/music_service/tidal/index.js Jan 28 11:05:16 so1905-ff03 volumio[3054]: [tidal] [1769569516158] ControllerTidalPlugin::constructor Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516159] ControllerTidalPlugin::onVolumioStart Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: Plugin volspotconnect2 is not enabled Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: Loading plugin "updater_comm"... Jan 28 11:05:16 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/system_controller/updater_comm/index.js Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: Plugin mpdemulation is not enabled Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: Loading plugin "rest_api"... Jan 28 11:05:16 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/user_interface/rest_api/index.js Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: Loading plugin "websocket"... Jan 28 11:05:16 so1905-ff03 volumio[3054]: [ require ] /volumio/app/plugins/user_interface/websocket/index.js Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: ___________ START PLUGINS ___________ Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516424] CoreMusicLibrary::Adding element Media Servers Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: SSDP Client initialized. Jan 28 11:05:16 so1905-ff03 volumio[3054]: Starting initial SSDP search... Jan 28 11:05:16 so1905-ff03 volumio[3054]: Discovering on interface: lo Jan 28 11:05:16 so1905-ff03 volumio[3054]: Discovering on interface: eth0 Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:16 so1905-ff03 volumio[3054]: [airplay_emulation] Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516582] CoreMusicLibrary::Adding element Last_100 Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: [spop] Creating Spotify config file Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516628] CoreMusicLibrary::Adding element Webradio Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 11:05:16 so1905-ff03 volumio[3054]: [yandex_browser] Yandex plugin started Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516664] ControllerYandexPlugin::addToBrowseSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516665] CoreMusicLibrary::Adding element Yandex Music Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:printToastMessage Jan 28 11:05:16 so1905-ff03 volumio[3054]: error: Plugin yandex_browser does not return adequate promise from onStart: please update! Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516682] CoreMusicLibrary::Adding element Pandora Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: [pandora] [1769569516690] ControllerPandora::initializeMQTT Jan 28 11:05:16 so1905-ff03 volumio[3054]: [pandora] [1769569516691] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516705] CoreMusicLibrary::Adding element Podcast Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516714] CoreMusicLibrary::Adding element Qobuz Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516728] ControllerTidalPlugin::onStart Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516736] ControllerTidalPlugin::addToBrowseSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: [1769569516738] CoreMusicLibrary::Adding element Tidal Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] Loading session from /data/configuration/music_service/tidal/tidal-session-oauth.json... Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] { token_type: { data: 'Bearer' }, Jan 28 11:05:16 so1905-ff03 volumio[3054]: session_id: { data: 'f6e9e73d-b968-42fa-bf37-a37b016f547e' }, Jan 28 11:05:16 so1905-ff03 volumio[3054]: access_token: Jan 28 11:05:16 so1905-ff03 volumio[3054]: { data: Jan 28 11:05:16 so1905-ff03 volumio[3054]: 'eyJraWQiOiJ2OU1GbFhqWSIsImFsZyI6IkVTMjU2In0.eyJ0eXBlIjoibzJfYWNjZXNzIiwidWlkIjoyMDY5ODkyNzQsInNjb3BlIjoid191c3Igcl91c3Igd19zdWIiLCJnVmVyIjowLCJzVmVyIjowLCJjaWQiOjEzMzE5LCJjYyI6IlVTIiwiYXQiOiJJTlRFUk5BTCIsImV4cCI6MTc2OTU4MjYzMSwic2lkIjoiZjZlOWU3M2QtYjk2OC00MmZhLWJmMzctYTM3YjAxNmY1NDdlIiwiaXNzIjoiaHR0cHM6Ly9hdXRoLnRpZGFsLmNvbS92MSJ9.4wpoEqr4WIL6wihhlC2V3KeyO6HY2ZAmNjnHmYKElPhq2HcoDOoBXXZaJ5IShyXCCUnHeOQDj5UfWeOO6vyOSA' }, Jan 28 11:05:16 so1905-ff03 volumio[3054]: refresh_token: Jan 28 11:05:16 so1905-ff03 volumio[3054]: { data: Jan 28 11:05:16 so1905-ff03 volumio[3054]: 'eyJraWQiOiJoUzFKYTdVMCIsImFsZyI6IkVTNTEyIn0.eyJ0eXBlIjoibzJfcmVmcmVzaCIsInVpZCI6MjA2OTg5Mjc0LCJzY29wZSI6Indfc3ViIHJfdXNyIHdfdXNyIiwiY2lkIjoxMzMxOSwic1ZlciI6MCwiZ1ZlciI6MCwiaXNzIjoiaHR0cHM6Ly9hdXRoLnRpZGFsLmNvbS92MSJ9.AfV48j5NB7w4txd9VqRDfGPrfD1wVbWPBlL3HRQ6itL16SIWqP6Na1LErZRpGeC8oYmltj_eKk0hv1E7Jhw85FauAKyZVXZRAf9JdIskiKa8ghZKIjo2Wx6-KAXPyrzRmdfk1lk-VIX9TkMskM9QbRQIDvQPUl3cYCFh5dnPkTA3DWjm' }, Jan 28 11:05:16 so1905-ff03 volumio[3054]: is_pkce: { data: false }, Jan 28 11:05:16 so1905-ff03 volumio[3054]: expiry_time: { data: 1769582632006 } } Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] Bearer eyJraWQiOiJ2OU1GbFhqWSIsImFsZyI6IkVTMjU2In0.eyJ0eXBlIjoibzJfYWNjZXNzIiwidWlkIjoyMDY5ODkyNzQsInNjb3BlIjoid191c3Igcl91c3Igd19zdWIiLCJnVmVyIjowLCJzVmVyIjowLCJjaWQiOjEzMzE5LCJjYyI6IlVTIiwiYXQiOiJJTlRFUk5BTCIsImV4cCI6MTc2OTU4MjYzMSwic2lkIjoiZjZlOWU3M2QtYjk2OC00MmZhLWJmMzctYTM3YjAxNmY1NDdlIiwiaXNzIjoiaHR0cHM6Ly9hdXRoLnRpZGFsLmNvbS92MSJ9.4wpoEqr4WIL6wihhlC2V3KeyO6HY2ZAmNjnHmYKElPhq2HcoDOoBXXZaJ5IShyXCCUnHeOQDj5UfWeOO6vyOSA Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] ===================== params ============== Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] uri https://api.tidal.com/v1/sessions?limit=1000 Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] method GET Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] params {"limit":1000} Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] data {} Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] headers {"User-Agent":"Mozilla/5.0 (Linux; Android 12; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/91.0.4472.114 Safari/537.36","authorization":"Bearer eyJraWQiOiJ2OU1GbFhqWSIsImFsZyI6IkVTMjU2In0.eyJ0eXBlIjoibzJfYWNjZXNzIiwidWlkIjoyMDY5ODkyNzQsInNjb3BlIjoid191c3Igcl91c3Igd19zdWIiLCJnVmVyIjowLCJzVmVyIjowLCJjaWQiOjEzMzE5LCJjYyI6IlVTIiwiYXQiOiJJTlRFUk5BTCIsImV4cCI6MTc2OTU4MjYzMSwic2lkIjoiZjZlOWU3M2QtYjk2OC00MmZhLWJmMzctYTM3YjAxNmY1NDdlIiwiaXNzIjoiaHR0cHM6Ly9hdXRoLnRpZGFsLmNvbS92MSJ9.4wpoEqr4WIL6wihhlC2V3KeyO6HY2ZAmNjnHmYKElPhq2HcoDOoBXXZaJ5IShyXCCUnHeOQDj5UfWeOO6vyOSA"} Jan 28 11:05:16 so1905-ff03 volumio[3054]: [Tidal] ===================== end params ============== Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: Loading i18n strings for locale en Jan 28 11:05:16 so1905-ff03 volumio[3054]: Updating browse sources language Jan 28 11:05:16 so1905-ff03 volumio[3054]: Cannot find translation for sourceMedia Servers Jan 28 11:05:16 so1905-ff03 volumio[3054]: Cannot find translation for sourceYandex Music Jan 28 11:05:16 so1905-ff03 volumio[3054]: Cannot find translation for sourcePodcast Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:05:16 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::initPlayerControls Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:16 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 28 11:05:17 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:17 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:17 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:17 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:17 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:17 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:05:17 so1905-ff03 volumio[3054]: info: BOOT COMPLETED Jan 28 11:05:17 so1905-ff03 volumio[3054]: [Metrics] CommandRouter: 10s 825.80ms Jan 28 11:05:17 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 11:05:17 so1905-ff03 kernel: sunxi-spdif 2036000.spdif: active: 1 Jan 28 11:05:22 so1905-ff03 volumio[3054]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 28 11:05:22 so1905-ff03 volumio[3054]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:05:22 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:22 so1905-ff03 volumio[3054]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:05:22 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:22 so1905-ff03 volumio[3054]: Express server listening on port 3000 Jan 28 11:05:22 so1905-ff03 volumio[3054]: [Metrics] WebUI: 16s 920.71ms Jan 28 11:05:22 so1905-ff03 volumio[3054]: (node:3054) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jan 28 11:05:22 so1905-ff03 volumio[3054]: [pandora] [1769569522568] ControllerPandora::validateAndSetAccountOptions Jan 28 11:05:22 so1905-ff03 volumio[3054]: [pandora] [1769569522571] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings. Jan 28 11:05:22 so1905-ff03 volumio[3054]: info: CoreStateMachine::resetVolumioState Jan 28 11:05:22 so1905-ff03 volumio[3054]: info: CoreStateMachine::getcurrentVolume Jan 28 11:05:22 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 11:05:22 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 11:05:22 so1905-ff03 sudo[3220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:05:22 so1905-ff03 volumio[3054]: [i2s_dacs] Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 28 11:05:22 so1905-ff03 sudo[3222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:05:23 so1905-ff03 sudo[3220]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:23 so1905-ff03 sudo[3222]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:23 so1905-ff03 sudo[3220]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:23 so1905-ff03 sudo[3222]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:23 so1905-ff03 volumio[3054]: [networkfs] IP address changed from "" to "192.168.23.164" Jan 28 11:05:23 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jan 28 11:05:23 so1905-ff03 sudo[3250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:05:23 so1905-ff03 sudo[3250]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:23 so1905-ff03 sudo[3260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:05:23 so1905-ff03 sudo[3266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 28 11:05:23 so1905-ff03 sudo[3250]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:23 so1905-ff03 sudo[3266]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:23 so1905-ff03 sudo[3260]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:23 so1905-ff03 volumio[3054]: [networkfs] Connecting to wireless device: undefined Jan 28 11:05:23 so1905-ff03 volumio[3054]: info: this.stateMachine.currentVolume: null, vol: 0 Jan 28 11:05:23 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:23 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:23 so1905-ff03 volumio[3054]: [airplay_emulation] [AirPlay] Received volume update: {"vol":0,"mute":false,"disableVolumeControl":false} Jan 28 11:05:23 so1905-ff03 volumio[3054]: [airplay_emulation] Sending DBus command: /usr/bin/dbus-send --system --print-reply --dest=org.gnome.ShairportSync "/org/gnome/ShairportSync" org.gnome.ShairportSync.RemoteControl.SetAirplayVolume double:-30.00 Jan 28 11:05:23 so1905-ff03 sudo[3279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:05:23 so1905-ff03 sudo[3285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:05:23 so1905-ff03 sudo[3279]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:23 so1905-ff03 volumio[3054]: info: CoreStateMachine::pushState Jan 28 11:05:23 so1905-ff03 sudo[3285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:23 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 11:05:23 so1905-ff03 sudo[3266]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:24 so1905-ff03 volumio[3054]: [rest_api] API:pushState Jan 28 11:05:24 so1905-ff03 sudo[3279]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:24 so1905-ff03 sudo[3260]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:24 so1905-ff03 volumio[3054]: info: CoreStateMachine::updateTrackBlock Jan 28 11:05:24 so1905-ff03 volumio[3054]: info: CorePlayQueue::getTrackBlock Jan 28 11:05:24 so1905-ff03 volumio[3054]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 11:05:24 so1905-ff03 sudo[3285]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:24 so1905-ff03 volumio[3054]: [mpd] MPD Permissions set Jan 28 11:05:24 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 28 11:05:24 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 28 11:05:24 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 28 11:05:24 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 28 11:05:24 so1905-ff03 volumio[3054]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 28 11:05:24 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 28 11:05:24 so1905-ff03 volumio[3054]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 28 11:05:24 so1905-ff03 volumio[3054]: [i2s_dacs] Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jan 28 11:05:24 so1905-ff03 volumio[3054]: sudo: /usr/sbin/i2cdetect: command not found Jan 28 11:05:24 so1905-ff03 volumio[3054]: [airplay_emulation] DBus command succeeded: SetAirplayVolume Jan 28 11:05:24 so1905-ff03 volumio[3054]: [rest_api] API:emitFavourites Jan 28 11:05:24 so1905-ff03 volumio[3054]: [spop] Spotify config file written Jan 28 11:05:25 so1905-ff03 sudo[3352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart go-librespot-daemon.service Jan 28 11:05:25 so1905-ff03 sudo[3352]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 11:05:25 so1905-ff03 systemd[1]: Stopping go-librespot Daemon... Jan 28 11:05:25 so1905-ff03 systemd[1]: go-librespot-daemon.service: Killing process 2743 (go-librespot) with signal SIGKILL. Jan 28 11:05:25 so1905-ff03 systemd[1]: go-librespot-daemon.service: Succeeded. Jan 28 11:05:25 so1905-ff03 systemd[1]: Stopped go-librespot Daemon. Jan 28 11:05:25 so1905-ff03 systemd[1]: Started go-librespot Daemon. Jan 28 11:05:25 so1905-ff03 sudo[3352]: pam_unix(sudo:session): session closed for user root Jan 28 11:05:25 so1905-ff03 go-librespot[3359]: go-librespot daemon starting... Jan 28 11:05:25 so1905-ff03 go-librespot[3364]: time="2026-01-28T11:05:25+08:00" level=info msg="running go-librespot 0.0.0" Jan 28 11:05:25 so1905-ff03 go-librespot[3364]: time="2026-01-28T11:05:25+08:00" level=debug msg="app state loaded" Jan 28 11:05:25 so1905-ff03 go-librespot[3364]: time="2026-01-28T11:05:25+08:00" level=debug msg="stored credentials not found" Jan 28 11:05:25 so1905-ff03 go-librespot[3364]: time="2026-01-28T11:05:25+08:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 28 11:05:25 so1905-ff03 volumio[3330]: Forking 1 albumart workers Jan 28 11:05:26 so1905-ff03 volumio[3054]: sendCommand: Command { name: 'playlistinfo', args: [] } Jan 28 11:05:26 so1905-ff03 volumio[3054]: sendCommand: Command { name: 'lsinfo "USB"', args: [] } Jan 28 11:05:26 so1905-ff03 volumio[3054]: sendCommand: Command { name: 'search album ""', args: [] } Jan 28 11:05:26 so1905-ff03 go-librespot[3364]: time="2026-01-28T11:05:26+08:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Jan 28 11:05:26 so1905-ff03 go-librespot[3364]: time="2026-01-28T11:05:26+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jan 28 11:05:26 so1905-ff03 go-librespot[3364]: time="2026-01-28T11:05:26+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jan 28 11:05:26 so1905-ff03 go-librespot[3364]: time="2026-01-28T11:05:26+08:00" level=info msg="zeroconf server listening on port 36235" Jan 28 11:05:26 so1905-ff03 go-librespot[3364]: 2026/01/28 11:05:26 [zeroconf] no suitable IPv6 interface: listen udp6 [ff02::]:5353: socket: address family not supported by protocol Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 28 11:05:26 so1905-ff03 volumio[3054]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworkMode Jan 28 11:05:26 so1905-ff03 volumio[3054]: [websocket] [pushCmd] {"index":5,"getInfo":0} Jan 28 11:05:26 so1905-ff03 volumio[3054]: [mpd] MPD running with PID3163 Jan 28 11:05:26 so1905-ff03 volumio[3054]: ,establishing connection Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 11:05:26 so1905-ff03 volumio[3054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 11:05:26 so1905-ff03 volumio[3054]: [spop] No need to fix Spotify hosts Jan 28 11:05:26 so1905-ff03 volumio[3054]: [mpd] updateQueue error: null Jan 28 11:05:27 so1905-ff03 volumio[3054]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 11:05:27 so1905-ff03 volumio[3054]: { Error: ENOENT: no such file or directory, stat '/mnt/USB/848E-C1AC' Jan 28 11:05:27 so1905-ff03 volumio[3054]: at Object.statSync (fs.js:855:3) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at eval (webpack://Volumio2/./app/plugins/music_service/mpd/index.js?:1586:23) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at MpdClient.handleMessage (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:77:3) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at MpdClient.receive (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:68:12) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at Socket.eval (webpack://Volumio2/./app/plugins/music_service/mpd/lib/mpd.js?:43:12) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at Socket.emit (events.js:198:13) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at addChunk (_stream_readable.js:288:12) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at readableAddChunk (_stream_readable.js:265:13) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at Socket.Readable.push (_stream_readable.js:224:10) Jan 28 11:05:27 so1905-ff03 volumio[3054]: at Pipe.onStreamRead [as onread] (internal/stream_base_commons.js:94:17) Jan 28 11:05:27 so1905-ff03 volumio[3054]: errno: -2, Jan 28 11:05:27 so1905-ff03 volumio[3054]: syscall: 'stat', Jan 28 11:05:27 so1905-ff03 volumio[3054]: code: 'ENOENT', Jan 28 11:05:27 so1905-ff03 volumio[3054]: path: '/mnt/USB/848E-C1AC' } Jan 28 11:05:27 so1905-ff03 volumio[3054]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 11:05:28 so1905-ff03 volumio[3371]: Starting albumart workers Jan 28 11:05:29 so1905-ff03 sudo[3409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 11:04 Jan 28 11:05:29 so1905-ff03 sudo[3409]: 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.7.40 VOLUMIO_BUILD_DATE=2026-01-21 07:29:33 VOLUMIO_VARIANT=volumio VOLUMIO_HARDWARE=Generic DT based system