-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-04-26 23:54:17 CEST. -- Apr 26 23:53:00 volumio wireless.js[644]: trying... Apr 26 23:53:00 volumio sudo[1127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 23:53:00 volumio sudo[1127]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:00 volumio sudo[1127]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:01 volumio wireless.js[644]: trying... Apr 26 23:53:01 volumio sudo[1130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 23:53:01 volumio sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:01 volumio sudo[1130]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:02 volumio wireless.js[644]: trying... Apr 26 23:53:02 volumio sudo[1133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 23:53:02 volumio sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:02 volumio sudo[1133]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:03 volumio wireless.js[644]: trying... Apr 26 23:53:03 volumio sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 23:53:03 volumio sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:03 volumio sudo[1136]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:03 volumio dhcpcd[691]: wlan0: using static address 192.168.1.15/24 Apr 26 23:53:03 volumio avahi-daemon[652]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.15. Apr 26 23:53:03 volumio avahi-daemon[652]: New relevant interface wlan0.IPv4 for mDNS. Apr 26 23:53:03 volumio dhcpcd[691]: wlan0: adding route to 192.168.1.0/24 Apr 26 23:53:03 volumio avahi-daemon[652]: Registering new address record for 192.168.1.15 on wlan0.IPv4. Apr 26 23:53:03 volumio dhcpcd[691]: wlan0: adding default route via 192.168.1.1 Apr 26 23:53:04 volumio wireless.js[644]: trying... Apr 26 23:53:04 volumio sudo[1159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 23:53:04 volumio sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:04 volumio sudo[1159]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:04 volumio wireless.js[644]: Connected to: ----EOLO - P1 Apr 26 23:53:04 volumio wireless.js[644]: ---- Apr 26 23:53:04 volumio sudo[1162]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 23:53:04 volumio sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:04 volumio sudo[1162]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:04 volumio wireless.js[644]: ... joined AP, wlan0 IPv4 is 192.168.1.15, ipV6 is undefined Apr 26 23:53:04 volumio wireless.js[644]: It's done! AP Apr 26 23:53:04 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 26 23:53:04 volumio systemd[1]: Started Wireless Services. Apr 26 23:53:04 volumio systemd[1]: Started Volumio Backend Module. Apr 26 23:53:04 volumio systemd[1]: Started Volumio Cpu Tweaker. Apr 26 23:53:04 volumio systemd[1]: Reached target Multi-User System. Apr 26 23:53:04 volumio systemd[1]: Reached target Graphical Interface. Apr 26 23:53:04 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 26 23:53:04 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 26 23:53:04 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 26 23:53:04 volumio systemd[1]: Startup finished in 14.084s (kernel) + 31.573s (userspace) = 45.658s. Apr 26 23:53:04 volumio volumio-cpu-tweak[1168]: Setting RT Priority for mpd Apr 26 23:53:04 volumio volumio-cpu-tweak[1168]: Setting MPD Affinity Apr 26 23:53:04 volumio volumio-cpu-tweak[1168]: pid 825's current affinity mask: f Apr 26 23:53:04 volumio volumio-cpu-tweak[1168]: pid 825's new affinity mask: 3 Apr 26 23:53:04 volumio volumio-cpu-tweak[1168]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Apr 26 23:53:04 volumio volumio-cpu-tweak[1168]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Apr 26 23:53:04 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Apr 26 23:53:05 volumio ntpd[802]: Listen normally on 4 wlan0 192.168.1.15:123 Apr 26 23:53:05 volumio ntpd[802]: new interface(s) found: waking up resolver Apr 26 23:53:06 volumio volumio-remote-updater[640]: [2025-04-26 23:53:06] [connect] Successful connection Apr 26 23:53:07 volumio volumio[1167]: info: ------------------------------------------- Apr 26 23:53:07 volumio volumio[1167]: info: ----- Volumio3 ---- Apr 26 23:53:07 volumio volumio[1167]: info: ------------------------------------------- Apr 26 23:53:07 volumio volumio[1167]: info: ----- System startup ---- Apr 26 23:53:07 volumio volumio[1167]: info: ------------------------------------------- Apr 26 23:53:07 volumio volumio[1167]: info: MYVOLUMIO Environment detected Apr 26 23:53:08 volumio volumio[1167]: info: Plugin folders cleanup Apr 26 23:53:08 volumio volumio[1167]: info: Scanning into folder /volumio/app/plugins/ Apr 26 23:53:08 volumio volumio[1167]: info: Scanning category audio_interface Apr 26 23:53:08 volumio volumio[1167]: info: Scanning category miscellanea Apr 26 23:53:08 volumio volumio[1167]: info: Scanning category music_service Apr 26 23:53:08 volumio volumio[1167]: info: Scanning category plugins.json Apr 26 23:53:08 volumio volumio[1167]: info: Scanning category system_controller Apr 26 23:53:08 volumio volumio[1167]: info: Scanning category user_interface Apr 26 23:53:08 volumio volumio[1167]: info: Scanning into folder /data/plugins/ Apr 26 23:53:08 volumio volumio[1167]: info: Scanning category user_interface Apr 26 23:53:08 volumio volumio[1167]: info: Plugin folders cleanup completed Apr 26 23:53:08 volumio volumio[1167]: info: ------------------------------------------- Apr 26 23:53:08 volumio volumio[1167]: info: ----- Core plugins startup ---- Apr 26 23:53:08 volumio volumio[1167]: info: ------------------------------------------- Apr 26 23:53:08 volumio volumio[1167]: info: Loading plugins from folder /volumio/app/plugins/ Apr 26 23:53:08 volumio volumio[1167]: info: Adding plugin upnp to MyMusic Plugins Apr 26 23:53:08 volumio volumio[1167]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 26 23:53:08 volumio volumio[1167]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 26 23:53:08 volumio volumio[1167]: info: Loading plugins from folder /data/plugins/ Apr 26 23:53:08 volumio volumio[1167]: info: Loading plugin "system"... Apr 26 23:53:08 volumio volumio[1167]: info: Loading plugin "appearance"... Apr 26 23:53:08 volumio systemd[1]: systemd-fsckd.service: Succeeded. Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "network"... Apr 26 23:53:09 volumio volumio[1167]: info: Refreshing Cached IP Addresses Apr 26 23:53:09 volumio sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 26 23:53:09 volumio sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:09 volumio sudo[1202]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:09 volumio sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 23:53:09 volumio sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:09 volumio sudo[1204]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "services"... Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "alsa_controller"... Apr 26 23:53:09 volumio sudo[1213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 26 23:53:09 volumio sudo[1213]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:09 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "wizard"... Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "networkfs"... Apr 26 23:53:09 volumio volumio[1167]: info: Starting Udev Watcher for removable devices Apr 26 23:53:09 volumio sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Vemife22,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/musica /mnt/NAS/Q-NAP Apr 26 23:53:09 volumio sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:09 volumio volumio[1167]: info: Ignoring mount for partition: boot Apr 26 23:53:09 volumio volumio[1167]: info: Ignoring mount for partition: volumio Apr 26 23:53:09 volumio volumio[1167]: info: Ignoring mount for partition: volumio_data Apr 26 23:53:09 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "volumio_command_line_client"... Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "upnp"... Apr 26 23:53:09 volumio volumio[1167]: info: [1745704389661] Starting Upmpd Daemon Apr 26 23:53:09 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "my_music"... Apr 26 23:53:09 volumio volumio[1167]: info: Loading plugin "mpd"... Apr 26 23:53:09 volumio kernel: Key type cifs.spnego registered Apr 26 23:53:09 volumio kernel: Key type cifs.idmap registered Apr 26 23:53:09 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Apr 26 23:53:09 volumio kernel: CIFS: Attempting to mount //192.168.1.10/musica Apr 26 23:53:09 volumio kernel: cryptd: max_cpu_qlen set to 1000 Apr 26 23:53:10 volumio volumio[1167]: info: Loading plugin "upnp_browser"... Apr 26 23:53:10 volumio sudo[1230]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:10 volumio volumio[1167]: info: Loading plugin "alarm-clock"... Apr 26 23:53:10 volumio volumio[1167]: info: Loading plugin "airplay_emulation"... Apr 26 23:53:10 volumio volumio[1167]: info: Starting Shairport Sync Apr 26 23:53:10 volumio volumio[1167]: info: Loading plugin "last_100"... Apr 26 23:53:10 volumio volumio[1167]: info: Loading plugin "webradio"... Apr 26 23:53:10 volumio volumio[1167]: info: Loading plugin "i2s_dacs"... Apr 26 23:53:10 volumio volumio[1167]: info: Loading plugin "volumiodiscovery"... Apr 26 23:53:10 volumio volumio[1167]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 26 23:53:10 volumio volumio[1167]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 26 23:53:10 volumio node[1167]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 26 23:53:10 volumio volumio[1167]: *** WARNING *** For more information see Apr 26 23:53:10 volumio volumio[1167]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 26 23:53:10 volumio volumio[1167]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 26 23:53:10 volumio volumio[1167]: *** WARNING *** For more information see Apr 26 23:53:10 volumio node[1167]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 26 23:53:10 volumio node[1167]: *** WARNING *** For more information see Apr 26 23:53:10 volumio node[1167]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 26 23:53:10 volumio node[1167]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 26 23:53:10 volumio node[1167]: *** WARNING *** For more information see Apr 26 23:53:10 volumio volumio[1167]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 26 23:53:10 volumio volumio[1167]: info: Discovery: Started advertising with name: Volumio Apr 26 23:53:10 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 26 23:53:10 volumio volumio[1167]: info: Loading plugin "now_playing"... Apr 26 23:53:13 volumio sudo[1213]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:13 volumio volumio[1167]: info: Loading plugin "outputs"... Apr 26 23:53:13 volumio volumio[1167]: info: Loading plugin "albumart"... Apr 26 23:53:13 volumio volumio[1167]: info: Plugin example_plugin is not enabled Apr 26 23:53:13 volumio volumio[1167]: info: Loading plugin "inputs"... Apr 26 23:53:13 volumio volumio[1167]: info: Loading plugin "updater_comm"... Apr 26 23:53:14 volumio volumio[1167]: info: Plugin mpdemulation is not enabled Apr 26 23:53:14 volumio volumio[1167]: Forking 3 albumart workers Apr 26 23:53:14 volumio volumio[1167]: info: Loading plugin "rest_api"... Apr 26 23:53:14 volumio volumio[1167]: info: Loading plugin "websocket"... Apr 26 23:53:14 volumio volumio[1167]: info: Starting Socket.io Server version 2.3.0 Apr 26 23:53:14 volumio volumio[1167]: info: Loading i18n strings for locale it Apr 26 23:53:14 volumio volumio[1167]: Updating browse sources language Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 23:53:14 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::initPlayerControls Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: Express server listening on port 3000 Apr 26 23:53:14 volumio volumio[1167]: [Metrics] WebUI: 8s 320.68ms Apr 26 23:53:14 volumio volumio[1167]: info: CoreStateMachine::resetVolumioState Apr 26 23:53:14 volumio volumio[1167]: info: CoreStateMachine::getcurrentVolume Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::volumioRetrievevolume Apr 26 23:53:14 volumio volumio[1167]: info: Volumio Network Manager: Network status updated: 3 Apr 26 23:53:14 volumio volumio[1167]: Starting albumart workers Apr 26 23:53:14 volumio volumio[1167]: Starting albumart workers Apr 26 23:53:14 volumio volumio[1167]: Starting albumart workers Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:14 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:14 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:14 volumio volumio[1167]: info: VolumeController:: Volume=100 Mute =false Apr 26 23:53:14 volumio volumio[1167]: info: CoreStateMachine::pushState Apr 26 23:53:14 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Apr 26 23:53:14 volumio volumio[1167]: info: CoreStateMachine::updateTrackBlock Apr 26 23:53:14 volumio volumio[1167]: info: CorePlayQueue::getTrackBlock Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::volumioRetrievevolume Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:14 volumio volumio[1167]: info: Reloading queue from file Apr 26 23:53:14 volumio volumio[1167]: info: Setting Device type: Raspberry PI Apr 26 23:53:14 volumio volumio[1167]: info: CoreStateMachine::setRepeat null single undefined Apr 26 23:53:14 volumio volumio[1167]: info: CoreStateMachine::pushState Apr 26 23:53:14 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Apr 26 23:53:14 volumio volumio[1167]: info: CoreStateMachine::setRandom null Apr 26 23:53:14 volumio volumio[1167]: info: CoreStateMachine::pushState Apr 26 23:53:14 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Apr 26 23:53:14 volumio volumio[1167]: info: Completed loading Core Plugins Apr 26 23:53:14 volumio volumio[1167]: info: Preparing to generate the ALSA configuration file Apr 26 23:53:14 volumio volumio[1167]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Apr 26 23:53:14 volumio volumio[1167]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03111 Apr 26 23:53:14 volumio volumio[1167]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:14 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:14 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:14 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:14 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:14 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:14 volumio volumio[1167]: verbose: New Socket.io Connection to 192.168.1.50:3000 from 192.168.1.107 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Apr 26 23:53:15 volumio volumio[1167]: info: VolumeController:: Volume=100 Mute =false Apr 26 23:53:15 volumio volumio[1167]: info: CoreStateMachine::pushState Apr 26 23:53:15 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Apr 26 23:53:15 volumio volumio[1167]: info: Asound.conf file unchanged, so no further update is needed Apr 26 23:53:15 volumio volumio[1167]: info: Output device has changed, restarting MPD Apr 26 23:53:15 volumio volumio[1167]: info: Output device has changed, restarting Shairport Sync Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:15 volumio sudo[1323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 26 23:53:15 volumio sudo[1323]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:15 volumio sudo[1325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 26 23:53:15 volumio sudo[1323]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:15 volumio sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:15 volumio volumio[1167]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 23:53:15 volumio volumio[1167]: info: ___________ START PLUGINS ___________ Apr 26 23:53:15 volumio volumio[1167]: info: ControllerMpd::onStart: Initializing MPD Apr 26 23:53:15 volumio volumio[1167]: info: Creating MPD Configuration file Apr 26 23:53:15 volumio systemd[1]: Stopping Music Player Daemon... Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 23:53:15 volumio sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 26 23:53:15 volumio sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 26 23:53:15 volumio volumio[1167]: info: [1745704395174] CoreMusicLibrary::Adding element Server multimediali Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 23:53:15 volumio sudo[1332]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:15 volumio sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 26 23:53:15 volumio sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:15 volumio volumio[1167]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 26 23:53:15 volumio volumio[1167]: info: [1745704395290] CoreMusicLibrary::Adding element Last_100 Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 26 23:53:15 volumio volumio[1167]: info: [1745704395293] CoreMusicLibrary::Adding element Webradio Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 23:53:15 volumio volumio[1167]: info: Initializing BBC Radios Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:15 volumio systemd[1]: mpd.service: Succeeded. Apr 26 23:53:15 volumio systemd[1]: Stopped Music Player Daemon. Apr 26 23:53:15 volumio volumio[1167]: info: [now-playing] ConfigUpdater: config is up to date. Apr 26 23:53:15 volumio volumio[1167]: info: Volumio Calling Home Apr 26 23:53:15 volumio systemd[1]: Starting Music Player Daemon... Apr 26 23:53:15 volumio volumio[1167]: info: [now-playing] App is listening on port 4004. Apr 26 23:53:15 volumio volumio[1167]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Apr 26 23:53:15 volumio volumio[1167]: info: Discovery: adding 1483fcde-5544-4f66-8dad-ab62290a61d6 Apr 26 23:53:15 volumio volumio[1167]: info: Discovery: Found device Volumio Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:15 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:15 volumio volumio[1167]: info: Discovery: this is already registered, 1483fcde-5544-4f66-8dad-ab62290a61d6 Apr 26 23:53:15 volumio volumio[1167]: info: Discovery: Found device Volumio Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:15 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:15 volumio sudo[1369]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 26 23:53:15 volumio sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:15 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 26 23:53:15 volumio sudo[1369]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:15 volumio volumio[1167]: info: MPD Permissions set Apr 26 23:53:15 volumio volumio[1167]: info: MPD Permissions set Apr 26 23:53:15 volumio volumio[1167]: 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 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:15 volumio volumio[1167]: info: Starting Shairport Sync Apr 26 23:53:15 volumio volumio[1167]: info: Starting Shairport Sync Apr 26 23:53:15 volumio volumio[1167]: info: Starting Shairport Sync Apr 26 23:53:15 volumio sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 23:53:15 volumio sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:15 volumio sudo[1386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 23:53:15 volumio sudo[1386]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:15 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 26 23:53:15 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 26 23:53:15 volumio sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 23:53:15 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 26 23:53:15 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:15 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 26 23:53:15 volumio sudo[1384]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:16 volumio volumio[1167]: info: Shairport-Sync Started Apr 26 23:53:16 volumio volumio[1167]: Error adding Membership: Error: addMembership EINVAL Apr 26 23:53:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 26 23:53:16 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 26 23:53:16 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 26 23:53:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 26 23:53:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 26 23:53:16 volumio sudo[1386]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:16 volumio sudo[1389]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:16 volumio volumio[1167]: info: Shairport-Sync Started Apr 26 23:53:16 volumio volumio[1167]: info: Shairport-Sync Started Apr 26 23:53:16 volumio mpd[1374]: Apr 26 23:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 26 23:53:16 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:16 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:16 volumio systemd[1]: Started Music Player Daemon. Apr 26 23:53:16 volumio sudo[1325]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:16 volumio sudo[1334]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:16 volumio volumio[1167]: info: Completed starting Core Plugins Apr 26 23:53:16 volumio volumio[1167]: info: ------------------------------------------- Apr 26 23:53:16 volumio volumio[1167]: info: ----- MyVolumio plugins startup ---- Apr 26 23:53:16 volumio volumio[1167]: info: ------------------------------------------- Apr 26 23:53:16 volumio volumio[1167]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 26 23:53:16 volumio volumio[1167]: info: MPD running with PID1374 Apr 26 23:53:16 volumio volumio[1167]: ,establishing connection Apr 26 23:53:16 volumio volumio[1167]: error: MPD error: The expression evaluated to a falsy value: Apr 26 23:53:16 volumio volumio[1167]: assert.ok(self.idling) Apr 26 23:53:16 volumio volumio[1167]: error: The expression evaluated to a falsy value: Apr 26 23:53:16 volumio volumio[1167]: assert.ok(self.idling) Apr 26 23:53:16 volumio volumio[1167]: error: MPD error: The expression evaluated to a falsy value: Apr 26 23:53:16 volumio volumio[1167]: assert.ok(self.idling) Apr 26 23:53:16 volumio volumio[1167]: error: The expression evaluated to a falsy value: Apr 26 23:53:16 volumio volumio[1167]: assert.ok(self.idling) Apr 26 23:53:16 volumio volumio[1167]: error: updateQueue error: null Apr 26 23:53:19 volumio sudo[1418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 26 23:53:19 volumio sudo[1418]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:19 volumio sudo[1418]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:19 volumio sudo[1420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 23:53:19 volumio sudo[1420]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:19 volumio sudo[1420]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:19 volumio sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 26 23:53:19 volumio sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:19 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 26 23:53:19 volumio sudo[1424]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:19 volumio volumio[1167]: info: Upmpdcli Daemon Started Apr 26 23:53:19 volumio volumio[1426]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 26 23:53:20 volumio volumio[1167]: info: Volumio called home Apr 26 23:53:20 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:20 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:21 volumio volumio[1167]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 26 23:53:21 volumio volumio-remote-updater[640]: [2025-04-26 23:53:21] [connect] Successful connection Apr 26 23:53:21 volumio volumio-remote-updater[640]: [2025-04-26 23:53:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745704401 101 Apr 26 23:53:21 volumio volumio[1167]: 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 26 23:53:22 volumio systemd[1]: systemd-timedated.service: Succeeded. Apr 26 23:53:22 volumio sudo[1445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 26 23:53:22 volumio sudo[1445]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:22 volumio sudo[1445]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:22 volumio sudo[1447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 23:53:22 volumio sudo[1447]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:22 volumio sudo[1447]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:22 volumio volumio[1167]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.107 UA: Mozilla/5.0 (Linux; Android 13; CPH2207 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Apr 26 23:53:22 volumio sudo[1451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 26 23:53:22 volumio sudo[1451]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:22 volumio sudo[1451]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:22 volumio sudo[1453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 23:53:22 volumio sudo[1453]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:22 volumio sudo[1453]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:22 volumio volumio[1167]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.107 UA: Mozilla/5.0 (Linux; Android 13; CPH2207 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::volumioGetVisibleSources Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:22 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 26 23:53:22 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:22 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:22 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:22 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:22 volumio volumio[1167]: info: Listing playlists Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 26 23:53:22 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 26 23:53:24 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 26 23:53:24 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 26 23:53:24 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:24 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:24 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:24 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:24 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:24 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:24 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 26 23:53:24 volumio volumio[1167]: info: Adding plugin bluetooth to MyMusic Plugins Apr 26 23:53:24 volumio volumio[1167]: info: Adding plugin multiroom to MyMusic Plugins Apr 26 23:53:24 volumio volumio[1167]: info: Adding plugin metavolumio to MyMusic Plugins Apr 26 23:53:24 volumio volumio[1167]: info: Adding plugin cd_controller to MyMusic Plugins Apr 26 23:53:24 volumio volumio[1167]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 26 23:53:24 volumio volumio[1167]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 26 23:53:24 volumio volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 26 23:53:25 volumio volumio[1167]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 26 23:53:25 volumio volumio[1167]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 26 23:53:25 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:25 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:25 volumio volumio[1167]: info: Starting MyVolumio Remote Streaming Endpoints Apr 26 23:53:25 volumio volumio[1167]: info: MyVolumio login type: Token Apr 26 23:53:25 volumio volumio[1167]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 26 23:53:25 volumio volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 26 23:53:26 volumio volumio[1167]: info: Starting Streaming Service Transparent Proxy Apr 26 23:53:26 volumio volumio[1167]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 26 23:53:26 volumio volumio[1167]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 26 23:53:26 volumio volumio[1167]: info: Streaming services startup Apr 26 23:53:26 volumio volumio[1167]: info: Starting Streaming Daemon Apr 26 23:53:26 volumio sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 26 23:53:26 volumio sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:26 volumio sudo[1463]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:26 volumio volumio[1167]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 26 23:53:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 26 23:53:26 volumio volumio[1167]: info: MyVolumio login type: Token Apr 26 23:53:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 26 23:53:26 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:26 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:26 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:26 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:26 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Apr 26 23:53:26 volumio volumio[1167]: info: CoreStateMachine::getQueue Apr 26 23:53:26 volumio volumio[1167]: info: CorePlayQueue::getQueue Apr 26 23:53:26 volumio volumio[1167]: error: Cannot start Volumio Streaming Daemon Apr 26 23:53:26 volumio volumio[1167]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 26 23:53:26 volumio volumio[1167]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 26 23:53:27 volumio volumio[1167]: error: MyVolumio Custom Token format not valid, refreshing it Apr 26 23:53:27 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 26 23:53:27 volumio volumio[1167]: info: MyVolumio login type: Token Apr 26 23:53:27 volumio volumio[1167]: STREAMING PROXY: Starting server on port 3245 Apr 26 23:53:27 volumio volumio[1167]: Node JS runtime: 14 Apr 26 23:53:27 volumio volumio[1167]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 26 23:53:29 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:29 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:29 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 26 23:53:29 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:29 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:29 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:29 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 26 23:53:30 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:30 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:30 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:32 volumio volumio[1167]: info: MyVolumio login type: Token Apr 26 23:53:32 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 26 23:53:33 volumio volumio[1167]: info: MyVolumio token set successfully Apr 26 23:53:33 volumio volumio[1167]: info: MYVOLUMIO: Adding device Apr 26 23:53:33 volumio volumio[1167]: info: MYVOLUMIO: Evaluating Server Apr 26 23:53:33 volumio volumio[1167]: info: MyVolumio status changed Apr 26 23:53:33 volumio volumio[1167]: info: Streaming services startup Apr 26 23:53:33 volumio volumio[1167]: info: Starting Streaming Daemon Apr 26 23:53:33 volumio volumio[1167]: info: Removing browser output: myVolumio user plan is not superstar Apr 26 23:53:33 volumio volumio[1167]: info: Removing audio output: Apr 26 23:53:33 volumio volumio[1167]: info: Stoppping Tunnel 1 Apr 26 23:53:33 volumio sudo[1505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 26 23:53:33 volumio sudo[1505]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:33 volumio sudo[1508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 26 23:53:33 volumio sudo[1508]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:33 volumio sudo[1505]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:33 volumio volumio[1167]: error: Cannot start Volumio Streaming Daemon Apr 26 23:53:33 volumio volumio[1167]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 26 23:53:33 volumio volumio[1167]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 26 23:53:33 volumio sudo[1508]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:33 volumio volumio[1167]: info: Remote SSH Stopped Apr 26 23:53:34 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:34 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:34 volumio volumio[1167]: info: Setting Geolocation for MyVolumio to eu4 Apr 26 23:53:34 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:34 volumio sudo[1511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 26 23:53:34 volumio sudo[1511]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:34 volumio sudo[1511]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:34 volumio sudo[1513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 23:53:34 volumio sudo[1513]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:34 volumio sudo[1513]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:34 volumio volumio[1167]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.107 UA: Mozilla/5.0 (Linux; Android 13; CPH2207 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 26 23:53:34 volumio volumio[1167]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 26 23:53:34 volumio sudo[1517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 26 23:53:34 volumio sudo[1517]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:34 volumio sudo[1517]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:34 volumio sudo[1519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 23:53:34 volumio sudo[1519]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 23:53:34 volumio sudo[1519]: pam_unix(sudo:session): session closed for user root Apr 26 23:53:34 volumio volumio[1167]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.107 UA: Mozilla/5.0 (Linux; Android 13; CPH2207 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::volumioGetVisibleSources Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:35 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 26 23:53:35 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:35 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:35 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:35 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:35 volumio volumio[1167]: info: Listing playlists Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 26 23:53:35 volumio volumio[1167]: info: Updating MyVolumio device info Apr 26 23:53:35 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:35 volumio volumio[1167]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 26 23:53:36 volumio volumio[1426]: .......................................................................................................................................................................................++++ Apr 26 23:53:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 26 23:53:36 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Apr 26 23:53:36 volumio volumio[1167]: info: CoreStateMachine::getQueue Apr 26 23:53:36 volumio volumio[1167]: info: CorePlayQueue::getQueue Apr 26 23:53:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 26 23:53:36 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:36 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:36 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:36 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 26 23:53:37 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:37 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:37 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:37 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:37 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:37 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:38 volumio volumio[1167]: info: MYVOLUMIO: Adding device Apr 26 23:53:38 volumio volumio[1167]: info: MYVOLUMIO: Evaluating Server Apr 26 23:53:39 volumio volumio[1167]: info: Setting Geolocation for MyVolumio to eu4 Apr 26 23:53:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:39 volumio volumio[1167]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 26 23:53:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:53:39 volumio volumio[1167]: info: Preload queue cleared Apr 26 23:53:40 volumio volumio[1167]: info: Updating MyVolumio device info Apr 26 23:53:40 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:40 volumio volumio[1167]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 26 23:53:40 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 26 23:53:40 volumio volumio[1167]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Apr 26 23:53:40 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:40 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:41 volumio volumio[1426]: ..................................................++++ Apr 26 23:53:41 volumio volumio[1426]: e is 65537 (0x010001) Apr 26 23:53:41 volumio volumio[1426]: writing RSA key Apr 26 23:53:41 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 26 23:53:41 volumio volumio[1167]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 26 23:53:41 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 26 23:53:41 volumio volumio[1167]: info: Received Get System Version Apr 26 23:53:41 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 23:53:41 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:41 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:41 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:41 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:41 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:41 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:41 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:41 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:53:42 volumio volumio[1167]: info: Preload queue cleared Apr 26 23:53:44 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:53:44 volumio volumio[1167]: info: Preload queue cleared Apr 26 23:53:44 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 26 23:53:45 volumio volumio-remote-updater[640]: No test mode Apr 26 23:53:45 volumio volumio-remote-updater[640]: No alpha test mode Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Apr 26 23:53:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 23:53:46 volumio volumio[1167]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

    • Improved translations


NEW ADDITIONS

 

    • Update to TIDAL Connect
    • Add Install-to-disk option for the new RPi5 HW revisions 

 

","title":"Update v3.799","updateavailable":true} Apr 26 23:53:46 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 26 23:53:46 volumio volumio[1167]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 26 23:53:46 volumio volumio[1167]: info: Completed starting MyVolumio Plugin Apr 26 23:53:46 volumio volumio[1167]: [Metrics] CommandRouter: 39s 857.92ms Apr 26 23:53:46 volumio volumio[1167]: info: CoreCommandRouter::volumiosetStartupVolume Apr 26 23:53:46 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 23:53:46 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 23:53:46 volumio volumio[1167]: info: CoreCommandRouter::Close All Modals sent Apr 26 23:53:46 volumio volumio[1167]: info: CoreCommandRouter::Close All Modals sent Apr 26 23:53:47 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 26 23:53:47 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 26 23:53:47 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 26 23:53:49 volumio ntpd[802]: Soliciting pool server 195.32.70.195 Apr 26 23:53:50 volumio ntpd[802]: Soliciting pool server 185.19.184.35 Apr 26 23:53:51 volumio ntpd[802]: Soliciting pool server 162.159.200.1 Apr 26 23:53:51 volumio ntpd[802]: Soliciting pool server 109.116.201.149 Apr 26 23:53:52 volumio ntpd[802]: Soliciting pool server 93.94.88.51 Apr 26 23:53:52 volumio ntpd[802]: Soliciting pool server 93.94.88.50 Apr 26 23:53:52 volumio ntpd[802]: Soliciting pool server 37.247.53.178 Apr 26 23:53:52 volumio ntpd[802]: Soliciting pool server 151.22.209.90 Apr 26 23:53:52 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 26 23:53:52 volumio volumio[1167]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 26 23:53:52 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 26 23:53:52 volumio volumio[1167]: info: Received Get System Version Apr 26 23:53:52 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 23:53:52 volumio volumio[1167]: info: Received Get System Info Apr 26 23:53:52 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:53:52 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:53:52 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:53:52 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:53:52 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:53:52 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:53:53 volumio ntpd[802]: Soliciting pool server 81.56.230.156 Apr 26 23:53:53 volumio ntpd[802]: Soliciting pool server 89.46.74.148 Apr 26 23:53:53 volumio volumio[1167]: info: BOOT COMPLETED Apr 26 23:53:54 volumio ntpd[802]: Soliciting pool server 79.10.113.170 Apr 26 23:53:54 volumio ntpd[802]: Soliciting pool server 95.242.98.72 Apr 26 23:53:55 volumio ntpd[802]: Soliciting pool server 2a00:6d41:10:1194::7 Apr 26 23:53:55 volumio ntpd[802]: Soliciting pool server 95.110.135.141 Apr 26 23:53:58 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:53:58 volumio volumio[1167]: info: Preload queue cleared Apr 26 23:53:59 volumio ntpd[802]: receive: Unexpected origin timestamp 0xebb7d476.78bf8375 does not match aorg 0000000000.00000000 from server@95.110.135.141 xmt 0xebb7d477.554ff33f Apr 26 23:53:59 volumio ntpd[802]: receive: Unexpected origin timestamp 0xebb7d476.78c64930 does not match aorg 0000000000.00000000 from server@95.242.98.72 xmt 0xebb7d477.5488509b Apr 26 23:53:59 volumio ntpd[802]: receive: Unexpected origin timestamp 0xebb7d476.78c7ac86 does not match aorg 0000000000.00000000 from server@81.56.230.156 xmt 0xebb7d477.5595bbbe Apr 26 23:53:59 volumio ntpd[802]: receive: Unexpected origin timestamp 0xebb7d476.78c49502 does not match aorg 0000000000.00000000 from server@79.10.113.170 xmt 0xebb7d477.56052e81 Apr 26 23:53:59 volumio ntpd[802]: receive: Unexpected origin timestamp 0xebb7d476.78c8ed61 does not match aorg 0000000000.00000000 from server@93.94.88.51 xmt 0xebb7d477.570ee18e Apr 26 23:54:00 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:54:00 volumio volumio[1167]: info: Preload queue cleared Apr 26 23:54:02 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:54:02 volumio volumio[1167]: info: Preload queue cleared Apr 26 23:54:08 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 23:54:08 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 23:54:08 volumio volumio[1167]: info: Discovery: Getting this device information Apr 26 23:54:08 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Apr 26 23:54:08 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Apr 26 23:54:08 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 23:54:09 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:54:09 volumio volumio[1167]: info: Preload queue cleared Apr 26 23:54:12 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:54:12 volumio volumio[1167]: info: Preload queue cleared Apr 26 23:54:16 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 26 23:54:16 volumio volumio[1167]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 23:54:16 volumio volumio[1167]: TypeError: Cannot read property 'length' of undefined Apr 26 23:54:16 volumio volumio[1167]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Apr 26 23:54:16 volumio volumio[1167]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Apr 26 23:54:16 volumio volumio[1167]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Apr 26 23:54:16 volumio volumio[1167]: at Parser.emit (events.js:315:20) Apr 26 23:54:16 volumio volumio[1167]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Apr 26 23:54:16 volumio volumio[1167]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Apr 26 23:54:16 volumio volumio[1167]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Apr 26 23:54:16 volumio volumio[1167]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Apr 26 23:54:16 volumio volumio[1167]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Apr 26 23:54:16 volumio volumio[1167]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 26 23:54:16 volumio volumio[1167]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 26 23:54:16 volumio volumio[1167]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 26 23:54:16 volumio volumio[1167]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 26 23:54:16 volumio volumio[1167]: at IncomingMessage.emit (events.js:327:22) Apr 26 23:54:16 volumio volumio[1167]: at endReadableNT (internal/streams/readable.js:1327:12) Apr 26 23:54:16 volumio volumio[1167]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 26 23:54:16 volumio volumio[1167]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 23:54:17 volumio sudo[1737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-26 23:53 Apr 26 23:54:17 volumio sudo[1737]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"