-- Logs begin at Fri 2025-04-04 05:07:01 CEST, end at Sun 2025-04-27 21:19:13 CEST. -- Apr 27 21:18:10 volumio systemd-timedated[1032]: Changed local time to Sun Apr 27 21:18:10 2025 Apr 27 21:18:10 volumio sudo[1026]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:10 volumio systemd[1]: Starting Daily man-db regeneration... Apr 27 21:18:10 volumio volumio-time-update[543]: volumio-time-update-util: System time updated successfully. Apr 27 21:18:10 volumio systemd[1]: Starting Daily apt download activities... Apr 27 21:18:10 volumio systemd[1]: Started Volumio Time Update Utility. Apr 27 21:18:10 volumio systemd[1]: man-db.service: Succeeded. Apr 27 21:18:10 volumio systemd[1]: Started Daily man-db regeneration. Apr 27 21:18:11 volumio nmbd[764]: [2025/04/27 21:18:11.441451, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 27 21:18:11 volumio nmbd[764]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 27 21:18:11 volumio systemd[1]: Started Samba NMB Daemon. Apr 27 21:18:11 volumio systemd[1]: Starting Samba Winbind Daemon... Apr 27 21:18:11 volumio kernel: nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead. Apr 27 21:18:11 volumio winbindd[1059]: [2025/04/27 21:18:11.805675, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 27 21:18:11 volumio winbindd[1059]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 27 21:18:11 volumio winbindd[1059]: [2025/04/27 21:18:11.816734, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 27 21:18:11 volumio systemd[1]: Started Samba Winbind Daemon. Apr 27 21:18:11 volumio winbindd[1059]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 27 21:18:11 volumio systemd[1]: Starting Samba SMB Daemon... Apr 27 21:18:11 volumio sh[491]: eth0: leased 192.168.178.46 for 864000 seconds Apr 27 21:18:11 volumio dhcpcd[527]: eth0: leased 192.168.178.46 for 864000 seconds Apr 27 21:18:11 volumio dhcpcd[527]: eth0: adding route to 192.168.178.0/24 Apr 27 21:18:11 volumio sh[491]: eth0: adding route to 192.168.178.0/24 Apr 27 21:18:11 volumio sh[491]: eth0: adding default route via 192.168.178.1 Apr 27 21:18:11 volumio dhcpcd[527]: eth0: adding default route via 192.168.178.1 Apr 27 21:18:11 volumio sh[491]: Warning: The unit file, source configuration file or drop-ins of systemd-timesyncd.service changed on disk. Run 'systemctl daemon-reload' to reload units. Apr 27 21:18:12 volumio systemd[1]: apt-daily.service: Succeeded. Apr 27 21:18:12 volumio systemd[1]: Started Daily apt download activities. Apr 27 21:18:12 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Apr 27 21:18:12 volumio ntpd[1018]: ntpd exiting on signal 15 (Terminated) Apr 27 21:18:12 volumio ntpd[1018]: 192.168.178.1 local addr 192.168.178.46 -> Apr 27 21:18:12 volumio systemd[1]: Stopping Network Time Service... Apr 27 21:18:12 volumio systemd[1]: ntp.service: Succeeded. Apr 27 21:18:12 volumio systemd[1]: Stopped Network Time Service. Apr 27 21:18:12 volumio systemd[1]: Starting Network Time Service... Apr 27 21:18:12 volumio ntpd[1140]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 27 21:18:12 volumio ntpd[1140]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 104:103 Apr 27 21:18:12 volumio systemd[1]: Started Network Time Service. Apr 27 21:18:12 volumio ntpd[1152]: proto: precision = 0.875 usec (-20) Apr 27 21:18:12 volumio ntpd[1152]: Listen and drop on 0 v6wildcard [::]:123 Apr 27 21:18:12 volumio ntpd[1152]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 27 21:18:12 volumio ntpd[1152]: Listen normally on 2 lo 127.0.0.1:123 Apr 27 21:18:12 volumio ntpd[1152]: Listen normally on 3 eth0 192.168.178.46:123 Apr 27 21:18:12 volumio ntpd[1152]: Listening on routing socket on fd #20 for interface updates Apr 27 21:18:12 volumio ntpd[1152]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Apr 27 21:18:12 volumio sh[491]: forked to background, child pid 1154 Apr 27 21:18:12 volumio ntpd[1152]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Apr 27 21:18:12 volumio dhcpcd[527]: forked to background, child pid 1154 Apr 27 21:18:12 volumio smbd[1079]: [2025/04/27 21:18:12.402745, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 27 21:18:12 volumio systemd[1]: Started Samba SMB Daemon. Apr 27 21:18:12 volumio smbd[1079]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 27 21:18:12 volumio ifplugd(eth0)[792]: client: ifup: interface eth0 already configured Apr 27 21:18:12 volumio sh[491]: eth0=eth0 Apr 27 21:18:12 volumio ifplugd(eth0)[792]: Program executed successfully. Apr 27 21:18:12 volumio ifplugd[758]: Network Interface Plugging Daemon...start eth0...done. Apr 27 21:18:12 volumio systemd[1]: Started LSB: Brings up/down network automatically. Apr 27 21:18:12 volumio systemd[1]: Reached target Multi-User System. Apr 27 21:18:12 volumio systemd[1]: Reached target Graphical Interface. Apr 27 21:18:12 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 27 21:18:12 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 27 21:18:12 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 27 21:18:12 volumio volumio[847]: info: Loading plugin "ytcr"... Apr 27 21:18:13 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 27 21:18:13 volumio systemd[1]: Started Daily apt upgrade and clean activities. Apr 27 21:18:13 volumio systemd[1]: Startup finished in 14.259s (kernel) + 16.633s (userspace) = 30.892s. Apr 27 21:18:14 volumio volumio[847]: info: Loading plugin "ytmusic"... Apr 27 21:18:15 volumio volumio[847]: info: Loading plugin "outputs"... Apr 27 21:18:15 volumio volumio[847]: info: Loading plugin "albumart"... Apr 27 21:18:15 volumio volumio[847]: info: Plugin example_plugin is not enabled Apr 27 21:18:15 volumio volumio[847]: info: Loading plugin "inputs"... Apr 27 21:18:15 volumio volumio[847]: info: Loading plugin "updater_comm"... Apr 27 21:18:15 volumio volumio[847]: info: Plugin mpdemulation is not enabled Apr 27 21:18:15 volumio volumio[847]: info: Loading plugin "rest_api"... Apr 27 21:18:15 volumio volumio[847]: info: Loading plugin "websocket"... Apr 27 21:18:15 volumio volumio[847]: info: Starting Socket.io Server version 2.3.0 Apr 27 21:18:15 volumio volumio[847]: info: Plugin fusiondsp is not enabled Apr 27 21:18:15 volumio volumio[847]: info: Plugin minidlna is not enabled Apr 27 21:18:15 volumio volumio[847]: info: Loading i18n strings for locale de Apr 27 21:18:15 volumio volumio[847]: Updating browse sources language Apr 27 21:18:15 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:15 volumio volumio[847]: Forking 3 albumart workers Apr 27 21:18:15 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::initPlayerControls Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 21:18:16 volumio volumio[847]: Express server listening on port 3000 Apr 27 21:18:16 volumio volumio[847]: [Metrics] WebUI: 13s 176.97ms Apr 27 21:18:16 volumio volumio[847]: info: CoreStateMachine::resetVolumioState Apr 27 21:18:16 volumio volumio[847]: info: CoreStateMachine::getcurrentVolume Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:16 volumio volumio[847]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 27 21:18:16 volumio volumio[847]: info: Completed loading Core Plugins Apr 27 21:18:16 volumio volumio[847]: info: Preparing to generate the ALSA configuration file Apr 27 21:18:16 volumio volumio[847]: info: Volumio Network Manager: Network status updated: 0 Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 21:18:16 volumio volumio[847]: info: Discovery: Getting this device information Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:16 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 21:18:16 volumio volumio[847]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Apr 27 21:18:16 volumio volumio[847]: info: VolumeController:: Volume=20 Mute =false Apr 27 21:18:16 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:16 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:16 volumio volumio[847]: info: CoreStateMachine::updateTrackBlock Apr 27 21:18:16 volumio volumio[847]: info: CorePlayQueue::getTrackBlock Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 21:18:16 volumio volumio[847]: info: Setting Device type: Tinkerboard Apr 27 21:18:16 volumio volumio[847]: info: CoreStateMachine::setRepeat false single undefined Apr 27 21:18:16 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:16 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:16 volumio volumio[847]: info: CoreStateMachine::setRandom true Apr 27 21:18:16 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:16 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:16 volumio volumio[847]: Starting albumart workers Apr 27 21:18:16 volumio volumio[847]: Starting albumart workers Apr 27 21:18:16 volumio volumio[847]: info: Asound.conf file unchanged, so no further update is needed Apr 27 21:18:16 volumio volumio[847]: info: Output device has changed, restarting MPD Apr 27 21:18:16 volumio volumio[847]: Starting albumart workers Apr 27 21:18:16 volumio volumio[847]: info: ___________ START PLUGINS ___________ Apr 27 21:18:16 volumio sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 21:18:16 volumio sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 21:18:16 volumio volumio[847]: error: Plugin ampswitch failed to start! Error: EINVAL: invalid argument, write Apr 27 21:18:16 volumio kernel: rockchip-pinctrl pinctrl: pin 0 is unrouted Apr 27 21:18:16 volumio volumio[847]: info: ControllerMpd::onStart: Initializing MPD Apr 27 21:18:16 volumio volumio[847]: info: Creating MPD Configuration file Apr 27 21:18:16 volumio sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:16 volumio sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:16 volumio sudo[1266]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:16 volumio systemd[1]: Stopping Music Player Daemon... Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 21:18:16 volumio volumio[847]: info: [1745781496802] CoreMusicLibrary::Adding element Medienserver Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 21:18:16 volumio volumio[847]: info: [1745781496853] CoreMusicLibrary::Adding element Last_100 Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 21:18:16 volumio volumio[847]: info: [1745781496857] CoreMusicLibrary::Adding element Webradio Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:16 volumio sudo[1297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 21:18:16 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 21:18:16 volumio volumio[847]: info: Initializing BBC Radios Apr 27 21:18:16 volumio sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 21:18:16 volumio sudo[1297]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:16 volumio sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:16 volumio sudo[1297]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 21:18:17 volumio volumio[847]: info: [1745781497089] CoreMusicLibrary::Adding element Mixcloud Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source Mixcloud Apr 27 21:18:17 volumio systemd[1]: mpd.service: Succeeded. Apr 27 21:18:17 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 21:18:17 volumio systemd[1]: Starting Music Player Daemon... Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 21:18:17 volumio volumio[847]: info: [1745781497113] CoreMusicLibrary::Adding element SoundCloud Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source Mixcloud Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source SoundCloud Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 21:18:17 volumio volumio[847]: info: [1745781497133] CoreMusicLibrary::Adding element YouTube2 Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source Mixcloud Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source SoundCloud Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source YouTube2 Apr 27 21:18:17 volumio sudo[1332]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 21:18:17 volumio sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 21:18:17 volumio volumio[847]: info: [1745781497253] CoreMusicLibrary::Adding element YouTube Music Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source Mixcloud Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source SoundCloud Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source YouTube2 Apr 27 21:18:17 volumio volumio[847]: Cannot find translation for source YouTube Music Apr 27 21:18:17 volumio volumio[847]: info: Volumio Calling Home Apr 27 21:18:17 volumio sudo[1332]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:17 volumio volumio[847]: info: Volumio Network Manager: Network status updated: 1 Apr 27 21:18:17 volumio sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 21:18:17 volumio sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 21:18:17 volumio sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:17 volumio sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:17 volumio sudo[1370]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:17 volumio volumio[847]: info: Volumio called home Apr 27 21:18:17 volumio volumio[847]: info: MPD Permissions set Apr 27 21:18:17 volumio volumio[847]: info: MPD Permissions set Apr 27 21:18:17 volumio sudo[1372]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:17 volumio volumio[847]: info: Discovery: adding 009929a0-f413-4a13-a312-90def98326b0 Apr 27 21:18:17 volumio volumio[847]: info: Discovery: Found device Volumio Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:17 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:17 volumio volumio[847]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Apr 27 21:18:17 volumio volumio[847]: info: VolumeController:: Volume=20 Mute =false Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:17 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:17 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:17 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 21:18:17 volumio volumio-remote-updater[555]: [2025-04-27 21:18:17] [connect] Successful connection Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:17 volumio volumio[847]: info: Discovery: A device disappeared from network Apr 27 21:18:17 volumio volumio[847]: info: Discovery: Device volumio disappeared from network Apr 27 21:18:17 volumio volumio-remote-updater[555]: [2025-04-27 21:18:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745781497 101 Apr 27 21:18:17 volumio volumio[847]: 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 Apr 27 21:18:17 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:17 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:18 volumio sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 27 21:18:18 volumio sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:18 volumio volumio[847]: info: Discovery: adding 009929a0-f413-4a13-a312-90def98326b0 Apr 27 21:18:18 volumio volumio[847]: info: Discovery: Found device Volumio Apr 27 21:18:18 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:18 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:18 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 27 21:18:18 volumio sudo[1404]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:18 volumio volumio[847]: info: Upmpdcli Daemon Started Apr 27 21:18:18 volumio volumio[847]: info: [yt-cast-receiver] DIAL server listening on port 8098 Apr 27 21:18:18 volumio mpd[1368]: Apr 27 21:18 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 27 21:18:18 volumio systemd[1]: Started Music Player Daemon. Apr 27 21:18:18 volumio sudo[1267]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:18 volumio sudo[1304]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:18 volumio volumio[847]: info: Completed starting Core Plugins Apr 27 21:18:18 volumio volumio[847]: info: ------------------------------------------- Apr 27 21:18:18 volumio volumio[847]: info: ----- MyVolumio plugins startup ---- Apr 27 21:18:18 volumio volumio[847]: info: ------------------------------------------- Apr 27 21:18:18 volumio volumio[847]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 27 21:18:18 volumio volumio[847]: error: updateQueue error: null Apr 27 21:18:18 volumio volumio[847]: error: updateQueue error: null Apr 27 21:18:18 volumio volumio[847]: info: MPD running with PID1368 Apr 27 21:18:18 volumio volumio[847]: ,establishing connection Apr 27 21:18:18 volumio volumio[1410]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 27 21:18:18 volumio volumio[847]: error: updateQueue error: null Apr 27 21:18:22 volumio volumio[1410]: ............................++++ Apr 27 21:18:24 volumio volumio[1410]: ...................................++++ Apr 27 21:18:24 volumio volumio[1410]: e is 65537 (0x010001) Apr 27 21:18:24 volumio volumio[1410]: writing RSA key Apr 27 21:18:24 volumio volumio[847]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 27 21:18:28 volumio volumio[847]: info: Adding plugin bluetooth to MyMusic Plugins Apr 27 21:18:28 volumio volumio[847]: info: Adding plugin multiroom to MyMusic Plugins Apr 27 21:18:28 volumio volumio[847]: info: Adding plugin metavolumio to MyMusic Plugins Apr 27 21:18:28 volumio volumio[847]: info: Adding plugin cd_controller to MyMusic Plugins Apr 27 21:18:28 volumio volumio[847]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 27 21:18:28 volumio volumio[847]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 27 21:18:28 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 27 21:18:29 volumio volumio[847]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 27 21:18:29 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 27 21:18:29 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:29 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:29 volumio volumio[847]: info: Starting MyVolumio Remote Streaming Endpoints Apr 27 21:18:29 volumio volumio[847]: info: MyVolumio login type: Token Apr 27 21:18:29 volumio volumio[847]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 27 21:18:29 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 27 21:18:29 volumio systemd[1]: systemd-fsckd.service: Succeeded. Apr 27 21:18:30 volumio volumio[847]: info: Starting Streaming Service Transparent Proxy Apr 27 21:18:30 volumio volumio[847]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 27 21:18:30 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 27 21:18:30 volumio volumio[847]: info: Streaming services startup Apr 27 21:18:30 volumio volumio[847]: info: Starting Streaming Daemon Apr 27 21:18:30 volumio sudo[1478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 27 21:18:30 volumio sudo[1478]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:30 volumio volumio[847]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 27 21:18:30 volumio sudo[1478]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:30 volumio volumio[847]: error: Cannot start Volumio Streaming Daemon Apr 27 21:18:30 volumio volumio[847]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 27 21:18:30 volumio volumio[847]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 27 21:18:30 volumio volumio[847]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 27 21:18:31 volumio volumio[847]: STREAMING PROXY: Starting server on port 3245 Apr 27 21:18:31 volumio volumio[847]: Node JS runtime: 14 Apr 27 21:18:31 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Apr 27 21:18:31 volumio volumio[847]: info: MyVolumio token set successfully Apr 27 21:18:31 volumio volumio[847]: info: MYVOLUMIO: Adding device Apr 27 21:18:31 volumio volumio[847]: info: MYVOLUMIO: Evaluating Server Apr 27 21:18:32 volumio volumio[847]: info: MyVolumio Plan changed: superstar Apr 27 21:18:32 volumio volumio[847]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Apr 27 21:18:32 volumio volumio[847]: info: Adding audio output: Apr 27 21:18:32 volumio volumio[847]: info: MYVOLUMIO: Adding device Apr 27 21:18:32 volumio volumio[847]: info: MYVOLUMIO: Evaluating Server Apr 27 21:18:32 volumio volumio[847]: info: Remote config written successfully Apr 27 21:18:32 volumio volumio[847]: info: Starting Tunnel 1 Apr 27 21:18:32 volumio volumio[847]: info: Starting Tunnel Connection Checker Apr 27 21:18:32 volumio volumio[847]: info: Completed starting MyVolumio Plugin Apr 27 21:18:32 volumio volumio[847]: info: MYVolumio Device enabled Apr 27 21:18:32 volumio volumio[847]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 27 21:18:32 volumio volumio[847]: info: MyVolumio status changed Apr 27 21:18:32 volumio volumio[847]: info: Streaming services startup Apr 27 21:18:32 volumio volumio[847]: info: Starting Streaming Daemon Apr 27 21:18:32 volumio volumio[847]: info: Setting Geolocation for MyVolumio to eu4 Apr 27 21:18:32 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:32 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:32 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:32 volumio sudo[1535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 27 21:18:32 volumio sudo[1535]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:32 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 27 21:18:32 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 27 21:18:32 volumio sudo[1535]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:32 volumio volumio[847]: info: [1745781512755] Starting BluetoothController Apr 27 21:18:32 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Apr 27 21:18:33 volumio volumio[847]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Apr 27 21:18:33 volumio sudo[1545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 27 21:18:33 volumio sudo[1545]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:33 volumio sudo[1545]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio volumio[847]: info: MRS: MultiRoom plugin initialized Apr 27 21:18:34 volumio volumio[847]: info: MRS: STOPPING SNAPCLIENT Apr 27 21:18:34 volumio volumio[847]: info: MRS: Snap server stop Apr 27 21:18:34 volumio volumio[847]: info: MRS: STOPPING volumioStreaming Apr 27 21:18:34 volumio sudo[1568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 27 21:18:34 volumio sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio sudo[1571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Apr 27 21:18:34 volumio sudo[1571]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio sudo[1576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 27 21:18:34 volumio sudo[1576]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio sudo[1568]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Apr 27 21:18:34 volumio sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 27 21:18:34 volumio sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio sudo[1584]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio sudo[1571]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio sudo[1576]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 27 21:18:34 volumio volumio[847]: info: Preparing to generate the ALSA configuration file Apr 27 21:18:34 volumio volumio[847]: info: Updating MyVolumio device info Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: Setting Geolocation for MyVolumio to eu10 Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: MRS: Removed streaming files Apr 27 21:18:34 volumio volumio[847]: info: MRS: volumioStreaming STOPPED Apr 27 21:18:34 volumio volumio[847]: info: MRS: SNAPSERVER STOPPED Apr 27 21:18:34 volumio volumio[847]: info: MRS: SNAPCLIENT STOPPED Apr 27 21:18:34 volumio volumio[847]: error: Cannot start Volumio Streaming Daemon Apr 27 21:18:34 volumio volumio[847]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 27 21:18:34 volumio volumio[847]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 27 21:18:34 volumio volumio[847]: info: Cleared local playlist file: /data/playlist/undefined Apr 27 21:18:34 volumio volumio[847]: error: Cannot delete local playlist /data/playlist/undefined : Error: ENOENT: no such file or directory, unlink '/data/playlist/undefined' Apr 27 21:18:34 volumio volumio[847]: info: Asound.conf file unchanged, so no further update is needed Apr 27 21:18:34 volumio volumio[847]: info: Output device has changed, restarting MPD Apr 27 21:18:34 volumio sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 21:18:34 volumio volumio[847]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio sudo[1612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 21:18:34 volumio sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 21:18:34 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio sudo[1608]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Plugin metavolumio disabled by user. Not starting Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Apr 27 21:18:34 volumio volumio[847]: info: Adding inputs REST Endpoints Apr 27 21:18:34 volumio volumio[847]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 27 21:18:34 volumio volumio[847]: info: Scanning Audio Inputs Apr 27 21:18:34 volumio systemd[1]: Stopping Music Player Daemon... Apr 27 21:18:34 volumio sudo[1625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Apr 27 21:18:34 volumio sudo[1625]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio volumio[847]: info: Checking against Known Cards name Apr 27 21:18:34 volumio volumio[847]: info: Checking against Known Cards name Apr 27 21:18:34 volumio volumio[847]: info: Checking against Known Cards name Apr 27 21:18:34 volumio volumio[847]: info: Adding Server instance for streaming Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Apr 27 21:18:34 volumio volumio[847]: error: Hi Res Audio Failed Login: Missing Login Data Apr 27 21:18:34 volumio volumio[847]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 27 21:18:34 volumio volumio[847]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Apr 27 21:18:34 volumio volumio[847]: info: Refreshing TIDAL token Apr 27 21:18:34 volumio systemd[1]: mpd.service: Succeeded. Apr 27 21:18:34 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Apr 27 21:18:34 volumio systemd[1]: Starting Music Player Daemon... Apr 27 21:18:34 volumio volumio[847]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 27 21:18:34 volumio volumio[847]: info: Stopping AccessToken refresher cron for QOBUZ Apr 27 21:18:34 volumio sudo[1637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 27 21:18:34 volumio sudo[1637]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio volumio[847]: info: AccessToken refresher cron started for QOBUZ Apr 27 21:18:34 volumio volumio[847]: info: Adding QOBUZ REST API Endpoints Apr 27 21:18:34 volumio volumio[847]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 27 21:18:34 volumio sudo[1637]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio volumio[847]: info: MPD Permissions set Apr 27 21:18:34 volumio sudo[1635]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:34 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:34 volumio sudo[1635]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 21:18:34 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:34 volumio volumio[847]: info: Successfully Added MyVolumio device Apr 27 21:18:34 volumio sudo[1625]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:34 volumio volumio[847]: info: Bluetooth name changed to Volumio Apr 27 21:18:35 volumio volumio[847]: info: Access Token successfully retrieved Apr 27 21:18:35 volumio volumio[847]: info: Successfully Updated MyVolumio device Apr 27 21:18:35 volumio volumio[847]: info: Successfully Added MyVolumio device Apr 27 21:18:35 volumio volumio[847]: info: Successfully retrieved User Session From TIDAL Apr 27 21:18:35 volumio volumio[847]: info: Updating MyVolumio device info Apr 27 21:18:35 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:35 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:35 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:35 volumio volumio[847]: info: Successfully retrieved User Subscription From TIDAL Apr 27 21:18:35 volumio volumio[847]: info: Adding TIDAL to Browse Sources Apr 27 21:18:35 volumio volumio[847]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 21:18:35 volumio volumio[847]: info: [1745781515454] CoreMusicLibrary::Adding element TIDAL Apr 27 21:18:35 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:35 volumio volumio[847]: Cannot find translation for source Mixcloud Apr 27 21:18:35 volumio volumio[847]: Cannot find translation for source SoundCloud Apr 27 21:18:35 volumio volumio[847]: Cannot find translation for source YouTube2 Apr 27 21:18:35 volumio volumio[847]: Cannot find translation for source YouTube Music Apr 27 21:18:35 volumio volumio[847]: Cannot find translation for source TIDAL Apr 27 21:18:35 volumio volumio[847]: info: Stopping AccessToken refresher cron Apr 27 21:18:35 volumio volumio[847]: info: AccessToken refresher cron started Apr 27 21:18:35 volumio volumio[847]: info: Adding TIDAL REST API Endpoints Apr 27 21:18:35 volumio volumio[847]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 27 21:18:35 volumio volumio[847]: info: Successfully Updated MyVolumio device Apr 27 21:18:35 volumio mpd[1661]: Apr 27 21:18 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 27 21:18:35 volumio systemd[1]: Started Music Player Daemon. Apr 27 21:18:35 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:35 volumio volumio[847]: error: updateQueue error: null Apr 27 21:18:37 volumio sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 27 21:18:37 volumio sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:37 volumio systemd[1]: Started MyVolumio SSH Tunnel. Apr 27 21:18:37 volumio sudo[1675]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:37 volumio volumio[847]: info: Remote SSH Started Apr 27 21:18:37 volumio autossh[1683]: port set to 0, monitoring disabled Apr 27 21:18:37 volumio autossh[1683]: starting ssh (count 1) Apr 27 21:18:37 volumio autossh[1683]: ssh child pid is 1688 Apr 27 21:18:37 volumio volumiossh-tunnel[1681]: Warning: Permanently added '[eu10.myvolumio.org]:2222,[46.101.141.203]:2222' (RSA) to the list of known hosts. Apr 27 21:18:37 volumio volumio[847]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Apr 27 21:18:37 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:37 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:37 volumio sudo[1690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 27 21:18:37 volumio sudo[1690]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:37 volumio systemd[1]: Started Volumio Bluetooth Module. Apr 27 21:18:37 volumio sudo[1690]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:37 volumio volumio[847]: info: Volumio BT Module successfully started Apr 27 21:18:37 volumio sudo[1698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 27 21:18:37 volumio sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:37 volumio volumiobt[1696]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 27 21:18:37 volumio sudo[1698]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:37 volumio volumio[847]: info: TidalConnect service stoped! Apr 27 21:18:37 volumio volumio[847]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 27 21:18:37 volumio volumio[847]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 27 21:18:37 volumio sudo[1719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 27 21:18:37 volumio sudo[1719]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:37 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 27 21:18:37 volumio sudo[1719]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:38 volumio volumio[847]: info: Executing endpoint tc_getconfig Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 27 21:18:38 volumio vtcs[1739]: STARTING TidalConnect services, version: 1.5.0.45 Apr 27 21:18:38 volumio vtcs[1739]: STARTED TidalConnect services. Apr 27 21:18:38 volumio volumio[847]: info: Executing endpoint tc_connect Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 27 21:18:38 volumio volumio[847]: info: Connecting to TidalConnect Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::servicePushState Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:38 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:38 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:38 volumio volumio[847]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 27 21:18:38 volumio volumio[847]: verbose: CURRENT POSITION 0 Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::syncState stateService stop Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus stop Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:38 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:38 volumio volumio[847]: info: No code Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:38 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::servicePushState Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:38 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:38 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:38 volumio volumio[847]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 27 21:18:38 volumio volumio[847]: verbose: CURRENT POSITION 0 Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::syncState stateService stop Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus stop Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:38 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:38 volumio volumio[847]: info: No code Apr 27 21:18:38 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:38 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:38 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:38 volumio sudo[1761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 27 21:18:38 volumio sudo[1761]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:38 volumio volumiobt[1696]: pulseaudio: no process found Apr 27 21:18:38 volumio sudo[1761]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:38 volumio dbus-daemon[532]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.17' (uid=1000 pid=1772 comm="/usr/bin/pulseaudio --high-priority=true ") Apr 27 21:18:38 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 27 21:18:38 volumio kernel: IPVS: Creating netns size=1496 id=3 Apr 27 21:18:38 volumio kernel: IPVS: ftp: loaded support on port[0] = 21 Apr 27 21:18:38 volumio volumio[847]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 21:18:38 volumio dbus-daemon[532]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 27 21:18:38 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 27 21:18:38 volumio rtkit-daemon[1773]: Successfully called chroot. Apr 27 21:18:38 volumio rtkit-daemon[1773]: Successfully dropped privileges. Apr 27 21:18:38 volumio rtkit-daemon[1773]: Successfully limited resources. Apr 27 21:18:38 volumio rtkit-daemon[1773]: Running. Apr 27 21:18:38 volumio rtkit-daemon[1773]: Watchdog thread running. Apr 27 21:18:38 volumio rtkit-daemon[1773]: Canary thread running. Apr 27 21:18:38 volumio dbus-daemon[532]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.18' (uid=0 pid=1773 comm="/usr/lib/rtkit/rtkit-daemon ") Apr 27 21:18:38 volumio systemd[1]: Starting Authorization Manager... Apr 27 21:18:38 volumio volumio[847]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 21:18:38 volumio polkitd[1777]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 27 21:18:38 volumio dbus-daemon[532]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 27 21:18:38 volumio systemd[1]: Started Authorization Manager. Apr 27 21:18:39 volumio pulseaudio[1772]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 27 21:18:39 volumio pulseaudio[1772]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 27 21:18:39 volumio volumiobt[1696]: Applying permissions Apr 27 21:18:39 volumio volumiobt[1696]: Setting BT discoverable and pairable Apr 27 21:18:39 volumio bluetoothd[594]: Endpoint registered: sender=:1.38 path=/MediaEndpoint/A2DPSource Apr 27 21:18:39 volumio bluetoothd[594]: Endpoint registered: sender=:1.38 path=/MediaEndpoint/A2DPSink Apr 27 21:18:39 volumio pulseaudio[1772]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Apr 27 21:18:39 volumio volumiobt[1696]: Agent registered Apr 27 21:18:39 volumio volumiobt[1696]: [bluetooth]# -e power on Apr 27 21:18:39 volumio volumiobt[1696]: Invalid command in menu main: -e Apr 27 21:18:39 volumio volumiobt[1696]: Apr 27 21:18:39 volumio volumiobt[1696]: Use "help" for a list of available commands in a menu. Apr 27 21:18:39 volumio volumiobt[1696]: Use "menu " if you want to enter any submenu. Apr 27 21:18:39 volumio volumiobt[1696]: Use "back" if you want to return to menu main. Apr 27 21:18:39 volumio volumiobt[1696]: [bluetooth]# agent on Apr 27 21:18:39 volumio volumiobt[1696]: Agent is already registered Apr 27 21:18:39 volumio volumiobt[1696]: [bluetooth]# discoverable on Apr 27 21:18:39 volumio volumiobt[1696]: [bluetooth]# pairable on Apr 27 21:18:39 volumio volumiobt[1696]: [bluetooth]# agent NoInputNoOutput Apr 27 21:18:39 volumio volumiobt[1696]: Agent is already registered Apr 27 21:18:39 volumio volumiobt[1696]: [bluetooth]# default-agent Apr 27 21:18:39 volumio volumiobt[1696]: [bluetooth]# quit Apr 27 21:18:39 volumio volumiobt[1696]: [59B blob data] Apr 27 21:18:40 volumio volumio[847]: info: TidalConnect service started! Apr 27 21:18:40 volumio volumio[847]: [Metrics] CommandRouter: 36s 132.26ms Apr 27 21:18:40 volumio volumio[847]: info: CoreCommandRouter::volumiosetStartupVolume Apr 27 21:18:40 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:40 volumio volumio[847]: info: VolumeController:: Setting startup Volume 20 Apr 27 21:18:40 volumio volumio[847]: info: VolumeController::SetAlsaVolume20 Apr 27 21:18:40 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:40 volumio volumio[847]: info: CoreCommandRouter::Close All Modals sent Apr 27 21:18:40 volumio volumio[847]: info: CoreCommandRouter::Close All Modals sent Apr 27 21:18:40 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:40 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:40 volumio volumio[847]: info: CoreStateMachine::pushState Apr 27 21:18:40 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:40 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Apr 27 21:18:41 volumio systemd[1]: systemd-timedated.service: Succeeded. Apr 27 21:18:41 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 27 21:18:41 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 27 21:18:42 volumio volumio[847]: xcb_connection_has_error() returned true Apr 27 21:18:42 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 27 21:18:44 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 21:18:44 volumio volumio[847]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Apr 27 21:18:44 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:44 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:47 volumio volumio[847]: info: BOOT COMPLETED Apr 27 21:18:48 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 21:18:48 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 21:18:48 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 21:18:48 volumio volumio-remote-updater[555]: No test mode Apr 27 21:18:48 volumio volumio-remote-updater[555]: No alpha test mode Apr 27 21:18:48 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 27 21:18:48 volumio volumio[847]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 27 21:18:48 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 27 21:18:49 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:49 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 21:18:49 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 27 21:18:49 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 27 21:18:49 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 27 21:18:49 volumio volumio[847]: info: CoreCommandRouter::volumioGetBrowseSources Apr 27 21:18:49 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 21:18:53 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 21:18:53 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 21:18:53 volumio volumio[847]: info: Discovery: Getting this device information Apr 27 21:18:53 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:53 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:53 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 21:18:53 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.178.46:3000 from 192.168.178.38 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Apr 27 21:18:53 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:53 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:53 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 27 21:18:53 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 27 21:18:56 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:56 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:56 volumio sudo[1817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 21:18:56 volumio sudo[1817]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:56 volumio sudo[1820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 21:18:56 volumio sudo[1817]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:56 volumio sudo[1820]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:56 volumio sudo[1820]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:57 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 21:18:57 volumio volumio[847]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:57 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 21:18:57 volumio sudo[1837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 21:18:57 volumio sudo[1840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 21:18:57 volumio sudo[1837]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:57 volumio sudo[1837]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:57 volumio sudo[1840]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 21:18:57 volumio sudo[1840]: pam_unix(sudo:session): session closed for user root Apr 27 21:18:57 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.178.46 from 192.168.178.38 UA: Mozilla/5.0 (Linux; Android 15; 2406APNFAG Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.49 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:18:57 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 21:18:57 volumio volumio[847]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 27 21:18:57 volumio volumio[847]: info: Listing playlists Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 27 21:18:57 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 21:18:59 volumio volumio[847]: info: CoreCommandRouter::volumioGetQueue Apr 27 21:18:59 volumio volumio[847]: info: CoreStateMachine::getQueue Apr 27 21:18:59 volumio volumio[847]: info: CorePlayQueue::getQueue Apr 27 21:19:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 21:19:01 volumio volumio[847]: info: Received Get System Info Apr 27 21:19:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 21:19:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 21:19:01 volumio volumio[847]: info: Discovery: Getting this device information Apr 27 21:19:01 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Apr 27 21:19:01 volumio volumio[847]: info: CorePlayQueue::getTrack 0 Apr 27 21:19:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 21:19:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 21:19:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 27 21:19:13 volumio volumio[847]: info: Starting Uninstall of plugin system_controller - ampswitch Apr 27 21:19:13 volumio volumio[847]: info: Uninstalling plugin ampswitch Apr 27 21:19:13 volumio volumio[847]: info: [ASDebug] Port: 24 Apr 27 21:19:13 volumio volumio[847]: info: [ASDebug] Inverted: false Apr 27 21:19:13 volumio volumio[847]: info: [ASDebug] Delay: 720 Apr 27 21:19:13 volumio volumio[847]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 21:19:13 volumio volumio[847]: TypeError: Cannot read property 'unexport' of undefined Apr 27 21:19:13 volumio volumio[847]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Apr 27 21:19:13 volumio volumio[847]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Apr 27 21:19:13 volumio volumio[847]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Apr 27 21:19:13 volumio volumio[847]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Apr 27 21:19:13 volumio volumio[847]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22) Apr 27 21:19:13 volumio volumio[847]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1260:45) Apr 27 21:19:13 volumio volumio[847]: at Socket.emit (events.js:400:28) Apr 27 21:19:13 volumio volumio[847]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Apr 27 21:19:13 volumio volumio[847]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Apr 27 21:19:13 volumio volumio[847]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 21:19:13 volumio sudo[1934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-27 21:18 Apr 27 21:19:13 volumio sudo[1934]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:14:40 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="a9bbde8819c9c7e405795a261e2a2f93"