-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2025-09-10 10:26:20 CEST. -- Sep 10 10:25:09 volumio volumio[3918]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/minidlna/volumio/buster/armhf Sep 10 10:25:10 volumio volumio[3918]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/minidlna/volumio/buster/armhf Sep 10 10:25:10 volumio volumio[3918]: info: minidlna: Stopping minidlna.service Sep 10 10:25:10 volumio sudo[6375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop minidlna.service Sep 10 10:25:10 volumio sudo[6375]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:10 volumio systemd[1]: Stopping MiniDLNA lightweight DLNA/UPnP-AV server... Sep 10 10:25:10 volumio volumio[3918]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 10 10:25:10 volumio systemd[1]: minidlna.service: Succeeded. Sep 10 10:25:10 volumio systemd[1]: Stopped MiniDLNA lightweight DLNA/UPnP-AV server. Sep 10 10:25:10 volumio sudo[6375]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:10 volumio volumio[3918]: info: minidlna: systemctl stop minidlna.service succeeded. Sep 10 10:25:11 volumio volumio[3918]: info: Check plugin dependencies Sep 10 10:25:11 volumio volumio[3918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 10 10:25:11 volumio volumio[3918]: info: Rename folder Sep 10 10:25:11 volumio volumio[3918]: info: Folder /tmp/downloaded_plugin.zip removed Sep 10 10:25:11 volumio volumio[3918]: info: Move to category Sep 10 10:25:11 volumio volumio[3918]: info: Checking if install.sh is present Sep 10 10:25:11 volumio volumio[3918]: info: Executing install.sh Sep 10 10:25:11 volumio sudo[6441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/minidlna/install.sh Sep 10 10:25:11 volumio sudo[6441]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:11 volumio volumio[3918]: info: Completing "UIConfig.json" Sep 10 10:25:11 volumio volumio[3918]: info: Installing MiniDLNA Sep 10 10:25:11 volumio volumio[3918]: info: Get:1 http://archive.debian.org/debian buster InRelease [122 kB] Sep 10 10:25:11 volumio volumio[3918]: info: Get:2 https://deb.nodesource.com/node_14.x buster InRelease [4584 B] Sep 10 10:25:12 volumio volumio[3918]: info: Get:3 http://archive.debian.org/debian buster/main armhf Packages [7706 kB] Sep 10 10:25:13 volumio volumio[3918]: info: Get:4 http://archive.debian.org/debian buster/main Translation-en [5969 kB] Sep 10 10:25:14 volumio volumio[3918]: info: Get:5 http://archive.debian.org/debian buster/contrib armhf Packages [40.1 kB] Sep 10 10:25:14 volumio volumio[3918]: info: Get:6 http://archive.debian.org/debian buster/contrib Translation-en [44.2 kB] Sep 10 10:25:14 volumio volumio[3918]: info: Get:7 http://archive.debian.org/debian buster/non-free armhf Packages [62.1 kB] Sep 10 10:25:14 volumio volumio[3918]: info: Get:8 http://archive.debian.org/debian buster/non-free Translation-en [88.9 kB] Sep 10 10:25:18 volumio volumio[3918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 10 10:25:18 volumio volumio[3918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 10 10:25:18 volumio volumio[3918]: info: Discovery: Getting this device information Sep 10 10:25:18 volumio volumio[3918]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:18 volumio volumio[3918]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:18 volumio volumio[3918]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 10 10:25:20 volumio volumio[3918]: info: Fetched 14.0 MB in 9s (1638 kB/s) Sep 10 10:25:22 volumio volumio[3918]: info: Reading package lists... Sep 10 10:25:22 volumio volumio[3918]: info: Reading package lists... Sep 10 10:25:23 volumio volumio[3918]: info: Building dependency tree... Sep 10 10:25:23 volumio volumio[3918]: info: Reading state information... Sep 10 10:25:24 volumio volumio[3918]: info: minidlna is already the newest version (1.2.1+dfsg-2+deb10u3). Sep 10 10:25:24 volumio volumio[3918]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Sep 10 10:25:24 volumio systemd[1]: Reloading. Sep 10 10:25:24 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Sep 10 10:25:24 volumio systemd[1]: serial-getty@ttyS3.service: Current command vanished from the unit file, execution of the command list won't be resumed. Sep 10 10:25:25 volumio systemd[1]: Starting Daily apt download activities... Sep 10 10:25:25 volumio volumio[3918]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 10 10:25:25 volumio systemd[1]: Reloading. Sep 10 10:25:25 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Sep 10 10:25:25 volumio systemd[1]: Reloading. Sep 10 10:25:26 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Sep 10 10:25:26 volumio systemd[1]: apt-daily.service: Succeeded. Sep 10 10:25:26 volumio systemd[1]: Started Daily apt download activities. Sep 10 10:25:26 volumio volumio[3918]: info: Creating systemd unit /etc/systemd/system/minidlna.service Sep 10 10:25:26 volumio systemd[1]: Reloading. Sep 10 10:25:26 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Sep 10 10:25:26 volumio volumio[3918]: info: Setting values for "network_interface" and "model_number" in /data/plugins/music_service/minidlna/config.json Sep 10 10:25:27 volumio volumio[3918]: info: Setting permissions to MiniDLNA folders Sep 10 10:25:27 volumio sudo[6441]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:27 volumio volumio[3918]: Plugin install end detected on script Sep 10 10:25:27 volumio volumio[3918]: info: Install script completed Sep 10 10:25:27 volumio volumio[3918]: info: Done installing plugin. Sep 10 10:25:27 volumio volumio[3918]: info: Enabling plugin minidlna Sep 10 10:25:27 volumio volumio[3918]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 10 10:25:27 volumio volumio[3918]: info: [{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.12","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.5","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Sep 10 10:25:27 volumio volumio[3918]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 10 10:25:27 volumio volumio[3918]: info: Folder /tmp/plugins removed Sep 10 10:25:27 volumio volumio[3918]: info: Folder /tmp/downloaded_plugin.zip removed Sep 10 10:25:27 volumio volumio[3918]: info: Folder /data/temp removed Sep 10 10:25:27 volumio volumio[3918]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 10 10:25:27 volumio volumio[3918]: [t [Error]: The project's quota for this operation has been exceeded.] { Sep 10 10:25:27 volumio volumio[3918]: code: 'auth/quota-exceeded', Sep 10 10:25:27 volumio volumio[3918]: a: null Sep 10 10:25:27 volumio volumio[3918]: } Sep 10 10:25:27 volumio volumio[3918]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 10 10:25:27 volumio sudo[6859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-10 10:24 Sep 10 10:25:27 volumio sudo[6859]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:28 volumio sudo[6859]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:28 volumio volumio-remote-updater[10190]: [2025-09-10 10:25:28] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Sep 10 10:25:28 volumio volumio-remote-updater[10190]: [2025-09-10 10:25:28] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Sep 10 10:25:28 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Sep 10 10:25:28 volumio qobuz-connect[4496]: 20250910 10:25:28.102 [4496.4496] INFO SampleApp: Socket closed Sep 10 10:25:28 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Sep 10 10:25:28 volumio systemd[1]: Started dynamicswap service. Sep 10 10:25:28 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 10 10:25:28 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Sep 10 10:25:28 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Sep 10 10:25:28 volumio systemd[1]: Started dynamicswap service. Sep 10 10:25:28 volumio systemd[1]: Stopped Volumio Backend Module. Sep 10 10:25:28 volumio systemd[1]: Started Volumio Backend Module. Sep 10 10:25:28 volumio systemd[1]: dynamicswap.service: Succeeded. Sep 10 10:25:29 volumio volumio[6879]: info: ------------------------------------------- Sep 10 10:25:29 volumio volumio[6879]: info: ----- Volumio3 ---- Sep 10 10:25:29 volumio volumio[6879]: info: ------------------------------------------- Sep 10 10:25:29 volumio volumio[6879]: info: ----- System startup ---- Sep 10 10:25:29 volumio volumio[6879]: info: ------------------------------------------- Sep 10 10:25:30 volumio volumio[6879]: info: MYVOLUMIO Environment detected Sep 10 10:25:30 volumio volumio[6879]: info: Plugin folders cleanup Sep 10 10:25:30 volumio volumio[6879]: info: Scanning into folder /volumio/app/plugins/ Sep 10 10:25:30 volumio volumio[6879]: info: Scanning category audio_interface Sep 10 10:25:30 volumio volumio[6879]: info: Scanning category miscellanea Sep 10 10:25:30 volumio volumio[6879]: info: Scanning category music_service Sep 10 10:25:30 volumio volumio[6879]: info: Scanning category plugins.json Sep 10 10:25:30 volumio volumio[6879]: info: Scanning category system_controller Sep 10 10:25:30 volumio volumio[6879]: info: Scanning category user_interface Sep 10 10:25:30 volumio volumio[6879]: info: Scanning into folder /data/plugins/ Sep 10 10:25:30 volumio volumio[6879]: info: Scanning category music_service Sep 10 10:25:30 volumio volumio[6879]: info: Scanning category user_interface Sep 10 10:25:30 volumio volumio[6879]: info: Plugin folders cleanup completed Sep 10 10:25:30 volumio volumio[6879]: info: ------------------------------------------- Sep 10 10:25:30 volumio volumio[6879]: info: ----- Core plugins startup ---- Sep 10 10:25:30 volumio volumio[6879]: info: ------------------------------------------- Sep 10 10:25:30 volumio volumio[6879]: info: Loading plugins from folder /volumio/app/plugins/ Sep 10 10:25:30 volumio volumio[6879]: info: Adding plugin upnp to MyMusic Plugins Sep 10 10:25:30 volumio volumio[6879]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 10 10:25:30 volumio volumio[6879]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 10 10:25:30 volumio volumio[6879]: info: Loading plugins from folder /data/plugins/ Sep 10 10:25:30 volumio volumio[6879]: info: Loading plugin "system"... Sep 10 10:25:30 volumio volumio[6879]: info: Loading plugin "appearance"... Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "network"... Sep 10 10:25:31 volumio volumio[6879]: info: Refreshing Cached IP Addresses Sep 10 10:25:31 volumio sudo[6906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "services"... Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "alsa_controller"... Sep 10 10:25:31 volumio sudo[6908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 10 10:25:31 volumio sudo[6906]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:31 volumio sudo[6908]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:31 volumio sudo[6906]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:31 volumio sudo[6908]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:31 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "wizard"... Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "networkfs"... Sep 10 10:25:31 volumio volumio[6879]: info: Cannot mount NAS WD_NAS at system boot, trial number 1 ,retrying in 5 seconds Sep 10 10:25:31 volumio volumio[6879]: info: Cannot mount NAS Eversolo at system boot, trial number 1 ,retrying in 5 seconds Sep 10 10:25:31 volumio volumio[6879]: info: Starting Udev Watcher for removable devices Sep 10 10:25:31 volumio volumio[6879]: info: Ignoring mount for partition: BOOT Sep 10 10:25:31 volumio volumio[6879]: info: Ignoring mount for partition: volumio Sep 10 10:25:31 volumio volumio[6879]: info: Ignoring mount for partition: volumio_data Sep 10 10:25:31 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "volumio_command_line_client"... Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "upnp"... Sep 10 10:25:31 volumio volumio[6879]: info: [1757492731528] Starting Upmpd Daemon Sep 10 10:25:31 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "my_music"... Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "mpd"... Sep 10 10:25:31 volumio volumio[6879]: info: Loading plugin "upnp_browser"... Sep 10 10:25:32 volumio volumio[6879]: info: Loading plugin "alarm-clock"... Sep 10 10:25:32 volumio volumio[6879]: info: Plugin airplay_emulation is not enabled Sep 10 10:25:32 volumio volumio[6879]: info: Loading plugin "last_100"... Sep 10 10:25:32 volumio volumio[6879]: info: Loading plugin "webradio"... Sep 10 10:25:32 volumio volumio[6879]: info: Loading plugin "i2s_dacs"... Sep 10 10:25:32 volumio volumio[6879]: info: I2S DAC not set, start Auto-detection Sep 10 10:25:32 volumio volumio[6879]: info: Loading plugin "volumiodiscovery"... Sep 10 10:25:32 volumio volumio[6879]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 10 10:25:32 volumio node[6879]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 10 10:25:32 volumio volumio[6879]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 10 10:25:32 volumio node[6879]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 10 10:25:32 volumio volumio[6879]: *** WARNING *** For more information see Sep 10 10:25:32 volumio node[6879]: *** WARNING *** For more information see Sep 10 10:25:32 volumio volumio[6879]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 10 10:25:32 volumio node[6879]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 10 10:25:32 volumio volumio[6879]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 10 10:25:32 volumio node[6879]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 10 10:25:32 volumio volumio[6879]: *** WARNING *** For more information see Sep 10 10:25:32 volumio node[6879]: *** WARNING *** For more information see Sep 10 10:25:32 volumio volumio[6879]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 10 10:25:32 volumio volumio[6879]: info: Discovery: Started advertising with name: Volumio Sep 10 10:25:32 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 10 10:25:32 volumio volumio[6879]: info: Loading plugin "now_playing"... Sep 10 10:25:33 volumio volumio-remote-updater[10190]: [2025-09-10 10:25:33] [connect] Successful connection Sep 10 10:25:33 volumio volumio[6879]: info: Loading plugin "outputs"... Sep 10 10:25:33 volumio volumio[6879]: info: Loading plugin "albumart"... Sep 10 10:25:33 volumio volumio[6879]: info: Plugin example_plugin is not enabled Sep 10 10:25:33 volumio volumio[6879]: info: Loading plugin "inputs"... Sep 10 10:25:33 volumio volumio[6879]: info: Loading plugin "updater_comm"... Sep 10 10:25:33 volumio volumio[6879]: info: Plugin mpdemulation is not enabled Sep 10 10:25:33 volumio volumio[6879]: info: Loading plugin "rest_api"... Sep 10 10:25:33 volumio volumio[6879]: info: Loading plugin "websocket"... Sep 10 10:25:33 volumio volumio[6879]: info: Starting Socket.io Server version 2.3.0 Sep 10 10:25:33 volumio volumio[6879]: info: Loading plugin "minidlna"... Sep 10 10:25:33 volumio volumio[6879]: info: Applying required configuration parameters for plugin minidlna Sep 10 10:25:33 volumio volumio[6879]: Forking 3 albumart workers Sep 10 10:25:33 volumio volumio[6879]: info: Loading plugin "radio_paradise"... Sep 10 10:25:34 volumio volumio[6879]: info: Applying required configuration parameters for plugin radio_paradise Sep 10 10:25:34 volumio volumio[6879]: info: [1757492734103] [RadioParadise] API delay: 5 Sep 10 10:25:34 volumio volumio[6879]: info: Loading plugin "Systeminfo"... Sep 10 10:25:34 volumio volumio[6879]: Starting albumart workers Sep 10 10:25:34 volumio volumio[6879]: info: Loading i18n strings for locale de Sep 10 10:25:34 volumio volumio[6879]: Starting albumart workers Sep 10 10:25:34 volumio volumio[6879]: Updating browse sources language Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:25:34 volumio volumio[6879]: Starting albumart workers Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::initPlayerControls Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: Express server listening on port 3000 Sep 10 10:25:34 volumio volumio[6879]: [Metrics] WebUI: 5s 540.64ms Sep 10 10:25:34 volumio volumio[6879]: info: CoreStateMachine::resetVolumioState Sep 10 10:25:34 volumio volumio[6879]: info: CoreStateMachine::getcurrentVolume Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::volumioRetrievevolume Sep 10 10:25:34 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:34 volumio volumio[6879]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 10 10:25:34 volumio volumio[6879]: info: Completed loading Core Plugins Sep 10 10:25:34 volumio volumio[6879]: info: Preparing to generate the ALSA configuration file Sep 10 10:25:34 volumio volumio[6879]: info: Volumio Network Manager: Network status updated: 1 Sep 10 10:25:34 volumio volumio[6879]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Sep 10 10:25:34 volumio volumio[6879]: info: Reading ALSA contributions from plugins. Sep 10 10:25:34 volumio volumio[6879]: verbose: New Socket.io Connection to 192.168.0.54 from 192.168.0.9 UA: Mozilla/5.0 (Linux; Android 15; SM-X906B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.158 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Sep 10 10:25:35 volumio volumio[6879]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 2 Sep 10 10:25:35 volumio volumio-remote-updater[10190]: [2025-09-10 10:25:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757492733 101 Sep 10 10:25:35 volumio volumio[6879]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Sep 10 10:25:35 volumio volumio[6879]: info: CoreStateMachine::pushState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioPushState Sep 10 10:25:35 volumio volumio[6879]: info: CoreStateMachine::updateTrackBlock Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrackBlock Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioRetrievevolume Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 10 10:25:35 volumio volumio[6879]: info: Discovery: Getting this device information Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 10 10:25:35 volumio volumio[6879]: info: Reloading queue from file Sep 10 10:25:35 volumio volumio[6879]: info: CoreStateMachine::pushState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioPushState Sep 10 10:25:35 volumio volumio[6879]: info: Setting Device type: Tinkerboard Sep 10 10:25:35 volumio volumio[6879]: info: CoreStateMachine::setRepeat false single undefined Sep 10 10:25:35 volumio volumio[6879]: info: CoreStateMachine::pushState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioPushState Sep 10 10:25:35 volumio volumio[6879]: info: CoreStateMachine::setRandom undefined Sep 10 10:25:35 volumio volumio[6879]: info: CoreStateMachine::pushState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioPushState Sep 10 10:25:35 volumio volumio[6879]: verbose: New Socket.io Connection to 192.168.0.54:3000 from 192.168.0.9 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Sep 10 10:25:35 volumio volumio[6879]: info: Asound.conf file unchanged, so no further update is needed Sep 10 10:25:35 volumio volumio[6879]: info: Output device has changed, restarting MPD Sep 10 10:25:35 volumio volumio[6879]: info: ___________ START PLUGINS ___________ Sep 10 10:25:35 volumio volumio[6879]: info: ControllerMpd::onStart: Initializing MPD Sep 10 10:25:35 volumio volumio[6879]: info: Creating MPD Configuration file Sep 10 10:25:35 volumio sudo[7025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 10 10:25:35 volumio sudo[7027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 10 10:25:35 volumio sudo[7025]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:35 volumio sudo[7027]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:35 volumio sudo[7025]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 10 10:25:35 volumio volumio[6879]: info: [1757492735244] CoreMusicLibrary::Adding element Medienserver Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:25:35 volumio sudo[7034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 10 10:25:35 volumio sudo[7041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 10 10:25:35 volumio systemd[1]: Stopping Music Player Daemon... Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 10 10:25:35 volumio volumio[6879]: info: [1757492735278] CoreMusicLibrary::Adding element Last_100 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:25:35 volumio sudo[7034]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 10 10:25:35 volumio volumio[6879]: info: [1757492735281] CoreMusicLibrary::Adding element Webradio Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 10 10:25:35 volumio sudo[7041]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:35 volumio volumio[6879]: info: Initializing BBC Radios Sep 10 10:25:35 volumio sudo[7034]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:35 volumio systemd[1]: mpd.service: Succeeded. Sep 10 10:25:35 volumio systemd[1]: Stopped Music Player Daemon. Sep 10 10:25:35 volumio systemd[1]: Starting Music Player Daemon... Sep 10 10:25:35 volumio volumio[6879]: info: [now-playing] ConfigUpdater: config is up to date. Sep 10 10:25:35 volumio volumio[6879]: info: Loading i18n strings for locale de Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 10 10:25:35 volumio volumio[6879]: info: [1757492735391] CoreMusicLibrary::Adding element Radio Paradise Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:25:35 volumio volumio[6879]: Cannot find translation for source Radio Paradise Sep 10 10:25:35 volumio volumio[6879]: info: Volumio Calling Home Sep 10 10:25:35 volumio sudo[7070]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 10 10:25:35 volumio sudo[7070]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:35 volumio sudo[7070]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:35 volumio volumio[6879]: info: [now-playing] App is listening on port 4004. Sep 10 10:25:35 volumio volumio[6879]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 10 10:25:35 volumio volumio[6879]: info: Discovery: adding b44d2fb1-665a-45b6-8e91-b7089f4d8aab Sep 10 10:25:35 volumio volumio[6879]: info: Discovery: Found device Volumio Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: verbose: New Socket.io Connection to 192.168.0.54 from 192.168.0.9 UA: Mozilla/5.0 (Linux; Android 15; SM-X906B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.158 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Sep 10 10:25:35 volumio volumio[6879]: info: Volumio called home Sep 10 10:25:35 volumio volumio[6879]: info: MPD Permissions set Sep 10 10:25:35 volumio volumio[6879]: info: MPD Permissions set Sep 10 10:25:35 volumio volumio[6879]: info: minidlna: Found miniDLNA version 1.2.1 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 10 10:25:35 volumio volumio[6879]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetVisibleSources Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 10 10:25:35 volumio volumio[6879]: info: Received Get System Info Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 10 10:25:35 volumio volumio[6879]: info: Discovery: Getting this device information Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:35 volumio volumio[6879]: info: Listing playlists Sep 10 10:25:35 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:35 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:36 volumio volumio[6879]: info: minidlna: /data/minidlna.conf written Sep 10 10:25:36 volumio volumio[6879]: info: minidlna: Starting minidlna.service Sep 10 10:25:36 volumio sudo[7098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Sep 10 10:25:36 volumio sudo[7098]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:36 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Sep 10 10:25:36 volumio sudo[7098]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:36 volumio volumio[6879]: info: minidlna: systemctl start minidlna.service succeeded. Sep 10 10:25:36 volumio volumio[6879]: info: Cannot mount NAS WD_NAS at system boot, trial number 2 ,retrying in 5 seconds Sep 10 10:25:36 volumio volumio[6879]: info: Cannot mount NAS Eversolo at system boot, trial number 2 ,retrying in 5 seconds Sep 10 10:25:36 volumio mpd[7084]: Sep 10 10:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 10 10:25:36 volumio volumio[6879]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 7 Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::volumioGetVisibleSources Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:37 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:37 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 10 10:25:37 volumio volumio[6879]: info: Received Get System Info Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 10 10:25:37 volumio volumio[6879]: info: Discovery: Getting this device information Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:37 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 10 10:25:37 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:37 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:37 volumio volumio[6879]: info: Listing playlists Sep 10 10:25:37 volumio systemd[1]: Started Music Player Daemon. Sep 10 10:25:37 volumio sudo[7027]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:37 volumio sudo[7041]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:37 volumio volumio[6879]: info: Completed starting Core Plugins Sep 10 10:25:37 volumio volumio[6879]: info: ------------------------------------------- Sep 10 10:25:37 volumio volumio[6879]: info: ----- MyVolumio plugins startup ---- Sep 10 10:25:37 volumio volumio[6879]: info: ------------------------------------------- Sep 10 10:25:37 volumio volumio[6879]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 10 10:25:37 volumio volumio[6879]: error: MPD error: The expression evaluated to a falsy value: Sep 10 10:25:37 volumio volumio[6879]: assert.ok(self.idling) Sep 10 10:25:37 volumio volumio[6879]: error: The expression evaluated to a falsy value: Sep 10 10:25:37 volumio volumio[6879]: assert.ok(self.idling) Sep 10 10:25:37 volumio volumio[6879]: error: updateQueue error: null Sep 10 10:25:37 volumio volumio[6879]: info: MPD running with PID7084 Sep 10 10:25:37 volumio volumio[6879]: ,establishing connection Sep 10 10:25:37 volumio volumio[6879]: error: updateQueue error: null Sep 10 10:25:41 volumio volumio[6879]: info: Cannot mount NAS WD_NAS at system boot, trial number 3 ,retrying in 5 seconds Sep 10 10:25:41 volumio volumio[6879]: info: Cannot mount NAS Eversolo at system boot, trial number 3 ,retrying in 5 seconds Sep 10 10:25:41 volumio sudo[7139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 10 10:25:41 volumio sudo[7139]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:41 volumio sudo[7141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 10 10:25:41 volumio sudo[7139]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:41 volumio sudo[7141]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:41 volumio sudo[7141]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:41 volumio sudo[7149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 10 10:25:41 volumio sudo[7149]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:41 volumio sudo[7149]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:41 volumio volumio[6879]: info: Upmpdcli Daemon Started Sep 10 10:25:42 volumio volumio[6879]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 10 10:25:45 volumio volumio[6879]: info: Adding plugin bluetooth to MyMusic Plugins Sep 10 10:25:45 volumio volumio[6879]: info: Adding plugin multiroom to MyMusic Plugins Sep 10 10:25:45 volumio volumio[6879]: info: Adding plugin metavolumio to MyMusic Plugins Sep 10 10:25:45 volumio volumio[6879]: info: Adding plugin cd_controller to MyMusic Plugins Sep 10 10:25:45 volumio volumio[6879]: info: Adding plugin qobuzconnect to MyMusic Plugins Sep 10 10:25:45 volumio volumio[6879]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 10 10:25:45 volumio volumio[6879]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 10 10:25:45 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 10 10:25:46 volumio volumio[6879]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 10 10:25:46 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 10 10:25:46 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:46 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:46 volumio volumio[6879]: info: Starting MyVolumio Remote Streaming Endpoints Sep 10 10:25:46 volumio volumio[6879]: info: MyVolumio login type: Token Sep 10 10:25:46 volumio volumio[6879]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 10 10:25:46 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 10 10:25:47 volumio volumio[6879]: info: Starting Streaming Service Transparent Proxy Sep 10 10:25:47 volumio volumio[6879]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 10 10:25:47 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 10 10:25:47 volumio volumio[6879]: info: Streaming services startup Sep 10 10:25:47 volumio volumio[6879]: info: Starting Streaming Daemon Sep 10 10:25:47 volumio sudo[7175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 10 10:25:47 volumio sudo[7175]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:47 volumio volumio[6879]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 10 10:25:47 volumio sudo[7175]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:47 volumio volumio[6879]: info: Cannot mount NAS WD_NAS at system boot, trial number 4 ,retrying in 5 seconds Sep 10 10:25:47 volumio volumio[6879]: info: Cannot mount NAS Eversolo at system boot, trial number 4 ,retrying in 5 seconds Sep 10 10:25:47 volumio volumio[6879]: error: Cannot start Volumio Streaming Daemon Sep 10 10:25:47 volumio volumio[6879]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 10 10:25:47 volumio volumio[6879]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 10 10:25:47 volumio volumio[6879]: error: MyVolumio Custom Token format not valid, refreshing it Sep 10 10:25:47 volumio volumio[6879]: STREAMING PROXY: Starting server on port 3245 Sep 10 10:25:47 volumio volumio[6879]: Node JS runtime: 14 Sep 10 10:25:47 volumio volumio[6879]: info: MyVolumio login type: Token Sep 10 10:25:48 volumio volumio[6879]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 10 10:25:48 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 10 10:25:48 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 10 10:25:48 volumio volumio[6879]: info: Discovery: Getting this device information Sep 10 10:25:48 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:48 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:48 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 10 10:25:49 volumio volumio[6879]: info: MyVolumio token set successfully Sep 10 10:25:49 volumio volumio[6879]: info: MYVOLUMIO: Adding device Sep 10 10:25:49 volumio volumio[6879]: info: MYVOLUMIO: Evaluating Server Sep 10 10:25:49 volumio volumio[6879]: info: MyVolumio Plan changed: superstar Sep 10 10:25:49 volumio volumio[6879]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Sep 10 10:25:49 volumio volumio[6879]: info: Adding audio output: Sep 10 10:25:49 volumio volumio[6879]: info: MYVOLUMIO: Adding device Sep 10 10:25:49 volumio volumio[6879]: info: MYVOLUMIO: Evaluating Server Sep 10 10:25:49 volumio volumio[6879]: info: Remote config written successfully Sep 10 10:25:49 volumio volumio[6879]: info: Starting Tunnel 1 Sep 10 10:25:49 volumio volumio[6879]: info: Starting Tunnel Connection Checker Sep 10 10:25:49 volumio volumio[6879]: info: Completed starting MyVolumio Plugin Sep 10 10:25:49 volumio volumio[6879]: info: MYVolumio Device enabled Sep 10 10:25:49 volumio volumio[6879]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Sep 10 10:25:49 volumio volumio[6879]: info: MyVolumio status changed Sep 10 10:25:49 volumio volumio[6879]: info: Streaming services startup Sep 10 10:25:49 volumio volumio[6879]: info: Starting Streaming Daemon Sep 10 10:25:49 volumio sudo[7229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 10 10:25:49 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Sep 10 10:25:49 volumio volumio[6879]: error: [MyVolumio PluginManager] Cache data is invalid! Sep 10 10:25:49 volumio sudo[7229]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:49 volumio sudo[7229]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:49 volumio volumio[6879]: error: Cannot start Volumio Streaming Daemon Sep 10 10:25:49 volumio volumio[6879]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 10 10:25:49 volumio volumio[6879]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 10 10:25:51 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Sep 10 10:25:51 volumio volumio[6879]: info: [1757492751322] Starting BluetoothController Sep 10 10:25:51 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Sep 10 10:25:52 volumio sudo[7253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Sep 10 10:25:52 volumio sudo[7253]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio sudo[7253]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio volumio[6879]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Sep 10 10:25:52 volumio volumio[6879]: info: MRS: MultiRoom plugin initialized Sep 10 10:25:52 volumio volumio[6879]: info: MRS: STOPPING SNAPCLIENT Sep 10 10:25:52 volumio volumio[6879]: info: MRS: Snap server stop Sep 10 10:25:52 volumio sudo[7276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Sep 10 10:25:52 volumio volumio[6879]: info: MRS: STOPPING volumioStreaming Sep 10 10:25:52 volumio sudo[7276]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio sudo[7279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Sep 10 10:25:52 volumio sudo[7279]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio sudo[7286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Sep 10 10:25:52 volumio sudo[7276]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio sudo[7286]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio sudo[7294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Sep 10 10:25:52 volumio sudo[7279]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Sep 10 10:25:52 volumio sudo[7294]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio sudo[7294]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Sep 10 10:25:52 volumio sudo[7286]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Sep 10 10:25:52 volumio volumio[6879]: info: Preparing to generate the ALSA configuration file Sep 10 10:25:52 volumio volumio[6879]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Sep 10 10:25:52 volumio volumio[6879]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Sep 10 10:25:52 volumio volumio[6879]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Sep 10 10:25:52 volumio volumio[6879]: info: Reading ALSA contributions from plugins. Sep 10 10:25:52 volumio volumio[6879]: info: Setting Geolocation for MyVolumio to eu6 Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: MRS: Removed streaming files Sep 10 10:25:52 volumio volumio[6879]: info: MRS: volumioStreaming STOPPED Sep 10 10:25:52 volumio volumio[6879]: info: MRS: SNAPSERVER STOPPED Sep 10 10:25:52 volumio volumio[6879]: info: MRS: SNAPCLIENT STOPPED Sep 10 10:25:52 volumio volumio[6879]: info: Asound.conf file unchanged, so no further update is needed Sep 10 10:25:52 volumio volumio[6879]: info: Output device has changed, restarting MPD Sep 10 10:25:52 volumio volumio[6879]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 10 10:25:52 volumio sudo[7316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio sudo[7316]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio sudo[7319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 10 10:25:52 volumio sudo[7316]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 10 10:25:52 volumio sudo[7319]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Sep 10 10:25:52 volumio volumio[6879]: info: Adding METAVOLUMIO REST API Endpoints Sep 10 10:25:52 volumio volumio[6879]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Sep 10 10:25:52 volumio volumio[6879]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Sep 10 10:25:52 volumio volumio[6879]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Sep 10 10:25:52 volumio volumio[6879]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Sep 10 10:25:52 volumio systemd[1]: Stopping Music Player Daemon... Sep 10 10:25:52 volumio volumio[6879]: error: Hi Res Audio Failed Login: Missing Login Data Sep 10 10:25:52 volumio volumio[6879]: info: Adding HIGHRESAUDIO REST API Endpoints Sep 10 10:25:52 volumio volumio[6879]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Sep 10 10:25:52 volumio volumio[6879]: info: Refreshing QOBUZ token Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Sep 10 10:25:52 volumio volumio[6879]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Sep 10 10:25:52 volumio volumio[6879]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Sep 10 10:25:52 volumio sudo[7335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Sep 10 10:25:52 volumio sudo[7335]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio volumio[6879]: info: QobuzConnect: Starting Qobuz Connect socket and service Sep 10 10:25:52 volumio volumio[6879]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Sep 10 10:25:52 volumio volumio[6879]: info: Stopping AccessToken refresher cron Sep 10 10:25:52 volumio sudo[7345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Sep 10 10:25:52 volumio systemd[1]: mpd.service: Succeeded. Sep 10 10:25:52 volumio systemd[1]: Stopped Music Player Daemon. Sep 10 10:25:52 volumio systemd[1]: Starting Music Player Daemon... Sep 10 10:25:52 volumio sudo[7345]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio volumio[6879]: info: AccessToken refresher cron started Sep 10 10:25:52 volumio volumio[6879]: info: Adding TIDAL REST API Endpoints Sep 10 10:25:52 volumio volumio[6879]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Sep 10 10:25:52 volumio sudo[7345]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio volumio[6879]: info: MPD Permissions set Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 10 10:25:52 volumio sudo[7356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:52 volumio sudo[7356]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio sudo[7349]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 10 10:25:52 volumio sudo[7349]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:52 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Sep 10 10:25:52 volumio qobuz-connect[4496]: 20250910 10:25:52.944 [4496.4496] INFO SampleApp: Stopping Local configuration server Sep 10 10:25:52 volumio sudo[7349]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio systemd[1]: qobuz-connect.service: Succeeded. Sep 10 10:25:52 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Sep 10 10:25:52 volumio systemd[1]: Started Volumio Qobuz Connect Service. Sep 10 10:25:52 volumio sudo[7356]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:52 volumio volumio[6879]: info: Access Token successfully retrieved Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 10 10:25:52 volumio volumio[6879]: info: [1757492752992] CoreMusicLibrary::Adding element QOBUZ Sep 10 10:25:52 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:25:52 volumio volumio[6879]: Cannot find translation for source Radio Paradise Sep 10 10:25:52 volumio volumio[6879]: Cannot find translation for source QOBUZ Sep 10 10:25:53 volumio volumio[6879]: info: Stopping AccessToken refresher cron for QOBUZ Sep 10 10:25:53 volumio volumio[6879]: info: AccessToken refresher cron started for QOBUZ Sep 10 10:25:53 volumio volumio[6879]: info: Adding QOBUZ REST API Endpoints Sep 10 10:25:53 volumio volumio[6879]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Sep 10 10:25:53 volumio volumio[6879]: [Metrics] CommandRouter: 23s 333.10ms Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::volumiosetStartupVolume Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::Close All Modals sent Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::Close All Modals sent Sep 10 10:25:53 volumio sudo[7335]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:53 volumio volumio[6879]: info: Executing endpoint qc_getconfig Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.104 [7374.7374] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Sep 10 10:25:53 volumio volumio[6879]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Sep 10 10:25:53 volumio volumio[6879]: info: QobuzConnect: QOBUZ Connect daemon connected Sep 10 10:25:53 volumio volumio[6879]: info: Bluetooth name changed to Volumio Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.124 [7374.7374] INFO VolumeManager: [0x8082f7f0]: Setting new playback volume: 75 Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.124 [7374.7374] INFO VolumeManager: [0x8082f7f0]: Setting new mute state: 0 Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.124 [7374.7374] INFO QobuzConnect: [0x808301c0]: Client initialized! Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.124 [7374.7374] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.139 [7374.7374] INFO LocalConfigManager: [0x8082f0d0]: Starting Local Configuration server Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.139 [7374.7374] INFO SampleApp: Starting Local configuration server Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.140 [7374.7374] INFO SampleApp: Connected to UNIX socket client 0x80824ed8 Sep 10 10:25:53 volumio volumio[6879]: info: Successfully Added MyVolumio device Sep 10 10:25:53 volumio qobuz-connect[7374]: 20250910 10:25:53.255 [7374.7374] INFO SampleApp: Playback volume changed: 75 Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:53 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:53 volumio volumio[6879]: info: Updating MyVolumio device info Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:53 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:53 volumio volumio[6879]: info: Successfully Updated MyVolumio device Sep 10 10:25:53 volumio mpd[7380]: Sep 10 10:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 10 10:25:54 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 10 10:25:54 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 10 10:25:54 volumio systemd[1]: Started Music Player Daemon. Sep 10 10:25:54 volumio sudo[7319]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:54 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 10 10:25:54 volumio volumio[6879]: error: updateQueue error: null Sep 10 10:25:54 volumio sudo[7403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Sep 10 10:25:54 volumio sudo[7403]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:54 volumio autossh[11630]: received signal to exit (15) Sep 10 10:25:54 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Sep 10 10:25:54 volumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Sep 10 10:25:54 volumio systemd[1]: sshtunnel.service: Succeeded. Sep 10 10:25:54 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Sep 10 10:25:54 volumio systemd[1]: Started MyVolumio SSH Tunnel. Sep 10 10:25:54 volumio sudo[7403]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:54 volumio autossh[7412]: port set to 0, monitoring disabled Sep 10 10:25:54 volumio autossh[7412]: starting ssh (count 1) Sep 10 10:25:54 volumio autossh[7412]: ssh child pid is 7416 Sep 10 10:25:54 volumio volumio[6879]: info: Remote SSH Started Sep 10 10:25:54 volumio volumiossh-tunnel[7409]: Warning: Permanently added '[eu6.myvolumio.org]:2222,[207.154.233.230]:2222' (RSA) to the list of known hosts. Sep 10 10:25:54 volumio volumio[6879]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Sep 10 10:25:54 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:25:54 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:25:55 volumio sudo[7418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Sep 10 10:25:55 volumio sudo[7418]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:25:55 volumio sudo[7418]: pam_unix(sudo:session): session closed for user root Sep 10 10:25:55 volumio volumio[6879]: info: Volumio BT Module successfully started Sep 10 10:25:56 volumio volumio[6879]: info: Setting Geolocation for MyVolumio to eu6 Sep 10 10:25:56 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:57 volumio volumio[6879]: info: Successfully Added MyVolumio device Sep 10 10:25:57 volumio volumio[6879]: info: Updating MyVolumio device info Sep 10 10:25:57 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:57 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:57 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:25:58 volumio volumio[6879]: info: Successfully Updated MyVolumio device Sep 10 10:25:58 volumio volumio[6879]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/radio_paradise/volumio/buster/armhf Sep 10 10:26:00 volumio volumio[6879]: info: BOOT COMPLETED Sep 10 10:26:00 volumio volumio[6879]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/radio_paradise/volumio/buster/armhf Sep 10 10:26:00 volumio volumio[6879]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesRadio Paradise Sep 10 10:26:00 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 10:26:00 volumio volumio[6879]: Cannot find translation for source QOBUZ Sep 10 10:26:00 volumio volumio[6879]: info: Check plugin dependencies Sep 10 10:26:00 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 10 10:26:00 volumio volumio[6879]: info: Rename folder Sep 10 10:26:00 volumio volumio[6879]: info: Folder /tmp/downloaded_plugin.zip removed Sep 10 10:26:00 volumio volumio[6879]: info: Move to category Sep 10 10:26:00 volumio volumio[6879]: info: Checking if install.sh is present Sep 10 10:26:00 volumio volumio[6879]: info: Executing install.sh Sep 10 10:26:00 volumio sudo[7441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/radio_paradise/install.sh Sep 10 10:26:00 volumio sudo[7441]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 10:26:00 volumio sudo[7441]: pam_unix(sudo:session): session closed for user root Sep 10 10:26:00 volumio volumio[6879]: info: Installing radio paradise Dependencies Sep 10 10:26:00 volumio volumio[6879]: Plugin install end detected on script Sep 10 10:26:00 volumio volumio[6879]: info: Install script completed Sep 10 10:26:00 volumio volumio[6879]: info: Done installing plugin. Sep 10 10:26:00 volumio volumio[6879]: info: Enabling plugin radio_paradise Sep 10 10:26:00 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 10 10:26:00 volumio volumio[6879]: info: [{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.13","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.5","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Sep 10 10:26:00 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 10 10:26:00 volumio volumio[6879]: info: Folder /tmp/plugins removed Sep 10 10:26:00 volumio volumio[6879]: info: Folder /tmp/downloaded_plugin.zip removed Sep 10 10:26:00 volumio volumio[6879]: info: Folder /data/temp removed Sep 10 10:26:01 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 10 10:26:01 volumio volumio[6879]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Sep 10 10:26:01 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:26:01 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:26:05 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 10 10:26:05 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 10 10:26:05 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 10 10:26:05 volumio volumio-remote-updater[10190]: No test mode Sep 10 10:26:05 volumio volumio-remote-updater[10190]: No alpha test mode Sep 10 10:26:05 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 10 10:26:05 volumio volumio[6879]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 10 10:26:05 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 10 10:26:06 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:26:06 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 10 10:26:06 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Sep 10 10:26:06 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 10 10:26:06 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 10 10:26:06 volumio volumio[6879]: info: CoreCommandRouter::volumioGetBrowseSources Sep 10 10:26:06 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 10 10:26:18 volumio volumio[6879]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/minidlna/volumio/buster/armhf Sep 10 10:26:18 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 10 10:26:18 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 10 10:26:18 volumio volumio[6879]: info: Discovery: Getting this device information Sep 10 10:26:18 volumio volumio[6879]: info: CoreCommandRouter::volumioGetState Sep 10 10:26:18 volumio volumio[6879]: info: CorePlayQueue::getTrack 0 Sep 10 10:26:18 volumio volumio[6879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 10 10:26:19 volumio volumio[6879]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 10 10:26:19 volumio volumio[6879]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Sep 10 10:26:19 volumio volumio[6879]: code: 'auth/network-request-failed', Sep 10 10:26:19 volumio volumio[6879]: a: null Sep 10 10:26:19 volumio volumio[6879]: } Sep 10 10:26:19 volumio volumio[6879]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 10 10:26:20 volumio sudo[7542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-10 10:25 Sep 10 10:26:20 volumio sudo[7542]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:55:15 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="2f3686ade78abf3b92c180a0c5b20c6b"