-- Logs begin at Thu 2019-02-14 19:11:58 KST, end at Sat 2025-02-15 17:19:06 KST. -- Feb 15 17:18:00 top-core-1 hostapd[849]: wlan0: interface state UNINITIALIZED->ENABLED Feb 15 17:18:00 top-core-1 hostapd[849]: wlan0: AP-ENABLED Feb 15 17:18:00 top-core-1 systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Feb 15 17:18:00 top-core-1 iwconfig[865]: Error for wireless request "Set Power Management" (8B2C) : Feb 15 17:18:00 top-core-1 iwconfig[865]: SET failed on device wlan0 ; Invalid argument. Feb 15 17:18:00 top-core-1 systemd[1]: wireless.service: Succeeded. Feb 15 17:18:00 top-core-1 systemd[1]: Started Wireless Services. Feb 15 17:18:00 top-core-1 systemd[1]: Started Volumio Backend Module. Feb 15 17:18:00 top-core-1 systemd[1]: Started Volumio Cpu Tweaker. Feb 15 17:18:00 top-core-1 nmbd[699]: [2025/02/15 17:18:00.134850, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 15 17:18:00 top-core-1 systemd[1]: Started Samba NMB Daemon. Feb 15 17:18:00 top-core-1 nmbd[699]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 15 17:18:00 top-core-1 systemd[1]: Starting Samba Winbind Daemon... Feb 15 17:18:00 top-core-1 volumio-cpu-tweak[867]: Setting RT Priority for mpd Feb 15 17:18:00 top-core-1 volumio-cpu-tweak[867]: Setting MPD Affinity Feb 15 17:18:00 top-core-1 volumio-cpu-tweak[867]: pid 765's current affinity mask: f Feb 15 17:18:00 top-core-1 volumio-cpu-tweak[867]: pid 765's new affinity mask: 3 Feb 15 17:18:00 top-core-1 volumio-cpu-tweak[867]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Feb 15 17:18:00 top-core-1 volumio-cpu-tweak[867]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Feb 15 17:18:00 top-core-1 systemd[1]: volumio_cpu_tweak.service: Succeeded. Feb 15 17:18:00 top-core-1 winbindd[878]: [2025/02/15 17:18:00.330456, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 15 17:18:00 top-core-1 winbindd[878]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 15 17:18:00 top-core-1 winbindd[878]: [2025/02/15 17:18:00.348250, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 15 17:18:00 top-core-1 winbindd[878]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 15 17:18:00 top-core-1 systemd[1]: Started Samba Winbind Daemon. Feb 15 17:18:00 top-core-1 systemd[1]: Starting Samba SMB Daemon... Feb 15 17:18:00 top-core-1 smbd[888]: [2025/02/15 17:18:00.734106, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 15 17:18:00 top-core-1 systemd[1]: Started Samba SMB Daemon. Feb 15 17:18:00 top-core-1 smbd[888]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 15 17:18:01 top-core-1 ntpd[744]: Listen normally on 3 wlan0 192.168.211.1:123 Feb 15 17:18:01 top-core-1 ntpd[744]: new interface(s) found: waking up resolver Feb 15 17:18:01 top-core-1 volumio[866]: info: ------------------------------------------- Feb 15 17:18:01 top-core-1 volumio[866]: info: ----- Volumio3 ---- Feb 15 17:18:01 top-core-1 volumio[866]: info: ------------------------------------------- Feb 15 17:18:01 top-core-1 volumio[866]: info: ----- System startup ---- Feb 15 17:18:01 top-core-1 volumio[866]: info: ------------------------------------------- Feb 15 17:18:02 top-core-1 volumio[866]: info: MYVOLUMIO Environment detected Feb 15 17:18:02 top-core-1 volumio[866]: info: Plugin folders cleanup Feb 15 17:18:02 top-core-1 volumio[866]: info: Scanning into folder /volumio/app/plugins/ Feb 15 17:18:02 top-core-1 volumio[866]: info: Scanning category audio_interface Feb 15 17:18:02 top-core-1 volumio[866]: info: Scanning category miscellanea Feb 15 17:18:02 top-core-1 volumio[866]: info: Scanning category music_service Feb 15 17:18:02 top-core-1 volumio[866]: info: Scanning category plugins.json Feb 15 17:18:02 top-core-1 volumio[866]: info: Scanning category system_controller Feb 15 17:18:02 top-core-1 volumio[866]: info: Scanning category user_interface Feb 15 17:18:02 top-core-1 volumio[866]: info: Scanning into folder /data/plugins/ Feb 15 17:18:02 top-core-1 volumio[866]: info: Plugin folders cleanup completed Feb 15 17:18:02 top-core-1 volumio[866]: info: ------------------------------------------- Feb 15 17:18:02 top-core-1 volumio[866]: info: ----- Core plugins startup ---- Feb 15 17:18:02 top-core-1 volumio[866]: info: ------------------------------------------- Feb 15 17:18:02 top-core-1 volumio[866]: info: Loading plugins from folder /volumio/app/plugins/ Feb 15 17:18:02 top-core-1 volumio[866]: info: Adding plugin upnp to MyMusic Plugins Feb 15 17:18:02 top-core-1 volumio[866]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 15 17:18:02 top-core-1 volumio[866]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 15 17:18:02 top-core-1 volumio[866]: info: Loading plugins from folder /data/plugins/ Feb 15 17:18:02 top-core-1 volumio[866]: info: Loading plugin "system"... Feb 15 17:18:02 top-core-1 volumio[866]: info: Loading plugin "appearance"... Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "network"... Feb 15 17:18:03 top-core-1 volumio[866]: info: Refreshing Cached IP Addresses Feb 15 17:18:03 top-core-1 sudo[910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 15 17:18:03 top-core-1 sudo[910]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:03 top-core-1 sudo[910]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:03 top-core-1 sudo[912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 15 17:18:03 top-core-1 sudo[912]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:03 top-core-1 sudo[912]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "services"... Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "alsa_controller"... Feb 15 17:18:03 top-core-1 sudo[925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 15 17:18:03 top-core-1 sudo[925]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:03 top-core-1 sh[499]: eth0: probing for an IPv4LL address Feb 15 17:18:03 top-core-1 dhcpcd[548]: eth0: probing for an IPv4LL address Feb 15 17:18:03 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "wizard"... Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "networkfs"... Feb 15 17:18:03 top-core-1 volumio[866]: info: Starting Udev Watcher for removable devices Feb 15 17:18:03 top-core-1 volumio[866]: info: Ignoring mount for partition: boot Feb 15 17:18:03 top-core-1 volumio[866]: info: Ignoring mount for partition: volumio Feb 15 17:18:03 top-core-1 volumio[866]: info: Ignoring mount for partition: volumio_data Feb 15 17:18:03 top-core-1 volumio[866]: info: Mounting Device Audiophile Feb 15 17:18:03 top-core-1 sudo[939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Audiophile -o noatime Feb 15 17:18:03 top-core-1 sudo[939]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:03 top-core-1 sudo[939]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:03 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "volumio_command_line_client"... Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "upnp"... Feb 15 17:18:03 top-core-1 volumio[866]: info: [1739607483933] Starting Upmpd Daemon Feb 15 17:18:03 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "my_music"... Feb 15 17:18:03 top-core-1 volumio[866]: info: Loading plugin "mpd"... Feb 15 17:18:04 top-core-1 volumio-time-update[608]: volumio-time-update-util: Fetching time from Volumio... Feb 15 17:18:04 top-core-1 volumio-time-update[608]: volumio-time-update-util: Date not found in response Feb 15 17:18:04 top-core-1 volumio-time-update[608]: volumio-time-update-util: Retrying in 5 seconds... Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "upnp_browser"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "alarm-clock"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "airplay_emulation"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Starting Shairport Sync Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "last_100"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "webradio"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "i2s_dacs"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "volumiodiscovery"... Feb 15 17:18:04 top-core-1 volumio[866]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 17:18:04 top-core-1 volumio[866]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 17:18:04 top-core-1 node[866]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 17:18:04 top-core-1 volumio[866]: *** WARNING *** For more information see Feb 15 17:18:04 top-core-1 volumio[866]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 17:18:04 top-core-1 volumio[866]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 17:18:04 top-core-1 volumio[866]: *** WARNING *** For more information see Feb 15 17:18:04 top-core-1 node[866]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 17:18:04 top-core-1 node[866]: *** WARNING *** For more information see Feb 15 17:18:04 top-core-1 node[866]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 17:18:04 top-core-1 node[866]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 17:18:04 top-core-1 node[866]: *** WARNING *** For more information see Feb 15 17:18:04 top-core-1 volumio[866]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 15 17:18:04 top-core-1 volumio[866]: info: Discovery: Started advertising with name: Top Core 1 Feb 15 17:18:04 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "outputs"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "albumart"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Plugin example_plugin is not enabled Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "inputs"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "updater_comm"... Feb 15 17:18:04 top-core-1 volumio[866]: info: Plugin mpdemulation is not enabled Feb 15 17:18:04 top-core-1 volumio[866]: info: Loading plugin "rest_api"... Feb 15 17:18:05 top-core-1 volumio[866]: info: Loading plugin "websocket"... Feb 15 17:18:05 top-core-1 volumio[866]: info: Starting Socket.io Server version 2.3.0 Feb 15 17:18:05 top-core-1 volumio[866]: Forking 3 albumart workers Feb 15 17:18:05 top-core-1 volumio[866]: info: Loading i18n strings for locale ko Feb 15 17:18:05 top-core-1 volumio[866]: Updating browse sources language Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::initPlayerControls Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: Express server listening on port 3000 Feb 15 17:18:05 top-core-1 volumio[866]: [Metrics] WebUI: 4s 60.78ms Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreStateMachine::resetVolumioState Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreStateMachine::getcurrentVolume Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreStateMachine::pushState Feb 15 17:18:05 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::volumioPushState Feb 15 17:18:05 top-core-1 volumio[866]: info: Volumio Network Manager: Network status updated: 0 Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreStateMachine::setRepeat null single undefined Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreStateMachine::pushState Feb 15 17:18:05 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::volumioPushState Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreStateMachine::setRandom null Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreStateMachine::pushState Feb 15 17:18:05 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::volumioPushState Feb 15 17:18:05 top-core-1 volumio[866]: info: Reloading queue from file Feb 15 17:18:05 top-core-1 volumio[866]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 15 17:18:05 top-core-1 volumio[866]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Feb 15 17:18:05 top-core-1 volumio[866]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 15 17:18:05 top-core-1 volumio[866]: info: Setting Device type: Raspberry PI Feb 15 17:18:05 top-core-1 volumio[866]: info: Completed loading Core Plugins Feb 15 17:18:05 top-core-1 volumio[866]: info: Preparing to generate the ALSA configuration file Feb 15 17:18:05 top-core-1 volumio[866]: Starting albumart workers Feb 15 17:18:05 top-core-1 volumio[866]: Starting albumart workers Feb 15 17:18:05 top-core-1 volumio[866]: info: Discovery: adding 9c851e8b-5c4f-4f49-a258-2391803e1255 Feb 15 17:18:05 top-core-1 volumio[866]: info: Discovery: Found device Top Core 1 Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:05 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:05 top-core-1 volumio[866]: info: Asound.conf file unchanged, so no further update is needed Feb 15 17:18:05 top-core-1 volumio[866]: info: Output device has changed, restarting MPD Feb 15 17:18:05 top-core-1 volumio[866]: info: Output device has changed, restarting Shairport Sync Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: Starting albumart workers Feb 15 17:18:05 top-core-1 sudo[988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 17:18:05 top-core-1 sudo[988]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:05 top-core-1 sudo[988]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:05 top-core-1 sudo[990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 17:18:05 top-core-1 sudo[990]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:05 top-core-1 systemd[1]: Stopping Music Player Daemon... Feb 15 17:18:05 top-core-1 volumio[866]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 15 17:18:05 top-core-1 volumio[866]: info: ___________ START PLUGINS ___________ Feb 15 17:18:05 top-core-1 volumio[866]: info: ControllerMpd::onStart: Initializing MPD Feb 15 17:18:05 top-core-1 volumio[866]: info: Creating MPD Configuration file Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 17:18:05 top-core-1 volumio[866]: info: [1739607485809] CoreMusicLibrary::Adding element 미디어 서버 Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 17:18:05 top-core-1 sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 17:18:05 top-core-1 sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:05 top-core-1 sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 17:18:05 top-core-1 sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:05 top-core-1 systemd[1]: mpd.service: Succeeded. Feb 15 17:18:05 top-core-1 systemd[1]: Stopped Music Player Daemon. Feb 15 17:18:05 top-core-1 sudo[997]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:05 top-core-1 volumio[866]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:05 top-core-1 systemd[1]: Starting Music Player Daemon... Feb 15 17:18:05 top-core-1 volumio[866]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 15 17:18:05 top-core-1 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 15 17:18:05 top-core-1 systemd[1]: mpd.service: Succeeded. Feb 15 17:18:05 top-core-1 systemd[1]: Stopped Music Player Daemon. Feb 15 17:18:05 top-core-1 systemd[1]: Starting Music Player Daemon... Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 17:18:05 top-core-1 volumio[866]: info: [1739607485968] CoreMusicLibrary::Adding element Last_100 Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 17:18:05 top-core-1 volumio[866]: info: [1739607485975] CoreMusicLibrary::Adding element Webradio Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 17:18:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 17:18:05 top-core-1 volumio[866]: info: Initializing BBC Radios Feb 15 17:18:06 top-core-1 sudo[1009]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 17:18:06 top-core-1 sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:06 top-core-1 sudo[1009]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: Volumio Calling Home Feb 15 17:18:06 top-core-1 volumio[866]: info: MPD Permissions set Feb 15 17:18:06 top-core-1 volumio[866]: info: MPD Permissions set Feb 15 17:18:06 top-core-1 volumio[866]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio-remote-updater[613]: [2025-02-15 17:18:06] [connect] Successful connection Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 17:18:06 top-core-1 volumio-remote-updater[613]: [2025-02-15 17:18:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739607486 101 Feb 15 17:18:06 top-core-1 volumio[866]: 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: 2 Feb 15 17:18:06 top-core-1 volumio[866]: info: Starting Shairport Sync Feb 15 17:18:06 top-core-1 volumio[866]: info: Starting Shairport Sync Feb 15 17:18:06 top-core-1 volumio[866]: info: Starting Shairport Sync Feb 15 17:18:06 top-core-1 sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 15 17:18:06 top-core-1 sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:06 top-core-1 sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 15 17:18:06 top-core-1 sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:06 top-core-1 sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 15 17:18:06 top-core-1 sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:06 top-core-1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 15 17:18:06 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:06 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:06 top-core-1 systemd[1]: shairport-sync.service: Succeeded. Feb 15 17:18:06 top-core-1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 15 17:18:06 top-core-1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 15 17:18:06 top-core-1 sudo[1058]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:06 top-core-1 volumio[866]: info: Shairport-Sync Started Feb 15 17:18:06 top-core-1 volumio[866]: Error adding Membership: Error: addMembership EINVAL Feb 15 17:18:06 top-core-1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 15 17:18:06 top-core-1 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 15 17:18:06 top-core-1 systemd[1]: shairport-sync.service: Succeeded. Feb 15 17:18:06 top-core-1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 15 17:18:06 top-core-1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 15 17:18:06 top-core-1 sudo[1060]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:06 top-core-1 sudo[1063]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:06 top-core-1 volumio[866]: info: Shairport-Sync Started Feb 15 17:18:06 top-core-1 volumio[866]: info: Shairport-Sync Started Feb 15 17:18:06 top-core-1 mpd[1029]: Feb 15 17:18 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 15 17:18:06 top-core-1 systemd[1]: Started Music Player Daemon. Feb 15 17:18:06 top-core-1 sudo[990]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:06 top-core-1 sudo[999]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:06 top-core-1 volumio[866]: info: Completed starting Core Plugins Feb 15 17:18:06 top-core-1 volumio[866]: info: ------------------------------------------- Feb 15 17:18:06 top-core-1 volumio[866]: info: ----- MyVolumio plugins startup ---- Feb 15 17:18:06 top-core-1 volumio[866]: info: ------------------------------------------- Feb 15 17:18:06 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 15 17:18:06 top-core-1 volumio[866]: error: MPD error: The expression evaluated to a falsy value: Feb 15 17:18:06 top-core-1 volumio[866]: assert.ok(self.idling) Feb 15 17:18:06 top-core-1 volumio[866]: error: The expression evaluated to a falsy value: Feb 15 17:18:06 top-core-1 volumio[866]: assert.ok(self.idling) Feb 15 17:18:06 top-core-1 volumio[866]: info: MPD running with PID1029 Feb 15 17:18:06 top-core-1 volumio[866]: ,establishing connection Feb 15 17:18:06 top-core-1 volumio[866]: error: updateQueue error: null Feb 15 17:18:06 top-core-1 volumio[866]: error: updateQueue error: null Feb 15 17:18:07 top-core-1 sudo[925]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:08 top-core-1 sh[499]: eth0: using IPv4LL address 169.254.92.141 Feb 15 17:18:08 top-core-1 sh[499]: eth0: adding route to 169.254.0.0/16 Feb 15 17:18:08 top-core-1 sh[499]: eth0: adding default route Feb 15 17:18:08 top-core-1 dhcpcd[548]: eth0: using IPv4LL address 169.254.92.141 Feb 15 17:18:08 top-core-1 dhcpcd[548]: eth0: adding route to 169.254.0.0/16 Feb 15 17:18:08 top-core-1 avahi-daemon[612]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.92.141. Feb 15 17:18:08 top-core-1 avahi-daemon[612]: New relevant interface eth0.IPv4 for mDNS. Feb 15 17:18:08 top-core-1 dhcpcd[548]: eth0: adding default route Feb 15 17:18:08 top-core-1 avahi-daemon[612]: Registering new address record for 169.254.92.141 on eth0.IPv4. Feb 15 17:18:08 top-core-1 sh[499]: forked to background, child pid 1089 Feb 15 17:18:08 top-core-1 dhcpcd[548]: forked to background, child pid 1089 Feb 15 17:18:08 top-core-1 ifplugd(eth0)[729]: client: ifup: interface eth0 already configured Feb 15 17:18:08 top-core-1 sh[499]: eth0=eth0 Feb 15 17:18:08 top-core-1 ifplugd(eth0)[729]: Program executed successfully. Feb 15 17:18:09 top-core-1 volumio-time-update[608]: volumio-time-update-util: Fetching time from Volumio... Feb 15 17:18:09 top-core-1 ntpd[744]: Listen normally on 4 eth0 169.254.92.141:123 Feb 15 17:18:09 top-core-1 ntpd[744]: new interface(s) found: waking up resolver Feb 15 17:18:10 top-core-1 dhcpcd[1089]: eth0: offered 192.168.8.100 from 192.168.8.1 Feb 15 17:18:10 top-core-1 dhcpcd[1089]: eth0: probing address 192.168.8.100/24 Feb 15 17:18:13 top-core-1 volumio[866]: info: Volumio Network Manager: Network status updated: 1 Feb 15 17:18:13 top-core-1 sudo[1135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 15 17:18:13 top-core-1 sudo[1135]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:13 top-core-1 sudo[1135]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:13 top-core-1 sudo[1137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 15 17:18:13 top-core-1 sudo[1137]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:13 top-core-1 sudo[1137]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:13 top-core-1 sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 15 17:18:13 top-core-1 sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:14 top-core-1 systemd[1]: Started UPnP Renderer front-end to MPD. Feb 15 17:18:14 top-core-1 sudo[1141]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:14 top-core-1 volumio[866]: info: Upmpdcli Daemon Started Feb 15 17:18:14 top-core-1 volumio[1143]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 15 17:18:16 top-core-1 dhcpcd[1089]: eth0: leased 192.168.8.100 for 86400 seconds Feb 15 17:18:16 top-core-1 dhcpcd[1089]: eth0: adding route to 192.168.8.0/24 Feb 15 17:18:16 top-core-1 dhcpcd[1089]: eth0: changing default route via 192.168.8.1 Feb 15 17:18:16 top-core-1 avahi-daemon[612]: Registering new address record for 192.168.8.100 on eth0.IPv4. Feb 15 17:18:16 top-core-1 dnsmasq[857]: reading /etc/resolv.conf Feb 15 17:18:16 top-core-1 dnsmasq[857]: using nameserver 192.168.8.1#53 Feb 15 17:18:16 top-core-1 dnsmasq[857]: using nameserver 208.67.222.222#53 Feb 15 17:18:16 top-core-1 dnsmasq[857]: using nameserver 208.67.220.220#53 Feb 15 17:18:16 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Feb 15 17:18:16 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 15 17:18:16 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 15 17:18:16 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 15 17:18:16 top-core-1 avahi-daemon[612]: Withdrawing address record for 169.254.92.141 on eth0. Feb 15 17:18:16 top-core-1 dhcpcd[1089]: eth0: deleting route to 169.254.0.0/16 Feb 15 17:18:16 top-core-1 avahi-daemon[612]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.92.141. Feb 15 17:18:16 top-core-1 avahi-daemon[612]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.8.100. Feb 15 17:18:16 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 15 17:18:16 top-core-1 dhcpcd[1089]: eth0: pid 1089 deleted default route via 192.168.8.1 Feb 15 17:18:16 top-core-1 volumio[866]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.785&uuid=2828023b725cbe08aa342e4f8b95fbdc" http://updates.volumio.org/downloader-v1/track-device Feb 15 17:18:16 top-core-1 volumio[866]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 15 17:18:16 top-core-1 volumio[866]: Dload Upload Total Spent Left Speed Feb 15 17:18:16 top-core-1 volumio[866]: [132B blob data] Feb 15 17:18:16 top-core-1 volumio[866]: retrying in 5 seconds, trial 0 Feb 15 17:18:16 top-core-1 volumio[866]: info: Volumio Calling Home Feb 15 17:18:17 top-core-1 volumio[866]: info: Volumio called home Feb 15 17:18:18 top-core-1 ntpd[744]: Listen normally on 5 eth0 192.168.8.100:123 Feb 15 17:18:18 top-core-1 ntpd[744]: Deleting interface #4 eth0, 169.254.92.141#123, interface stats: received=0, sent=0, dropped=0, active_time=9 secs Feb 15 17:18:18 top-core-1 ntpd[744]: new interface(s) found: waking up resolver Feb 15 17:18:18 top-core-1 volumio[866]: info: Discovery: this is already registered, 9c851e8b-5c4f-4f49-a258-2391803e1255 Feb 15 17:18:18 top-core-1 volumio[866]: info: Discovery: Found device Top Core 1 Feb 15 17:18:18 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:18 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:20 top-core-1 volumio[1143]: ......................................................................++++ Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 15 17:18:20 top-core-1 volumio[866]: info: Adding plugin bluetooth to MyMusic Plugins Feb 15 17:18:20 top-core-1 volumio[866]: info: Adding plugin multiroom to MyMusic Plugins Feb 15 17:18:20 top-core-1 volumio[866]: info: Adding plugin metavolumio to MyMusic Plugins Feb 15 17:18:20 top-core-1 volumio[866]: info: Adding plugin cd_controller to MyMusic Plugins Feb 15 17:18:20 top-core-1 volumio[866]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 15 17:18:20 top-core-1 volumio[866]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 15 17:18:20 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 15 17:18:21 top-core-1 volumio[866]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 15 17:18:21 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 15 17:18:21 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:21 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:21 top-core-1 volumio[866]: info: Starting MyVolumio Remote Streaming Endpoints Feb 15 17:18:21 top-core-1 volumio[866]: info: MyVolumio login type: Token Feb 15 17:18:21 top-core-1 volumio[866]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 15 17:18:21 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 15 17:18:21 top-core-1 volumio[1143]: .............++++ Feb 15 17:18:21 top-core-1 volumio[1143]: e is 65537 (0x010001) Feb 15 17:18:21 top-core-1 volumio[1143]: writing RSA key Feb 15 17:18:22 top-core-1 volumio[866]: info: Starting Streaming Service Transparent Proxy Feb 15 17:18:22 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 15 17:18:22 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 15 17:18:22 top-core-1 volumio[866]: info: Streaming services startup Feb 15 17:18:22 top-core-1 volumio[866]: info: Starting Streaming Daemon Feb 15 17:18:22 top-core-1 sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 15 17:18:22 top-core-1 sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:22 top-core-1 volumio[866]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 15 17:18:22 top-core-1 sudo[1212]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:22 top-core-1 volumio[866]: error: Cannot start Volumio Streaming Daemon Feb 15 17:18:22 top-core-1 volumio[866]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 15 17:18:22 top-core-1 volumio[866]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 15 17:18:22 top-core-1 systemd[1]: systemd-fsckd.service: Succeeded. Feb 15 17:18:23 top-core-1 volumio[866]: STREAMING PROXY: Starting server on port 3245 Feb 15 17:18:23 top-core-1 volumio[866]: Node JS runtime: 14 Feb 15 17:18:23 top-core-1 volumio[866]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 15 17:18:24 top-core-1 volumio[866]: info: MyVolumio token set successfully Feb 15 17:18:24 top-core-1 volumio[866]: info: MYVOLUMIO: Adding device Feb 15 17:18:24 top-core-1 volumio[866]: info: MYVOLUMIO: Evaluating Server Feb 15 17:18:24 top-core-1 systemd[1]: systemd-hostnamed.service: Succeeded. Feb 15 17:18:24 top-core-1 volumio[866]: info: MyVolumio status changed Feb 15 17:18:24 top-core-1 volumio[866]: info: Streaming services startup Feb 15 17:18:24 top-core-1 volumio[866]: info: Starting Streaming Daemon Feb 15 17:18:24 top-core-1 volumio[866]: info: Removing browser output: myVolumio user plan is not superstar Feb 15 17:18:24 top-core-1 volumio[866]: info: Removing audio output: Feb 15 17:18:24 top-core-1 volumio[866]: info: Stoppping Tunnel 1 Feb 15 17:18:24 top-core-1 sudo[1255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 15 17:18:24 top-core-1 sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:24 top-core-1 sudo[1258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 15 17:18:24 top-core-1 volumio-time-update[608]: volumio-time-update-util: Setting system time to: 2025-02-15 17:18:51 Feb 15 17:18:24 top-core-1 sudo[1258]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:24 top-core-1 sudo[1255]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:24 top-core-1 volumio[866]: error: Cannot start Volumio Streaming Daemon Feb 15 17:18:24 top-core-1 volumio[866]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 15 17:18:24 top-core-1 volumio[866]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 15 17:18:24 top-core-1 sudo[1260]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-02-15 17:18:51 Feb 15 17:18:24 top-core-1 sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:18:25 top-core-1 sudo[1258]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:25 top-core-1 volumio[866]: info: Remote SSH Stopped Feb 15 17:18:25 top-core-1 dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.15' (uid=0 pid=1262 comm="timedatectl set-time 2025-02-15 17:18:51 ") Feb 15 17:18:25 top-core-1 systemd[1]: Starting Time & Date Service... Feb 15 17:18:25 top-core-1 dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 15 17:18:25 top-core-1 systemd[1]: Started Time & Date Service. Feb 15 17:18:51 top-core-1 systemd-timedated[1263]: Changed local time to Sat Feb 15 17:18:51 2025 Feb 15 17:18:51 top-core-1 sudo[1260]: pam_unix(sudo:session): session closed for user root Feb 15 17:18:51 top-core-1 volumio-time-update[608]: volumio-time-update-util: System time updated successfully. Feb 15 17:18:51 top-core-1 systemd[1]: Started Volumio Time Update Utility. Feb 15 17:18:51 top-core-1 systemd[1]: Reached target Multi-User System. Feb 15 17:18:51 top-core-1 systemd[1]: Reached target Graphical Interface. Feb 15 17:18:51 top-core-1 systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 15 17:18:51 top-core-1 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 15 17:18:51 top-core-1 systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 15 17:18:51 top-core-1 systemd[1]: Startup finished in 12.130s (kernel) + 35.109s (userspace) = 47.240s. Feb 15 17:18:52 top-core-1 volumio[866]: info: Setting Geolocation for MyVolumio to as1 Feb 15 17:18:52 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:52 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:52 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:53 top-core-1 volumio[866]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 15 17:18:53 top-core-1 volumio[866]: info: Updating MyVolumio device info Feb 15 17:18:53 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:55 top-core-1 volumio[866]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 21 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 22 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 24 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 25 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 26 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 27 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 29 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 30 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 31 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 32 Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 15 17:18:56 top-core-1 volumio[866]: info: Discovery: Getting this device information Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:56 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 33 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 34 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 35 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 36 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 37 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 38 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 39 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 40 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100:3000 from 192.168.8.101 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 41 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 42 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 43 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 44 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 45 Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:56 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 46 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 47 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 48 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 49 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 50 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 51 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 52 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 53 Feb 15 17:18:56 top-core-1 volumio[866]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 54 Feb 15 17:18:56 top-core-1 volumio[866]: info: Received Get System Info Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 15 17:18:56 top-core-1 volumio[866]: info: Discovery: Getting this device information Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:56 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:56 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetVisibleSources Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:56 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 15 17:18:56 top-core-1 volumio[866]: info: Received Get System Info Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 15 17:18:56 top-core-1 volumio[866]: info: Discovery: Getting this device information Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:56 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:18:56 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:18:56 top-core-1 volumio[866]: info: Listing playlists Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:18:56 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 15 17:18:57 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:18:57 top-core-1 volumio[866]: info: MYVOLUMIO: Adding device Feb 15 17:18:57 top-core-1 volumio[866]: info: MYVOLUMIO: Evaluating Server Feb 15 17:18:57 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:18:58 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:18:58 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:18:59 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:18:59 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:18:59 top-core-1 volumio[866]: info: Setting Geolocation for MyVolumio to as1 Feb 15 17:18:59 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:59 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:18:59 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:19:00 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:00 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:00 top-core-1 volumio[866]: info: Updating MyVolumio device info Feb 15 17:19:00 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:19:00 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:19:00 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 15 17:19:01 top-core-1 volumio[866]: info: Retrieving Cloud Streaming UI Feb 15 17:19:01 top-core-1 volumio[866]: info: Getting Tidal Cloud Configuration Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 15 17:19:01 top-core-1 volumio[866]: info: Getting Qobuz Cloud Configuration Feb 15 17:19:01 top-core-1 volumio[866]: info: Asking plugin for UI Config Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 15 17:19:01 top-core-1 volumio[866]: info: Getting Spotify Cloud Configuration Feb 15 17:19:01 top-core-1 volumio[866]: info: Asking plugin for UI Config Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 15 17:19:01 top-core-1 volumio[866]: info: Saving Spotify Acccount Feb 15 17:19:01 top-core-1 volumio[866]: info: Got Tidal Cloud Configuration Feb 15 17:19:01 top-core-1 volumio[866]: info: Got it Feb 15 17:19:01 top-core-1 volumio[866]: info: Got it Feb 15 17:19:01 top-core-1 volumio[866]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 15 17:19:01 top-core-1 volumio[866]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetBrowseSources Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetBrowseSources Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetBrowseSources Feb 15 17:19:01 top-core-1 volumio[866]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 15 17:19:01 top-core-1 volumio[866]: info: Discovery: Getting this device information Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:19:01 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 15 17:19:01 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:02 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 15 17:19:02 top-core-1 volumio-remote-updater[613]: No test mode Feb 15 17:19:02 top-core-1 volumio-remote-updater[613]: No alpha test mode Feb 15 17:19:02 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:02 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 15 17:19:02 top-core-1 volumio[866]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 55 Feb 15 17:19:02 top-core-1 volumio[866]: info: CoreCommandRouter::volumioGetState Feb 15 17:19:02 top-core-1 volumio[866]: info: CorePlayQueue::getTrack 0 Feb 15 17:19:02 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:02 top-core-1 volumio[866]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 15 17:19:02 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 15 17:19:03 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:03 top-core-1 volumio[866]: info: Disabling MyMusic plugin upnp Feb 15 17:19:03 top-core-1 sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Feb 15 17:19:03 top-core-1 sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 17:19:03 top-core-1 systemd[1]: Stopping UPnP Renderer front-end to MPD... Feb 15 17:19:03 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:04 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:04 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 15 17:19:05 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 15 17:19:06 top-core-1 volumio[866]: info: Enabling MyMusic plugin upnp Feb 15 17:19:06 top-core-1 volumio[866]: info: Enabling plugin upnp Feb 15 17:19:06 top-core-1 volumio[866]: info: Loading plugin "upnp"... Feb 15 17:19:06 top-core-1 volumio[866]: info: [1739607546019] Starting Upmpd Daemon Feb 15 17:19:06 top-core-1 volumio[866]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 17:19:06 top-core-1 volumio[866]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 17:19:06 top-core-1 volumio[866]: Error: listen EADDRINUSE: address already in use :::6599 Feb 15 17:19:06 top-core-1 volumio[866]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Feb 15 17:19:06 top-core-1 volumio[866]: at listenInCluster (net.js:1366:12) Feb 15 17:19:06 top-core-1 volumio[866]: at Server.listen (net.js:1452:7) Feb 15 17:19:06 top-core-1 volumio[866]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Feb 15 17:19:06 top-core-1 volumio[866]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Feb 15 17:19:06 top-core-1 volumio[866]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Feb 15 17:19:06 top-core-1 volumio[866]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 15 17:19:06 top-core-1 volumio[866]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Feb 15 17:19:06 top-core-1 volumio[866]: code: 'EADDRINUSE', Feb 15 17:19:06 top-core-1 volumio[866]: errno: -98, Feb 15 17:19:06 top-core-1 volumio[866]: syscall: 'listen', Feb 15 17:19:06 top-core-1 volumio[866]: address: '::', Feb 15 17:19:06 top-core-1 volumio[866]: port: 6599 Feb 15 17:19:06 top-core-1 volumio[866]: } Feb 15 17:19:06 top-core-1 volumio[866]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 17:19:06 top-core-1 sudo[1315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 17:18 Feb 15 17:19:06 top-core-1 sudo[1315]: 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"