-- Logs begin at Mon 2025-07-07 10:16:16 BST, end at Mon 2025-07-07 10:29:30 BST. -- Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "network"... Jul 07 10:28:00 volumio volumio[4214]: info: Refreshing Cached IP Addresses Jul 07 10:28:00 volumio sudo[4241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 10:28:00 volumio sudo[4241]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:00 volumio sudo[4241]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:00 volumio sudo[4243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 10:28:00 volumio sudo[4243]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:00 volumio sudo[4243]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "services"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "alsa_controller"... Jul 07 10:28:00 volumio sudo[4256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 07 10:28:00 volumio sudo[4256]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:00 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "wizard"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "networkfs"... Jul 07 10:28:00 volumio volumio[4214]: info: Starting Udev Watcher for removable devices Jul 07 10:28:00 volumio volumio[4214]: info: Ignoring mount for partition: boot Jul 07 10:28:00 volumio volumio[4214]: info: Ignoring mount for partition: volumio Jul 07 10:28:00 volumio volumio[4214]: info: Ignoring mount for partition: volumio_data Jul 07 10:28:00 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "volumio_command_line_client"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "upnp"... Jul 07 10:28:00 volumio volumio[4214]: info: [1751880480202] Starting Upmpd Daemon Jul 07 10:28:00 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "my_music"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "mpd"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "upnp_browser"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "alarm-clock"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "airplay_emulation"... Jul 07 10:28:00 volumio volumio[4214]: info: Starting Shairport Sync Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "last_100"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "webradio"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "i2s_dacs"... Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "volumiodiscovery"... Jul 07 10:28:00 volumio volumio[4214]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:00 volumio node[4214]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:00 volumio node[4214]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:00 volumio volumio[4214]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:00 volumio volumio[4214]: *** WARNING *** For more information see Jul 07 10:28:00 volumio volumio[4214]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:00 volumio volumio[4214]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:00 volumio volumio[4214]: *** WARNING *** For more information see Jul 07 10:28:00 volumio node[4214]: *** WARNING *** For more information see Jul 07 10:28:00 volumio node[4214]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:00 volumio node[4214]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:00 volumio node[4214]: *** WARNING *** For more information see Jul 07 10:28:00 volumio volumio[4214]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 07 10:28:00 volumio volumio[4214]: info: Discovery: Started advertising with name: Volumio Jul 07 10:28:00 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:00 volumio volumio[4214]: info: Loading plugin "ytcr"... Jul 07 10:28:01 volumio volumio[4214]: info: Loading plugin "ytmusic"... Jul 07 10:28:01 volumio volumio[4214]: info: Loading plugin "outputs"... Jul 07 10:28:01 volumio volumio[4214]: info: Loading plugin "albumart"... Jul 07 10:28:01 volumio volumio[4214]: info: Plugin example_plugin is not enabled Jul 07 10:28:01 volumio volumio[4214]: info: Loading plugin "inputs"... Jul 07 10:28:01 volumio volumio[4214]: info: Loading plugin "updater_comm"... Jul 07 10:28:01 volumio volumio[4214]: info: Plugin mpdemulation is not enabled Jul 07 10:28:01 volumio volumio[4214]: info: Loading plugin "rest_api"... Jul 07 10:28:01 volumio volumio[4214]: info: Loading plugin "websocket"... Jul 07 10:28:01 volumio volumio[4214]: info: Starting Socket.io Server version 2.3.0 Jul 07 10:28:01 volumio volumio[4214]: info: Loading plugin "radio_paradise"... Jul 07 10:28:01 volumio volumio[4214]: Forking 3 albumart workers Jul 07 10:28:01 volumio volumio[4214]: info: Applying required configuration parameters for plugin radio_paradise Jul 07 10:28:01 volumio volumio[4214]: info: [1751880481852] [RadioParadise] API delay: 5 Jul 07 10:28:01 volumio volumio[4214]: info: Loading i18n strings for locale en Jul 07 10:28:01 volumio volumio[4214]: Updating browse sources language Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::initPlayerControls Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:01 volumio volumio[4214]: Express server listening on port 3000 Jul 07 10:28:01 volumio volumio[4214]: [Metrics] WebUI: 2s 223.60ms Jul 07 10:28:01 volumio volumio[4214]: info: CoreStateMachine::resetVolumioState Jul 07 10:28:01 volumio volumio[4214]: info: CoreStateMachine::getcurrentVolume Jul 07 10:28:01 volumio volumio[4214]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 10:28:01 volumio volumio[4214]: info: Volumio Network Manager: Network status updated: 3 Jul 07 10:28:02 volumio volumio[4214]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 07 10:28:02 volumio volumio[4214]: Starting albumart workers Jul 07 10:28:02 volumio volumio[4214]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 07 10:28:02 volumio volumio[4214]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 07 10:28:02 volumio volumio[4214]: Starting albumart workers Jul 07 10:28:02 volumio volumio[4214]: Starting albumart workers Jul 07 10:28:02 volumio volumio[4214]: info: Reloading queue from file Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: Executing start script for DAC IQaudIO DAC Plus Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: VolumeController:: Volume=100 Mute =false Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::pushState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::updateTrackBlock Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrackBlock Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 10:28:02 volumio volumio[4214]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jul 07 10:28:02 volumio volumio[4214]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Jul 07 10:28:02 volumio volumio[4214]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::setRepeat null single undefined Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::pushState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::setRandom null Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::pushState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:02 volumio volumio[4214]: info: Received Get System Info Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 10:28:02 volumio volumio[4214]: info: Discovery: Getting this device information Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetVisibleSources Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 07 10:28:02 volumio volumio[4214]: info: Received Get System Info Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 10:28:02 volumio volumio[4214]: info: Discovery: Getting this device information Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: Listing playlists Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetQueue Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::getQueue Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getQueue Jul 07 10:28:02 volumio volumio[4214]: error: Cannot execute DAC script: Error: Command failed: /volumio/app/plugins/system_controller/i2s_dacs/scripts/iqamp-unmute.sh Jul 07 10:28:02 volumio volumio[4214]: Oops: Unable to determine board revision from /proc/cpuinfo Jul 07 10:28:02 volumio volumio[4214]: -> No "Hardware" line Jul 07 10:28:02 volumio volumio[4214]: -> You'd best google the error to find out why. Jul 07 10:28:02 volumio volumio[4214]: Oops: Unable to determine board revision from /proc/cpuinfo Jul 07 10:28:02 volumio volumio[4214]: -> No "Hardware" line Jul 07 10:28:02 volumio volumio[4214]: -> You'd best google the error to find out why. Jul 07 10:28:02 volumio volumio[4214]: info: Setting Device type: Raspberry PI Jul 07 10:28:02 volumio volumio[4214]: info: Completed loading Core Plugins Jul 07 10:28:02 volumio volumio[4214]: info: Preparing to generate the ALSA configuration file Jul 07 10:28:02 volumio volumio[4214]: info: VolumeController:: Volume=100 Mute =false Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::pushState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:02 volumio volumio[4214]: info: Discovery: adding b330b747-79f9-422d-9bc1-3c6dc5c8d543 Jul 07 10:28:02 volumio volumio[4214]: info: Discovery: Found device Volumio Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: Asound.conf file unchanged, so no further update is needed Jul 07 10:28:02 volumio volumio[4214]: info: Output device has changed, restarting MPD Jul 07 10:28:02 volumio sudo[4345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 10:28:02 volumio sudo[4345]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:02 volumio sudo[4345]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:02 volumio volumio[4214]: info: Output device has changed, restarting Shairport Sync Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:02 volumio sudo[4348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 10:28:02 volumio sudo[4348]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:02 volumio systemd[1]: Stopping Music Player Daemon... Jul 07 10:28:02 volumio volumio[4214]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:02 volumio volumio[4214]: info: ___________ START PLUGINS ___________ Jul 07 10:28:02 volumio volumio[4214]: info: ControllerMpd::onStart: Initializing MPD Jul 07 10:28:02 volumio systemd[1]: mpd.service: Succeeded. Jul 07 10:28:02 volumio volumio[4214]: info: Creating MPD Configuration file Jul 07 10:28:02 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 10:28:02 volumio sudo[4355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 10:28:02 volumio sudo[4355]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:02 volumio volumio[4214]: info: [1751880482368] CoreMusicLibrary::Adding element Media Servers Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:02 volumio sudo[4355]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:02 volumio systemd[1]: Starting Music Player Daemon... Jul 07 10:28:02 volumio sudo[4358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 10:28:02 volumio sudo[4358]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:02 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 07 10:28:02 volumio systemd[1]: mpd.service: Succeeded. Jul 07 10:28:02 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 10:28:02 volumio systemd[1]: Starting Music Player Daemon... Jul 07 10:28:02 volumio volumio[4214]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:02 volumio sudo[4362]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 07 10:28:02 volumio sudo[4362]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:02 volumio sudo[4362]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:02 volumio volumio[4214]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:02 volumio volumio[4214]: info: [1751880482408] CoreMusicLibrary::Adding element Last_100 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:02 volumio volumio[4214]: info: [1751880482409] CoreMusicLibrary::Adding element Webradio Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:02 volumio volumio[4214]: info: Initializing BBC Radios Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:02 volumio volumio[4214]: info: [1751880482451] CoreMusicLibrary::Adding element YouTube Music Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:02 volumio volumio[4214]: Cannot find translation for source YouTube Music Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:02 volumio volumio[4214]: info: [1751880482453] CoreMusicLibrary::Adding element Radio Paradise Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:02 volumio volumio[4214]: Cannot find translation for source YouTube Music Jul 07 10:28:02 volumio volumio[4214]: Cannot find translation for source Radio Paradise Jul 07 10:28:02 volumio volumio[4214]: info: Volumio Calling Home Jul 07 10:28:02 volumio volumio[4214]: info: VolumeController::SetAlsaVolume0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreStateMachine::pushState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:02 volumio volumio[4214]: info: Discovery: this is already registered, b330b747-79f9-422d-9bc1-3c6dc5c8d543 Jul 07 10:28:02 volumio volumio[4214]: info: Discovery: Found device Volumio Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio volumio[4214]: info: MPD Permissions set Jul 07 10:28:02 volumio volumio[4214]: info: MPD Permissions set Jul 07 10:28:02 volumio volumio[4214]: info: Volumio called home Jul 07 10:28:02 volumio volumio[4214]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:02 volumio volumio[4214]: info: Starting Shairport Sync Jul 07 10:28:02 volumio volumio[4214]: info: Starting Shairport Sync Jul 07 10:28:02 volumio sudo[4393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:02 volumio sudo[4393]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:02 volumio volumio[4214]: info: Starting Shairport Sync Jul 07 10:28:02 volumio sudo[4396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:02 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 07 10:28:02 volumio sudo[4396]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:02 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 07 10:28:02 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:02 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:02 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:02 volumio sudo[4398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:02 volumio sudo[4398]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:02 volumio sudo[4393]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:02 volumio mpd[4369]: Jul 07 10:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 07 10:28:02 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 07 10:28:02 volumio systemd[1]: Started Music Player Daemon. Jul 07 10:28:02 volumio sudo[4348]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:02 volumio sudo[4358]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:02 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 07 10:28:02 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 07 10:28:02 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:02 volumio sudo[4396]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:02 volumio sudo[4398]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:02 volumio volumio[4214]: info: Shairport-Sync Started Jul 07 10:28:02 volumio volumio[4214]: Error adding Membership: Error: addMembership EINVAL Jul 07 10:28:02 volumio volumio[4214]: info: Shairport-Sync Started Jul 07 10:28:02 volumio volumio[4214]: info: Shairport-Sync Started Jul 07 10:28:02 volumio volumio[4214]: error: MPD error: The expression evaluated to a falsy value: Jul 07 10:28:02 volumio volumio[4214]: assert.ok(self.idling) Jul 07 10:28:02 volumio volumio[4214]: error: The expression evaluated to a falsy value: Jul 07 10:28:02 volumio volumio[4214]: assert.ok(self.idling) Jul 07 10:28:02 volumio volumio[4214]: info: MPD running with PID4369 Jul 07 10:28:02 volumio volumio[4214]: ,establishing connection Jul 07 10:28:02 volumio volumio[4214]: error: updateQueue error: null Jul 07 10:28:02 volumio volumio[4214]: error: updateQueue error: null Jul 07 10:28:03 volumio volumio[4214]: info: [yt-cast-receiver] DIAL server listening on port 8098 Jul 07 10:28:03 volumio volumio[4214]: info: Completed starting Core Plugins Jul 07 10:28:03 volumio volumio[4214]: info: ------------------------------------------- Jul 07 10:28:03 volumio volumio[4214]: info: ----- MyVolumio plugins startup ---- Jul 07 10:28:03 volumio volumio[4214]: info: ------------------------------------------- Jul 07 10:28:03 volumio volumio[4214]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 07 10:28:03 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:03 volumio sudo[4256]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:04 volumio volumio-remote-updater[694]: [2025-07-07 10:28:04] [connect] Successful connection Jul 07 10:28:04 volumio volumio-remote-updater[694]: [2025-07-07 10:28:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751880484 101 Jul 07 10:28:04 volumio volumio[4214]: 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: 5 Jul 07 10:28:07 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:07 volumio volumio[4214]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 07 10:28:08 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:08 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:08 volumio volumio[4214]: info: Listing playlists Jul 07 10:28:08 volumio volumio[4214]: info: Listing playlists Jul 07 10:28:10 volumio sudo[4425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 10:28:10 volumio sudo[4425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:10 volumio sudo[4425]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:10 volumio sudo[4428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 10:28:10 volumio sudo[4428]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:10 volumio sudo[4428]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:10 volumio sudo[4431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 07 10:28:10 volumio sudo[4431]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:10 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 07 10:28:10 volumio sudo[4431]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:10 volumio volumio[4214]: info: Upmpdcli Daemon Started Jul 07 10:28:10 volumio volumio[4433]: writing RSA key Jul 07 10:28:11 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:11 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:11 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:11 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 07 10:28:11 volumio volumio[4214]: info: Adding plugin bluetooth to MyMusic Plugins Jul 07 10:28:11 volumio volumio[4214]: info: Adding plugin multiroom to MyMusic Plugins Jul 07 10:28:11 volumio volumio[4214]: info: Adding plugin metavolumio to MyMusic Plugins Jul 07 10:28:11 volumio volumio[4214]: info: Adding plugin cd_controller to MyMusic Plugins Jul 07 10:28:11 volumio volumio[4214]: info: Adding plugin qobuzconnect to MyMusic Plugins Jul 07 10:28:11 volumio volumio[4214]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 07 10:28:11 volumio volumio[4214]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 07 10:28:11 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:11 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:11 volumio volumio[4214]: info: Starting MyVolumio Remote Streaming Endpoints Jul 07 10:28:11 volumio volumio[4214]: info: MyVolumio login type: Token Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 07 10:28:11 volumio volumio[4214]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 07 10:28:12 volumio volumio[4214]: info: Starting Streaming Service Transparent Proxy Jul 07 10:28:12 volumio volumio[4214]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 07 10:28:12 volumio volumio[4214]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 07 10:28:12 volumio volumio[4214]: info: Streaming services startup Jul 07 10:28:12 volumio volumio[4214]: info: Starting Streaming Daemon Jul 07 10:28:12 volumio sudo[4470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 07 10:28:12 volumio sudo[4470]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:12 volumio sudo[4470]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:12 volumio volumio[4214]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 07 10:28:12 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:12 volumio volumio[4214]: error: Cannot start Volumio Streaming Daemon Jul 07 10:28:12 volumio volumio[4214]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 07 10:28:12 volumio volumio[4214]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 07 10:28:12 volumio volumio[4214]: STREAMING PROXY: Starting server on port 3245 Jul 07 10:28:12 volumio volumio[4214]: Node JS runtime: 14 Jul 07 10:28:12 volumio volumio[4214]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 07 10:28:13 volumio volumio[4214]: info: MyVolumio token set successfully Jul 07 10:28:13 volumio volumio[4214]: info: MYVOLUMIO: Adding device Jul 07 10:28:13 volumio volumio[4214]: info: MYVOLUMIO: Evaluating Server Jul 07 10:28:13 volumio volumio[4214]: info: MyVolumio status changed Jul 07 10:28:13 volumio volumio[4214]: info: Streaming services startup Jul 07 10:28:13 volumio volumio[4214]: info: Starting Streaming Daemon Jul 07 10:28:13 volumio volumio[4214]: info: Removing browser output: myVolumio user plan is not superstar Jul 07 10:28:13 volumio volumio[4214]: info: Removing audio output: Jul 07 10:28:13 volumio volumio[4214]: info: Stoppping Tunnel 1 Jul 07 10:28:13 volumio sudo[4495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 07 10:28:13 volumio sudo[4495]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:13 volumio sudo[4495]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:13 volumio sudo[4498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 07 10:28:13 volumio sudo[4498]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:13 volumio volumio[4214]: error: Cannot start Volumio Streaming Daemon Jul 07 10:28:13 volumio volumio[4214]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 07 10:28:13 volumio volumio[4214]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 07 10:28:13 volumio sudo[4498]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:13 volumio volumio[4214]: info: Remote SSH Stopped Jul 07 10:28:13 volumio volumio[4214]: info: Setting Geolocation for MyVolumio to eu3 Jul 07 10:28:13 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:13 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:13 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:14 volumio volumio[4214]: info: Successfully Added MyVolumio device Jul 07 10:28:14 volumio volumio[4214]: info: CoreCommandRouter::Close All Modals sent Jul 07 10:28:14 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Jul 07 10:28:14 volumio volumio[4214]: info: Updating MyVolumio device info Jul 07 10:28:14 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:15 volumio volumio[4214]: info: Successfully Updated MyVolumio device Jul 07 10:28:15 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:18 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:18 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:19 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:23 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:25 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 07 10:28:25 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 07 10:28:26 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 07 10:28:26 volumio volumio[4214]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 07 10:28:26 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:26 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:27 volumio volumio[4214]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:28 volumio volumio[4214]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:28 volumio volumio[4214]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:28 volumio volumio[4214]: info: Listing playlists Jul 07 10:28:28 volumio volumio[4214]: info: Listing playlists Jul 07 10:28:30 volumio volumio[4214]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 10:28:30 volumio volumio[4214]: Error: dns service error: unknown Jul 07 10:28:30 volumio volumio[4214]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jul 07 10:28:30 volumio volumio[4214]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jul 07 10:28:30 volumio volumio[4214]: errorCode: -65537 Jul 07 10:28:30 volumio volumio[4214]: } Jul 07 10:28:30 volumio volumio[4214]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 10:28:31 volumio sudo[4609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-07 10:27 Jul 07 10:28:31 volumio sudo[4609]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:31 volumio sudo[4609]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:31 volumio volumio-remote-updater[694]: [2025-07-07 10:28:31] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 07 10:28:31 volumio volumio-remote-updater[694]: [2025-07-07 10:28:31] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 07 10:28:31 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 07 10:28:31 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 07 10:28:31 volumio systemd[1]: Started dynamicswap service. Jul 07 10:28:31 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 07 10:28:31 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 07 10:28:31 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jul 07 10:28:31 volumio systemd[1]: Started dynamicswap service. Jul 07 10:28:31 volumio systemd[1]: Stopped Volumio Backend Module. Jul 07 10:28:31 volumio systemd[1]: Started Volumio Backend Module. Jul 07 10:28:31 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 07 10:28:31 volumio volumio[4620]: info: ------------------------------------------- Jul 07 10:28:31 volumio volumio[4620]: info: ----- Volumio3 ---- Jul 07 10:28:31 volumio volumio[4620]: info: ------------------------------------------- Jul 07 10:28:31 volumio volumio[4620]: info: ----- System startup ---- Jul 07 10:28:31 volumio volumio[4620]: info: ------------------------------------------- Jul 07 10:28:31 volumio volumio[4620]: info: MYVOLUMIO Environment detected Jul 07 10:28:31 volumio volumio[4620]: info: Plugin folders cleanup Jul 07 10:28:31 volumio volumio[4620]: info: Scanning into folder /volumio/app/plugins/ Jul 07 10:28:31 volumio volumio[4620]: info: Scanning category audio_interface Jul 07 10:28:31 volumio volumio[4620]: info: Scanning category miscellanea Jul 07 10:28:31 volumio volumio[4620]: info: Scanning category music_service Jul 07 10:28:31 volumio volumio[4620]: info: Scanning category plugins.json Jul 07 10:28:31 volumio volumio[4620]: info: Scanning category system_controller Jul 07 10:28:31 volumio volumio[4620]: info: Scanning category user_interface Jul 07 10:28:31 volumio volumio[4620]: info: Scanning into folder /data/plugins/ Jul 07 10:28:31 volumio volumio[4620]: info: Scanning category music_service Jul 07 10:28:31 volumio volumio[4620]: info: Plugin folders cleanup completed Jul 07 10:28:31 volumio volumio[4620]: info: ------------------------------------------- Jul 07 10:28:31 volumio volumio[4620]: info: ----- Core plugins startup ---- Jul 07 10:28:31 volumio volumio[4620]: info: ------------------------------------------- Jul 07 10:28:31 volumio volumio[4620]: info: Loading plugins from folder /volumio/app/plugins/ Jul 07 10:28:31 volumio volumio[4620]: info: Adding plugin upnp to MyMusic Plugins Jul 07 10:28:31 volumio volumio[4620]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 07 10:28:31 volumio volumio[4620]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 07 10:28:31 volumio volumio[4620]: info: Loading plugins from folder /data/plugins/ Jul 07 10:28:31 volumio volumio[4620]: info: Loading plugin "system"... Jul 07 10:28:31 volumio volumio[4620]: info: Loading plugin "appearance"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "network"... Jul 07 10:28:32 volumio volumio[4620]: info: Refreshing Cached IP Addresses Jul 07 10:28:32 volumio sudo[4646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 10:28:32 volumio sudo[4646]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:32 volumio sudo[4646]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:32 volumio sudo[4648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 10:28:32 volumio sudo[4648]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:32 volumio sudo[4648]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "services"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "alsa_controller"... Jul 07 10:28:32 volumio sudo[4661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 07 10:28:32 volumio sudo[4661]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:32 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "wizard"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "networkfs"... Jul 07 10:28:32 volumio volumio[4620]: info: Starting Udev Watcher for removable devices Jul 07 10:28:32 volumio volumio[4620]: info: Ignoring mount for partition: boot Jul 07 10:28:32 volumio volumio[4620]: info: Ignoring mount for partition: volumio Jul 07 10:28:32 volumio volumio[4620]: info: Ignoring mount for partition: volumio_data Jul 07 10:28:32 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "volumio_command_line_client"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "upnp"... Jul 07 10:28:32 volumio volumio[4620]: info: [1751880512194] Starting Upmpd Daemon Jul 07 10:28:32 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "my_music"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "mpd"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "upnp_browser"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "alarm-clock"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "airplay_emulation"... Jul 07 10:28:32 volumio volumio[4620]: info: Starting Shairport Sync Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "last_100"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "webradio"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "i2s_dacs"... Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "volumiodiscovery"... Jul 07 10:28:32 volumio volumio[4620]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:32 volumio node[4620]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:32 volumio node[4620]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:32 volumio volumio[4620]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:32 volumio volumio[4620]: *** WARNING *** For more information see Jul 07 10:28:32 volumio volumio[4620]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:32 volumio volumio[4620]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:32 volumio volumio[4620]: *** WARNING *** For more information see Jul 07 10:28:32 volumio node[4620]: *** WARNING *** For more information see Jul 07 10:28:32 volumio node[4620]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:32 volumio node[4620]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:32 volumio node[4620]: *** WARNING *** For more information see Jul 07 10:28:32 volumio volumio[4620]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 07 10:28:32 volumio volumio[4620]: info: Discovery: Started advertising with name: Volumio Jul 07 10:28:32 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:32 volumio volumio[4620]: info: Loading plugin "ytcr"... Jul 07 10:28:33 volumio volumio[4620]: info: Loading plugin "ytmusic"... Jul 07 10:28:33 volumio volumio[4620]: info: Loading plugin "outputs"... Jul 07 10:28:33 volumio volumio[4620]: info: Loading plugin "albumart"... Jul 07 10:28:33 volumio volumio[4620]: info: Plugin example_plugin is not enabled Jul 07 10:28:33 volumio volumio[4620]: info: Loading plugin "inputs"... Jul 07 10:28:33 volumio volumio[4620]: info: Loading plugin "updater_comm"... Jul 07 10:28:33 volumio volumio[4620]: info: Plugin mpdemulation is not enabled Jul 07 10:28:33 volumio volumio[4620]: info: Loading plugin "rest_api"... Jul 07 10:28:33 volumio volumio[4620]: info: Loading plugin "websocket"... Jul 07 10:28:33 volumio volumio[4620]: info: Starting Socket.io Server version 2.3.0 Jul 07 10:28:33 volumio volumio[4620]: info: Loading plugin "radio_paradise"... Jul 07 10:28:33 volumio volumio[4620]: Forking 3 albumart workers Jul 07 10:28:33 volumio volumio[4620]: info: Applying required configuration parameters for plugin radio_paradise Jul 07 10:28:33 volumio volumio[4620]: info: [1751880513812] [RadioParadise] API delay: 5 Jul 07 10:28:33 volumio volumio[4620]: info: Loading i18n strings for locale en Jul 07 10:28:33 volumio volumio[4620]: Updating browse sources language Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::initPlayerControls Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:33 volumio volumio[4620]: Express server listening on port 3000 Jul 07 10:28:33 volumio volumio[4620]: [Metrics] WebUI: 2s 180.43ms Jul 07 10:28:33 volumio volumio[4620]: info: CoreStateMachine::resetVolumioState Jul 07 10:28:33 volumio volumio[4620]: info: CoreStateMachine::getcurrentVolume Jul 07 10:28:33 volumio volumio[4620]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 10:28:33 volumio volumio[4620]: info: Volumio Network Manager: Network status updated: 3 Jul 07 10:28:33 volumio volumio[4620]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 07 10:28:33 volumio volumio[4620]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 07 10:28:33 volumio volumio[4620]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 07 10:28:33 volumio volumio[4620]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: Executing start script for DAC IQaudIO DAC Plus Jul 07 10:28:34 volumio volumio[4620]: info: Reloading queue from file Jul 07 10:28:34 volumio volumio[4620]: Starting albumart workers Jul 07 10:28:34 volumio volumio[4620]: Starting albumart workers Jul 07 10:28:34 volumio volumio[4620]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 07 10:28:34 volumio volumio[4620]: info: CoreStateMachine::setRepeat null single undefined Jul 07 10:28:34 volumio volumio[4620]: info: CoreStateMachine::pushState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:34 volumio volumio[4620]: info: CoreStateMachine::setRandom null Jul 07 10:28:34 volumio volumio[4620]: info: CoreStateMachine::pushState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:34 volumio volumio[4620]: info: Setting Device type: Raspberry PI Jul 07 10:28:34 volumio volumio[4620]: Starting albumart workers Jul 07 10:28:34 volumio volumio[4620]: info: VolumeController:: Volume=0 Mute =false Jul 07 10:28:34 volumio volumio[4620]: info: CoreStateMachine::pushState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:34 volumio volumio[4620]: info: CoreStateMachine::updateTrackBlock Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrackBlock Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 10:28:34 volumio volumio[4620]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jul 07 10:28:34 volumio volumio[4620]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Jul 07 10:28:34 volumio volumio[4620]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: error: Cannot execute DAC script: Error: Command failed: /volumio/app/plugins/system_controller/i2s_dacs/scripts/iqamp-unmute.sh Jul 07 10:28:34 volumio volumio[4620]: Oops: Unable to determine board revision from /proc/cpuinfo Jul 07 10:28:34 volumio volumio[4620]: -> No "Hardware" line Jul 07 10:28:34 volumio volumio[4620]: -> You'd best google the error to find out why. Jul 07 10:28:34 volumio volumio[4620]: Oops: Unable to determine board revision from /proc/cpuinfo Jul 07 10:28:34 volumio volumio[4620]: -> No "Hardware" line Jul 07 10:28:34 volumio volumio[4620]: -> You'd best google the error to find out why. Jul 07 10:28:34 volumio volumio[4620]: info: Completed loading Core Plugins Jul 07 10:28:34 volumio volumio[4620]: info: Preparing to generate the ALSA configuration file Jul 07 10:28:34 volumio volumio[4620]: info: Received Get System Info Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 10:28:34 volumio volumio[4620]: info: Discovery: Getting this device information Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetVisibleSources Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 07 10:28:34 volumio volumio[4620]: info: Received Get System Info Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 10:28:34 volumio volumio[4620]: info: Discovery: Getting this device information Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: Listing playlists Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetQueue Jul 07 10:28:34 volumio volumio[4620]: info: CoreStateMachine::getQueue Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getQueue Jul 07 10:28:34 volumio volumio[4620]: info: Discovery: adding b330b747-79f9-422d-9bc1-3c6dc5c8d543 Jul 07 10:28:34 volumio volumio[4620]: info: Discovery: Found device Volumio Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: VolumeController:: Volume=0 Mute =false Jul 07 10:28:34 volumio volumio[4620]: info: CoreStateMachine::pushState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:34 volumio volumio[4620]: info: Asound.conf file unchanged, so no further update is needed Jul 07 10:28:34 volumio volumio[4620]: info: Output device has changed, restarting MPD Jul 07 10:28:34 volumio sudo[4731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 10:28:34 volumio sudo[4731]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:34 volumio volumio[4620]: info: Output device has changed, restarting Shairport Sync Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:34 volumio sudo[4731]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:34 volumio sudo[4733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 10:28:34 volumio sudo[4733]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:34 volumio volumio[4620]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:34 volumio volumio[4620]: info: ___________ START PLUGINS ___________ Jul 07 10:28:34 volumio systemd[1]: Stopping Music Player Daemon... Jul 07 10:28:34 volumio volumio[4620]: info: ControllerMpd::onStart: Initializing MPD Jul 07 10:28:34 volumio volumio[4620]: info: Creating MPD Configuration file Jul 07 10:28:34 volumio systemd[1]: mpd.service: Succeeded. Jul 07 10:28:34 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 10:28:34 volumio sudo[4757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 10:28:34 volumio sudo[4757]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:34 volumio volumio[4620]: info: [1751880514280] CoreMusicLibrary::Adding element Media Servers Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:34 volumio sudo[4757]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:34 volumio systemd[1]: Starting Music Player Daemon... Jul 07 10:28:34 volumio sudo[4760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 10:28:34 volumio sudo[4760]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:34 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 07 10:28:34 volumio systemd[1]: mpd.service: Succeeded. Jul 07 10:28:34 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 10:28:34 volumio systemd[1]: Starting Music Player Daemon... Jul 07 10:28:34 volumio volumio[4620]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:34 volumio sudo[4765]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 07 10:28:34 volumio sudo[4765]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:34 volumio sudo[4765]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:34 volumio volumio[4620]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:34 volumio volumio[4620]: info: [1751880514326] CoreMusicLibrary::Adding element Last_100 Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:34 volumio volumio[4620]: info: [1751880514327] CoreMusicLibrary::Adding element Webradio Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:34 volumio volumio[4620]: info: Initializing BBC Radios Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:34 volumio volumio[4620]: info: [1751880514372] CoreMusicLibrary::Adding element YouTube Music Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:34 volumio volumio[4620]: Cannot find translation for source YouTube Music Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:34 volumio volumio[4620]: info: [1751880514373] CoreMusicLibrary::Adding element Radio Paradise Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:34 volumio volumio[4620]: Cannot find translation for source YouTube Music Jul 07 10:28:34 volumio volumio[4620]: Cannot find translation for source Radio Paradise Jul 07 10:28:34 volumio volumio[4620]: info: Volumio Calling Home Jul 07 10:28:34 volumio volumio[4620]: info: Discovery: this is already registered, b330b747-79f9-422d-9bc1-3c6dc5c8d543 Jul 07 10:28:34 volumio volumio[4620]: info: Discovery: Found device Volumio Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio volumio[4620]: info: MPD Permissions set Jul 07 10:28:34 volumio volumio[4620]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 07 10:28:34 volumio volumio[4620]: info: Volumio called home Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:34 volumio volumio[4620]: info: Starting Shairport Sync Jul 07 10:28:34 volumio volumio[4620]: info: Starting Shairport Sync Jul 07 10:28:34 volumio sudo[4804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:34 volumio sudo[4804]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:34 volumio volumio[4620]: info: Starting Shairport Sync Jul 07 10:28:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 07 10:28:34 volumio sudo[4807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:34 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 07 10:28:34 volumio sudo[4807]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:34 volumio mpd[4770]: Jul 07 10:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 07 10:28:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:34 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:34 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:34 volumio sudo[4813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:34 volumio systemd[1]: Started Music Player Daemon. Jul 07 10:28:34 volumio sudo[4813]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:34 volumio sudo[4804]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:34 volumio sudo[4760]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:34 volumio sudo[4733]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 07 10:28:34 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 07 10:28:34 volumio volumio[4620]: info: Shairport-Sync Started Jul 07 10:28:34 volumio volumio[4620]: Error adding Membership: Error: addMembership EINVAL Jul 07 10:28:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:34 volumio sudo[4807]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:34 volumio sudo[4813]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:34 volumio volumio[4620]: error: MPD error: The expression evaluated to a falsy value: Jul 07 10:28:34 volumio volumio[4620]: assert.ok(self.idling) Jul 07 10:28:34 volumio volumio[4620]: error: The expression evaluated to a falsy value: Jul 07 10:28:34 volumio volumio[4620]: assert.ok(self.idling) Jul 07 10:28:34 volumio volumio[4620]: info: MPD running with PID4770 Jul 07 10:28:34 volumio volumio[4620]: ,establishing connection Jul 07 10:28:34 volumio volumio[4620]: info: Shairport-Sync Started Jul 07 10:28:34 volumio volumio[4620]: error: MPD error: The expression evaluated to a falsy value: Jul 07 10:28:34 volumio volumio[4620]: assert.ok(self.idling) Jul 07 10:28:34 volumio volumio[4620]: error: The expression evaluated to a falsy value: Jul 07 10:28:34 volumio volumio[4620]: assert.ok(self.idling) Jul 07 10:28:34 volumio volumio[4620]: info: Shairport-Sync Started Jul 07 10:28:34 volumio volumio[4620]: error: updateQueue error: null Jul 07 10:28:35 volumio volumio[4620]: info: [yt-cast-receiver] DIAL server listening on port 8098 Jul 07 10:28:35 volumio volumio[4620]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 10:28:35 volumio volumio[4620]: info: VolumeController:: Volume=0 Mute =false Jul 07 10:28:35 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:35 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:35 volumio volumio[4620]: info: CoreStateMachine::pushState Jul 07 10:28:35 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:35 volumio volumio[4620]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:35 volumio volumio[4620]: info: Completed starting Core Plugins Jul 07 10:28:35 volumio volumio[4620]: info: ------------------------------------------- Jul 07 10:28:35 volumio volumio[4620]: info: ----- MyVolumio plugins startup ---- Jul 07 10:28:35 volumio volumio[4620]: info: ------------------------------------------- Jul 07 10:28:35 volumio volumio[4620]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 07 10:28:35 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:35 volumio sudo[4661]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:36 volumio volumio-remote-updater[694]: [2025-07-07 10:28:36] [connect] Successful connection Jul 07 10:28:36 volumio volumio-remote-updater[694]: [2025-07-07 10:28:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751880516 101 Jul 07 10:28:36 volumio volumio[4620]: 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: 7 Jul 07 10:28:38 volumio volumio[4620]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:38 volumio volumio[4620]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:39 volumio volumio[4620]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:39 volumio volumio[4620]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 07 10:28:41 volumio volumio[4620]: info: Enabling MyMusic plugin metavolumio Jul 07 10:28:41 volumio volumio[4620]: info: [MyVolumio PluginManager] Enabling and starting plugin miscellanea metavolumio Jul 07 10:28:41 volumio volumio[4620]: info: [MyVolumio PluginManager] Plugin miscellanea metavolumio not in user plan, not enabling Jul 07 10:28:41 volumio volumio[4620]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 10:28:41 volumio volumio[4620]: TypeError: Cannot read property 'toUpperCase' of undefined Jul 07 10:28:41 volumio volumio[4620]: at MyVolumioPluginManager.pushMyVolumioRequiredAccountModal (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:19516) Jul 07 10:28:41 volumio volumio[4620]: at MyVolumioPluginManager.enablePlugin (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:18418) Jul 07 10:28:41 volumio volumio[4620]: at MyVolumioPluginManager.enableAndStartPlugin (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:17039) Jul 07 10:28:41 volumio volumio[4620]: at PluginManager.enableDisableMyMusicPlugin (/volumio/app/pluginmanager.js:2024:48) Jul 07 10:28:41 volumio volumio[4620]: at CoreCommandRouter.enableDisableMyMusicPlugin (/volumio/app/index.js:2107:29) Jul 07 10:28:41 volumio volumio[4620]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1935:59) Jul 07 10:28:41 volumio volumio[4620]: at Socket.emit (events.js:315:20) Jul 07 10:28:41 volumio volumio[4620]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 07 10:28:41 volumio volumio[4620]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 07 10:28:41 volumio volumio[4620]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 10:28:42 volumio sudo[4839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-07 10:27 Jul 07 10:28:42 volumio sudo[4839]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:42 volumio sudo[4839]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:42 volumio volumio-remote-updater[694]: [2025-07-07 10:28:42] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 07 10:28:42 volumio volumio-remote-updater[694]: [2025-07-07 10:28:42] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 07 10:28:42 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 07 10:28:42 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 07 10:28:42 volumio systemd[1]: Started dynamicswap service. Jul 07 10:28:42 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 07 10:28:42 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 07 10:28:42 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jul 07 10:28:42 volumio systemd[1]: Started dynamicswap service. Jul 07 10:28:42 volumio systemd[1]: Stopped Volumio Backend Module. Jul 07 10:28:42 volumio systemd[1]: Started Volumio Backend Module. Jul 07 10:28:42 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 07 10:28:42 volumio volumio[4868]: info: ------------------------------------------- Jul 07 10:28:42 volumio volumio[4868]: info: ----- Volumio3 ---- Jul 07 10:28:42 volumio volumio[4868]: info: ------------------------------------------- Jul 07 10:28:42 volumio volumio[4868]: info: ----- System startup ---- Jul 07 10:28:42 volumio volumio[4868]: info: ------------------------------------------- Jul 07 10:28:42 volumio volumio[4868]: info: MYVOLUMIO Environment detected Jul 07 10:28:42 volumio volumio[4868]: info: Plugin folders cleanup Jul 07 10:28:42 volumio volumio[4868]: info: Scanning into folder /volumio/app/plugins/ Jul 07 10:28:42 volumio volumio[4868]: info: Scanning category audio_interface Jul 07 10:28:42 volumio volumio[4868]: info: Scanning category miscellanea Jul 07 10:28:42 volumio volumio[4868]: info: Scanning category music_service Jul 07 10:28:42 volumio volumio[4868]: info: Scanning category plugins.json Jul 07 10:28:42 volumio volumio[4868]: info: Scanning category system_controller Jul 07 10:28:42 volumio volumio[4868]: info: Scanning category user_interface Jul 07 10:28:42 volumio volumio[4868]: info: Scanning into folder /data/plugins/ Jul 07 10:28:42 volumio volumio[4868]: info: Scanning category music_service Jul 07 10:28:42 volumio volumio[4868]: info: Plugin folders cleanup completed Jul 07 10:28:42 volumio volumio[4868]: info: ------------------------------------------- Jul 07 10:28:42 volumio volumio[4868]: info: ----- Core plugins startup ---- Jul 07 10:28:42 volumio volumio[4868]: info: ------------------------------------------- Jul 07 10:28:42 volumio volumio[4868]: info: Loading plugins from folder /volumio/app/plugins/ Jul 07 10:28:42 volumio volumio[4868]: info: Adding plugin upnp to MyMusic Plugins Jul 07 10:28:42 volumio volumio[4868]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 07 10:28:42 volumio volumio[4868]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 07 10:28:42 volumio volumio[4868]: info: Loading plugins from folder /data/plugins/ Jul 07 10:28:42 volumio volumio[4868]: info: Loading plugin "system"... Jul 07 10:28:42 volumio volumio[4868]: info: Loading plugin "appearance"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "network"... Jul 07 10:28:43 volumio volumio[4868]: info: Refreshing Cached IP Addresses Jul 07 10:28:43 volumio sudo[4894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 10:28:43 volumio sudo[4894]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:43 volumio sudo[4894]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:43 volumio sudo[4896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 10:28:43 volumio sudo[4896]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:43 volumio sudo[4896]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "services"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "alsa_controller"... Jul 07 10:28:43 volumio sudo[4909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 07 10:28:43 volumio sudo[4909]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:43 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "wizard"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "networkfs"... Jul 07 10:28:43 volumio volumio[4868]: info: Starting Udev Watcher for removable devices Jul 07 10:28:43 volumio volumio[4868]: info: Ignoring mount for partition: boot Jul 07 10:28:43 volumio volumio[4868]: info: Ignoring mount for partition: volumio Jul 07 10:28:43 volumio volumio[4868]: info: Ignoring mount for partition: volumio_data Jul 07 10:28:43 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "volumio_command_line_client"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "upnp"... Jul 07 10:28:43 volumio volumio[4868]: info: [1751880523202] Starting Upmpd Daemon Jul 07 10:28:43 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "my_music"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "mpd"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "upnp_browser"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "alarm-clock"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "airplay_emulation"... Jul 07 10:28:43 volumio volumio[4868]: info: Starting Shairport Sync Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "last_100"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "webradio"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "i2s_dacs"... Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "volumiodiscovery"... Jul 07 10:28:43 volumio volumio[4868]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:43 volumio node[4868]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:43 volumio node[4868]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:43 volumio volumio[4868]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:43 volumio volumio[4868]: *** WARNING *** For more information see Jul 07 10:28:43 volumio volumio[4868]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:43 volumio volumio[4868]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:43 volumio volumio[4868]: *** WARNING *** For more information see Jul 07 10:28:43 volumio node[4868]: *** WARNING *** For more information see Jul 07 10:28:43 volumio node[4868]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 07 10:28:43 volumio node[4868]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 07 10:28:43 volumio node[4868]: *** WARNING *** For more information see Jul 07 10:28:43 volumio volumio[4868]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 07 10:28:43 volumio volumio[4868]: info: Discovery: Started advertising with name: Volumio Jul 07 10:28:43 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 07 10:28:43 volumio volumio[4868]: info: Loading plugin "ytcr"... Jul 07 10:28:44 volumio volumio[4868]: info: Loading plugin "ytmusic"... Jul 07 10:28:44 volumio volumio[4868]: info: Loading plugin "outputs"... Jul 07 10:28:44 volumio volumio[4868]: info: Loading plugin "albumart"... Jul 07 10:28:44 volumio volumio[4868]: info: Plugin example_plugin is not enabled Jul 07 10:28:44 volumio volumio[4868]: info: Loading plugin "inputs"... Jul 07 10:28:44 volumio volumio[4868]: info: Loading plugin "updater_comm"... Jul 07 10:28:44 volumio volumio[4868]: info: Plugin mpdemulation is not enabled Jul 07 10:28:44 volumio volumio[4868]: info: Loading plugin "rest_api"... Jul 07 10:28:44 volumio volumio[4868]: info: Loading plugin "websocket"... Jul 07 10:28:44 volumio volumio[4868]: info: Starting Socket.io Server version 2.3.0 Jul 07 10:28:44 volumio volumio[4868]: info: Loading plugin "radio_paradise"... Jul 07 10:28:44 volumio volumio[4868]: info: Applying required configuration parameters for plugin radio_paradise Jul 07 10:28:44 volumio volumio[4868]: Forking 3 albumart workers Jul 07 10:28:44 volumio volumio[4868]: info: [1751880524811] [RadioParadise] API delay: 5 Jul 07 10:28:44 volumio volumio[4868]: info: Loading i18n strings for locale en Jul 07 10:28:44 volumio volumio[4868]: Updating browse sources language Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::initPlayerControls Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:44 volumio volumio[4868]: Express server listening on port 3000 Jul 07 10:28:44 volumio volumio[4868]: [Metrics] WebUI: 2s 189.01ms Jul 07 10:28:44 volumio volumio[4868]: info: CoreStateMachine::resetVolumioState Jul 07 10:28:44 volumio volumio[4868]: info: CoreStateMachine::getcurrentVolume Jul 07 10:28:44 volumio volumio[4868]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 10:28:44 volumio volumio[4868]: info: Volumio Network Manager: Network status updated: 3 Jul 07 10:28:44 volumio volumio[4868]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 07 10:28:44 volumio volumio[4868]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 07 10:28:44 volumio volumio[4868]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 07 10:28:44 volumio volumio[4868]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.225 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: Starting albumart workers Jul 07 10:28:45 volumio volumio[4868]: info: Reloading queue from file Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: Executing start script for DAC IQaudIO DAC Plus Jul 07 10:28:45 volumio volumio[4868]: Starting albumart workers Jul 07 10:28:45 volumio volumio[4868]: Starting albumart workers Jul 07 10:28:45 volumio volumio[4868]: info: Received Get System Info Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 10:28:45 volumio volumio[4868]: info: Discovery: Getting this device information Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetVisibleSources Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 07 10:28:45 volumio volumio[4868]: info: Received Get System Info Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 10:28:45 volumio volumio[4868]: info: Discovery: Getting this device information Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: Listing playlists Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetQueue Jul 07 10:28:45 volumio volumio[4868]: info: CoreStateMachine::getQueue Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getQueue Jul 07 10:28:45 volumio volumio[4868]: info: VolumeController:: Volume=0 Mute =false Jul 07 10:28:45 volumio volumio[4868]: info: CoreStateMachine::pushState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:45 volumio volumio[4868]: info: CoreStateMachine::updateTrackBlock Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrackBlock Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 10:28:45 volumio volumio[4868]: info: CoreStateMachine::setRepeat null single undefined Jul 07 10:28:45 volumio volumio[4868]: info: CoreStateMachine::pushState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:45 volumio volumio[4868]: info: CoreStateMachine::setRandom null Jul 07 10:28:45 volumio volumio[4868]: info: CoreStateMachine::pushState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:45 volumio volumio[4868]: info: Setting Device type: Raspberry PI Jul 07 10:28:45 volumio volumio[4868]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jul 07 10:28:45 volumio volumio[4868]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Jul 07 10:28:45 volumio volumio[4868]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jul 07 10:28:45 volumio volumio[4868]: error: Cannot execute DAC script: Error: Command failed: /volumio/app/plugins/system_controller/i2s_dacs/scripts/iqamp-unmute.sh Jul 07 10:28:45 volumio volumio[4868]: Oops: Unable to determine board revision from /proc/cpuinfo Jul 07 10:28:45 volumio volumio[4868]: -> No "Hardware" line Jul 07 10:28:45 volumio volumio[4868]: -> You'd best google the error to find out why. Jul 07 10:28:45 volumio volumio[4868]: Oops: Unable to determine board revision from /proc/cpuinfo Jul 07 10:28:45 volumio volumio[4868]: -> No "Hardware" line Jul 07 10:28:45 volumio volumio[4868]: -> You'd best google the error to find out why. Jul 07 10:28:45 volumio volumio[4868]: info: Completed loading Core Plugins Jul 07 10:28:45 volumio volumio[4868]: info: Preparing to generate the ALSA configuration file Jul 07 10:28:45 volumio volumio[4868]: info: Asound.conf file unchanged, so no further update is needed Jul 07 10:28:45 volumio volumio[4868]: info: Output device has changed, restarting MPD Jul 07 10:28:45 volumio sudo[5006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 10:28:45 volumio sudo[5006]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:45 volumio sudo[5006]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:45 volumio volumio[4868]: info: Output device has changed, restarting Shairport Sync Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:45 volumio sudo[5009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 10:28:45 volumio sudo[5009]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:45 volumio systemd[1]: Stopping Music Player Daemon... Jul 07 10:28:45 volumio systemd[1]: mpd.service: Succeeded. Jul 07 10:28:45 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 10:28:45 volumio volumio[4868]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:45 volumio volumio[4868]: info: ___________ START PLUGINS ___________ Jul 07 10:28:45 volumio volumio[4868]: info: ControllerMpd::onStart: Initializing MPD Jul 07 10:28:45 volumio volumio[4868]: info: Creating MPD Configuration file Jul 07 10:28:45 volumio sudo[5016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 10:28:45 volumio sudo[5016]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:45 volumio systemd[1]: Starting Music Player Daemon... Jul 07 10:28:45 volumio sudo[5016]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:45 volumio volumio[4868]: info: [1751880525315] CoreMusicLibrary::Adding element Media Servers Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:45 volumio sudo[5019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 10:28:45 volumio sudo[5019]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:45 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 07 10:28:45 volumio systemd[1]: mpd.service: Succeeded. Jul 07 10:28:45 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 10:28:45 volumio systemd[1]: Starting Music Player Daemon... Jul 07 10:28:45 volumio volumio[4868]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:45 volumio sudo[5022]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 07 10:28:45 volumio sudo[5022]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:45 volumio sudo[5022]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:45 volumio volumio[4868]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:45 volumio volumio[4868]: info: [1751880525363] CoreMusicLibrary::Adding element Last_100 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:45 volumio volumio[4868]: info: [1751880525363] CoreMusicLibrary::Adding element Webradio Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:45 volumio volumio[4868]: info: Initializing BBC Radios Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:45 volumio volumio[4868]: info: [1751880525408] CoreMusicLibrary::Adding element YouTube Music Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:45 volumio volumio[4868]: Cannot find translation for source YouTube Music Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 10:28:45 volumio volumio[4868]: info: [1751880525410] CoreMusicLibrary::Adding element Radio Paradise Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 10:28:45 volumio volumio[4868]: Cannot find translation for source YouTube Music Jul 07 10:28:45 volumio volumio[4868]: Cannot find translation for source Radio Paradise Jul 07 10:28:45 volumio volumio[4868]: info: Volumio Calling Home Jul 07 10:28:45 volumio volumio[4868]: info: Discovery: adding b330b747-79f9-422d-9bc1-3c6dc5c8d543 Jul 07 10:28:45 volumio volumio[4868]: info: Discovery: Found device Volumio Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: VolumeController:: Volume=0 Mute =false Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreStateMachine::pushState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioPushState Jul 07 10:28:45 volumio volumio[4868]: info: Discovery: this is already registered, b330b747-79f9-422d-9bc1-3c6dc5c8d543 Jul 07 10:28:45 volumio volumio[4868]: info: Discovery: Found device Volumio Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio volumio[4868]: info: MPD Permissions set Jul 07 10:28:45 volumio volumio[4868]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 07 10:28:45 volumio volumio[4868]: info: Volumio called home Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:28:45 volumio volumio[4868]: info: Starting Shairport Sync Jul 07 10:28:45 volumio volumio[4868]: info: Starting Shairport Sync Jul 07 10:28:45 volumio sudo[5052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:45 volumio sudo[5052]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:45 volumio volumio[4868]: info: Starting Shairport Sync Jul 07 10:28:45 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 07 10:28:45 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 07 10:28:45 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:45 volumio sudo[5055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:45 volumio sudo[5055]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:45 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:45 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:45 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:45 volumio mpd[5029]: Jul 07 10:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 07 10:28:45 volumio sudo[5058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 10:28:45 volumio systemd[1]: Started Music Player Daemon. Jul 07 10:28:45 volumio sudo[5058]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:45 volumio sudo[5019]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:45 volumio sudo[5052]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:45 volumio sudo[5009]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:45 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 07 10:28:45 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 07 10:28:45 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:45 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 07 10:28:45 volumio sudo[5055]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:45 volumio sudo[5058]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:45 volumio volumio[4868]: info: Shairport-Sync Started Jul 07 10:28:45 volumio volumio[4868]: Error adding Membership: Error: addMembership EINVAL Jul 07 10:28:45 volumio volumio[4868]: info: Shairport-Sync Started Jul 07 10:28:45 volumio volumio[4868]: info: Shairport-Sync Started Jul 07 10:28:45 volumio volumio[4868]: error: MPD error: The expression evaluated to a falsy value: Jul 07 10:28:45 volumio volumio[4868]: assert.ok(self.idling) Jul 07 10:28:45 volumio volumio[4868]: error: The expression evaluated to a falsy value: Jul 07 10:28:45 volumio volumio[4868]: assert.ok(self.idling) Jul 07 10:28:45 volumio volumio[4868]: info: MPD running with PID5029 Jul 07 10:28:45 volumio volumio[4868]: ,establishing connection Jul 07 10:28:45 volumio volumio[4868]: error: updateQueue error: null Jul 07 10:28:45 volumio volumio[4868]: error: updateQueue error: null Jul 07 10:28:45 volumio volumio[4868]: info: [yt-cast-receiver] DIAL server listening on port 8098 Jul 07 10:28:46 volumio volumio[4868]: info: Completed starting Core Plugins Jul 07 10:28:46 volumio volumio[4868]: info: ------------------------------------------- Jul 07 10:28:46 volumio volumio[4868]: info: ----- MyVolumio plugins startup ---- Jul 07 10:28:46 volumio volumio[4868]: info: ------------------------------------------- Jul 07 10:28:46 volumio volumio[4868]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 07 10:28:46 volumio ntpd[970]: 46.17.88.212 local addr 192.168.1.118 -> Jul 07 10:28:46 volumio sudo[4909]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:47 volumio volumio-remote-updater[694]: [2025-07-07 10:28:47] [connect] Successful connection Jul 07 10:28:47 volumio volumio-remote-updater[694]: [2025-07-07 10:28:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751880527 101 Jul 07 10:28:47 volumio volumio[4868]: 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: 6 Jul 07 10:28:47 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:48 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:48 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:48 volumio volumio[4868]: info: Listing playlists Jul 07 10:28:48 volumio volumio[4868]: info: Listing playlists Jul 07 10:28:50 volumio volumio[4868]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 07 10:28:51 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:53 volumio sudo[5086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 10:28:53 volumio sudo[5086]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:53 volumio sudo[5086]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:53 volumio sudo[5089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 10:28:53 volumio sudo[5089]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:53 volumio sudo[5089]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:53 volumio sudo[5092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 07 10:28:53 volumio sudo[5092]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:53 volumio sudo[5092]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:53 volumio volumio[4868]: info: Upmpdcli Daemon Started Jul 07 10:28:53 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:53 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:54 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:54 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 07 10:28:54 volumio volumio[4868]: info: Adding plugin bluetooth to MyMusic Plugins Jul 07 10:28:54 volumio volumio[4868]: info: Adding plugin multiroom to MyMusic Plugins Jul 07 10:28:54 volumio volumio[4868]: info: Adding plugin metavolumio to MyMusic Plugins Jul 07 10:28:54 volumio volumio[4868]: info: Adding plugin cd_controller to MyMusic Plugins Jul 07 10:28:54 volumio volumio[4868]: info: Adding plugin qobuzconnect to MyMusic Plugins Jul 07 10:28:54 volumio volumio[4868]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 07 10:28:54 volumio volumio[4868]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 07 10:28:54 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:54 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:54 volumio volumio[4868]: info: Starting MyVolumio Remote Streaming Endpoints Jul 07 10:28:54 volumio volumio[4868]: info: MyVolumio login type: Token Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 07 10:28:54 volumio volumio[4868]: info: Starting Streaming Service Transparent Proxy Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 07 10:28:54 volumio volumio[4868]: info: Streaming services startup Jul 07 10:28:54 volumio volumio[4868]: info: Starting Streaming Daemon Jul 07 10:28:54 volumio sudo[5112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 07 10:28:54 volumio sudo[5112]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:54 volumio sudo[5112]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:54 volumio volumio[4868]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 07 10:28:54 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:54 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 10:28:54 volumio volumio[4868]: error: Cannot start Volumio Streaming Daemon Jul 07 10:28:54 volumio volumio[4868]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 07 10:28:54 volumio volumio[4868]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 07 10:28:55 volumio volumio[4868]: STREAMING PROXY: Starting server on port 3245 Jul 07 10:28:55 volumio volumio[4868]: Node JS runtime: 14 Jul 07 10:28:55 volumio volumio[4868]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 07 10:28:55 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:28:55 volumio volumio[4868]: info: MyVolumio token set successfully Jul 07 10:28:55 volumio volumio[4868]: info: MYVOLUMIO: Adding device Jul 07 10:28:55 volumio volumio[4868]: info: MYVOLUMIO: Evaluating Server Jul 07 10:28:55 volumio volumio[4868]: info: MyVolumio status changed Jul 07 10:28:55 volumio volumio[4868]: info: Streaming services startup Jul 07 10:28:55 volumio volumio[4868]: info: Starting Streaming Daemon Jul 07 10:28:55 volumio volumio[4868]: info: Removing browser output: myVolumio user plan is not superstar Jul 07 10:28:55 volumio volumio[4868]: info: Removing audio output: Jul 07 10:28:55 volumio volumio[4868]: info: Stoppping Tunnel 1 Jul 07 10:28:55 volumio sudo[5137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 07 10:28:55 volumio sudo[5137]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:55 volumio sudo[5137]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:55 volumio sudo[5140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 07 10:28:55 volumio sudo[5140]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:28:55 volumio volumio[4868]: error: Cannot start Volumio Streaming Daemon Jul 07 10:28:55 volumio volumio[4868]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 07 10:28:55 volumio volumio[4868]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 07 10:28:55 volumio sudo[5140]: pam_unix(sudo:session): session closed for user root Jul 07 10:28:55 volumio volumio[4868]: info: Remote SSH Stopped Jul 07 10:28:56 volumio volumio[4868]: info: Setting Geolocation for MyVolumio to eu3 Jul 07 10:28:56 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:56 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:56 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:56 volumio volumio[4868]: info: Successfully Added MyVolumio device Jul 07 10:28:57 volumio volumio[4868]: info: Updating MyVolumio device info Jul 07 10:28:57 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:57 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:57 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:28:57 volumio volumio[4868]: info: Successfully Updated MyVolumio device Jul 07 10:28:58 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:28:58 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:28:59 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:29:03 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:29:07 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:29:08 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:29:08 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:29:08 volumio volumio[4868]: info: Listing playlists Jul 07 10:29:08 volumio volumio[4868]: info: Listing playlists Jul 07 10:29:09 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 07 10:29:09 volumio volumio[4868]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jul 07 10:29:09 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:29:09 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:29:11 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::volumioGetBrowseSources Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:29:14 volumio volumio[4868]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 07 10:29:14 volumio volumio[4868]: info: Completed starting MyVolumio Plugin Jul 07 10:29:14 volumio volumio[4868]: [Metrics] CommandRouter: 32s 101.07ms Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::volumiosetStartupVolume Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::Close All Modals sent Jul 07 10:29:14 volumio volumio[4868]: info: CoreCommandRouter::Close All Modals sent Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 07 10:29:15 volumio volumio-remote-updater[694]: No test mode Jul 07 10:29:15 volumio volumio-remote-updater[694]: No alpha test mode Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:29:15 volumio volumio[4868]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 10:29:15 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 07 10:29:16 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Jul 07 10:29:16 volumio volumio[4868]: info: Adding a new share Jul 07 10:29:16 volumio volumio[4868]: info: No correspondence found in configuration for share plex on IP 192.168.1.6 Jul 07 10:29:16 volumio volumio[4868]: info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.1.6 -N Jul 07 10:29:16 volumio volumio[4868]: info: Error browsing device plex for shares: Command failed: smbclient --debuglevel=4 -L 192.168.1.6 -N Jul 07 10:29:16 volumio volumio[4868]: lp_load_ex: refreshing parameters Jul 07 10:29:16 volumio volumio[4868]: Initialising global parameters Jul 07 10:29:16 volumio volumio[4868]: Processing section "[global]" Jul 07 10:29:16 volumio volumio[4868]: doing parameter netbios name = Volumio Jul 07 10:29:16 volumio volumio[4868]: doing parameter server string = Volumio Audiophile Music Player Jul 07 10:29:16 volumio volumio[4868]: doing parameter workgroup = WORKGROUP Jul 07 10:29:16 volumio volumio[4868]: doing parameter security = user Jul 07 10:29:16 volumio volumio[4868]: doing parameter map to guest = Bad User Jul 07 10:29:16 volumio volumio[4868]: doing parameter encrypt passwords = yes Jul 07 10:29:16 volumio volumio[4868]: doing parameter wins support = yes Jul 07 10:29:16 volumio volumio[4868]: doing parameter local master = no Jul 07 10:29:16 volumio volumio[4868]: doing parameter preferred master = no Jul 07 10:29:16 volumio volumio[4868]: doing parameter os level = 30 Jul 07 10:29:16 volumio volumio[4868]: doing parameter fruit:model = AirPort Jul 07 10:29:16 volumio volumio[4868]: pm_process() returned Yes Jul 07 10:29:16 volumio volumio[4868]: directory_create_or_exist_strict: invalid ownership on directory /var/run/samba/msg.lock Jul 07 10:29:16 volumio volumio[4868]: cmdline_messaging_context: Unable to initialize messaging context. Jul 07 10:29:16 volumio volumio[4868]: Unable to initialize messaging context Jul 07 10:29:16 volumio volumio[4868]: lp_load_ex: refreshing parameters Jul 07 10:29:16 volumio volumio[4868]: Initialising global parameters Jul 07 10:29:16 volumio volumio[4868]: Processing section "[global]" Jul 07 10:29:16 volumio volumio[4868]: doing parameter netbios name = Volumio Jul 07 10:29:16 volumio volumio[4868]: doing parameter server string = Volumio Audiophile Music Player Jul 07 10:29:16 volumio volumio[4868]: doing parameter workgroup = WORKGROUP Jul 07 10:29:16 volumio volumio[4868]: doing parameter security = user Jul 07 10:29:16 volumio volumio[4868]: doing parameter map to guest = Bad User Jul 07 10:29:16 volumio volumio[4868]: doing parameter encrypt passwords = yes Jul 07 10:29:16 volumio volumio[4868]: doing parameter wins support = yes Jul 07 10:29:16 volumio volumio[4868]: doing parameter local master = no Jul 07 10:29:16 volumio volumio[4868]: doing parameter preferred master = no Jul 07 10:29:16 volumio volumio[4868]: doing parameter os level = 30 Jul 07 10:29:16 volumio volumio[4868]: doing parameter fruit:model = AirPort Jul 07 10:29:16 volumio volumio[4868]: pm_process() returned Yes Jul 07 10:29:16 volumio volumio[4868]: added interface eth0 ip=192.168.1.118 bcast=192.168.1.255 netmask=255.255.255.0 Jul 07 10:29:16 volumio volumio[4868]: added interface wlan0 ip=192.168.1.241 bcast=192.168.1.255 netmask=255.255.255.0 Jul 07 10:29:16 volumio volumio[4868]: Client started (version 4.9.5-Debian). Jul 07 10:29:16 volumio volumio[4868]: Connecting to 192.168.1.6 at port 445 Jul 07 10:29:16 volumio volumio[4868]: Connecting to 192.168.1.6 at port 139 Jul 07 10:29:16 volumio volumio[4868]: do_connect: Connection to 192.168.1.6 failed (Error NT_STATUS_HOST_UNREACHABLE) Jul 07 10:29:16 volumio volumio[4868]: info: Detected device plex with version null Jul 07 10:29:16 volumio sudo[5205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.6/music /mnt/NAS/plex Jul 07 10:29:16 volumio sudo[5205]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 10:29:16 volumio sudo[5205]: pam_unix(sudo:session): session closed for user root Jul 07 10:29:16 volumio kernel: Key type cifs.spnego registered Jul 07 10:29:16 volumio kernel: Key type cifs.idmap registered Jul 07 10:29:16 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. Jul 07 10:29:16 volumio kernel: CIFS: Attempting to mount //192.168.1.6/music Jul 07 10:29:16 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jul 07 10:29:16 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jul 07 10:29:16 volumio volumio[4868]: info: Error mounting plex on IP 192.168.1.6 : exec error Error: Command failed: /usr/bin/sudo /bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft '//192.168.1.6/music' '/mnt/NAS/plex' Jul 07 10:29:16 volumio volumio[4868]: Unable to find suitable address. Jul 07 10:29:17 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 07 10:29:18 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:29:18 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:29:19 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:29:21 volumio volumio[4868]: info: BOOT COMPLETED Jul 07 10:29:23 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:29:25 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 07 10:29:25 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 07 10:29:27 volumio volumio[4868]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 10:29:28 volumio volumio[4868]: info: CoreCommandRouter::volumioGetState Jul 07 10:29:28 volumio volumio[4868]: info: CorePlayQueue::getTrack 0 Jul 07 10:29:28 volumio volumio[4868]: info: Listing playlists Jul 07 10:29:28 volumio volumio[4868]: info: Listing playlists Jul 07 10:29:29 volumio ntpd[970]: 178.79.155.116 local addr 192.168.1.118 -> Jul 07 10:29:30 volumio volumio[4868]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 10:29:30 volumio volumio[4868]: Error: dns service error: unknown Jul 07 10:29:30 volumio volumio[4868]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jul 07 10:29:30 volumio volumio[4868]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jul 07 10:29:30 volumio volumio[4868]: errorCode: -65537 Jul 07 10:29:30 volumio volumio[4868]: } Jul 07 10:29:30 volumio volumio[4868]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 10:29:30 volumio sudo[5304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-07 10:28 Jul 07 10:29:30 volumio sudo[5304]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"