-- Logs begin at Mon 2025-04-21 07:06:22 EDT, end at Mon 2025-04-21 10:44:31 EDT. -- Apr 21 10:43:14 volumio-mac volumio-remote-updater[912]: [2025-04-21 10:43:14] [connect] Successful connection Apr 21 10:43:16 volumio-mac go-librespot[28298]: time="2025-04-21T10:43:16-04:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: i/o timeout" Apr 21 10:43:16 volumio-mac systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 21 10:43:16 volumio-mac systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 21 10:43:19 volumio-mac systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 21 10:43:19 volumio-mac systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Apr 21 10:43:19 volumio-mac systemd[1]: Stopped go-librespot Daemon. Apr 21 10:43:19 volumio-mac systemd[1]: Started go-librespot Daemon. Apr 21 10:43:19 volumio-mac go-librespot[28454]: go-librespot daemon starting... Apr 21 10:43:19 volumio-mac go-librespot[28454]: time="2025-04-21T10:43:19-04:00" level=info msg="running go-librespot 0.2.0" Apr 21 10:43:19 volumio-mac go-librespot[28454]: time="2025-04-21T10:43:19-04:00" level=debug msg="app state loaded" Apr 21 10:43:19 volumio-mac go-librespot[28454]: time="2025-04-21T10:43:19-04:00" level=debug msg="stored credentials not found" Apr 21 10:43:19 volumio-mac go-librespot[28454]: time="2025-04-21T10:43:19-04:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 21 10:43:29 volumio-mac volumio-remote-updater[912]: [2025-04-21 10:43:29] [connect] Successful connection Apr 21 10:43:31 volumio-mac volumio-time-update[914]: volumio-time-update-util: Date not found in response Apr 21 10:43:31 volumio-mac volumio-time-update[914]: volumio-time-update-util: Retrying in 5 seconds... Apr 21 10:43:33 volumio-mac ntpd[21122]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 21 10:43:36 volumio-mac volumio-time-update[914]: volumio-time-update-util: Fetching time from Volumio... Apr 21 10:43:44 volumio-mac volumio-remote-updater[912]: [2025-04-21 10:43:44] [connect] Successful connection Apr 21 10:43:49 volumio-mac go-librespot[28454]: time="2025-04-21T10:43:49-04:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: i/o timeout" Apr 21 10:43:49 volumio-mac systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 21 10:43:49 volumio-mac systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 21 10:43:52 volumio-mac systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 21 10:43:52 volumio-mac systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Apr 21 10:43:52 volumio-mac systemd[1]: Stopped go-librespot Daemon. Apr 21 10:43:52 volumio-mac systemd[1]: Started go-librespot Daemon. Apr 21 10:43:52 volumio-mac go-librespot[28556]: go-librespot daemon starting... Apr 21 10:43:52 volumio-mac go-librespot[28556]: time="2025-04-21T10:43:52-04:00" level=info msg="running go-librespot 0.2.0" Apr 21 10:43:52 volumio-mac go-librespot[28556]: time="2025-04-21T10:43:52-04:00" level=debug msg="app state loaded" Apr 21 10:43:52 volumio-mac go-librespot[28556]: time="2025-04-21T10:43:52-04:00" level=debug msg="stored credentials not found" Apr 21 10:43:52 volumio-mac go-librespot[28556]: time="2025-04-21T10:43:52-04:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 21 10:43:54 volumio-mac systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 21 10:43:54 volumio-mac systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 21 10:43:54 volumio-mac systemd[1]: Started dynamicswap service. Apr 21 10:43:54 volumio-mac systemd[1]: dynamicswap.service: Succeeded. Apr 21 10:43:54 volumio-mac systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 21 10:43:54 volumio-mac systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1067. Apr 21 10:43:54 volumio-mac systemd[1]: Started dynamicswap service. Apr 21 10:43:54 volumio-mac systemd[1]: Stopped Volumio Backend Module. Apr 21 10:43:54 volumio-mac systemd[1]: Started Volumio Backend Module. Apr 21 10:43:54 volumio-mac systemd[1]: dynamicswap.service: Succeeded. Apr 21 10:43:55 volumio-mac volumio[28594]: info: ------------------------------------------- Apr 21 10:43:55 volumio-mac volumio[28594]: info: ----- Volumio3 ---- Apr 21 10:43:55 volumio-mac volumio[28594]: info: ------------------------------------------- Apr 21 10:43:55 volumio-mac volumio[28594]: info: ----- System startup ---- Apr 21 10:43:55 volumio-mac volumio[28594]: info: ------------------------------------------- Apr 21 10:43:55 volumio-mac volumio[28594]: info: MYVOLUMIO Environment detected Apr 21 10:43:55 volumio-mac volumio[28594]: info: Plugin folders cleanup Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning into folder /volumio/app/plugins/ Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category audio_interface Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category miscellanea Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category music_service Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category plugins.json Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category system_controller Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category user_interface Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning into folder /data/plugins/ Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category music_service Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category system_controller Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category system_hardware Apr 21 10:43:55 volumio-mac volumio[28594]: info: Scanning category user_interface Apr 21 10:43:55 volumio-mac volumio[28594]: info: Plugin folders cleanup completed Apr 21 10:43:55 volumio-mac volumio[28594]: info: ------------------------------------------- Apr 21 10:43:55 volumio-mac volumio[28594]: info: ----- Core plugins startup ---- Apr 21 10:43:55 volumio-mac volumio[28594]: info: ------------------------------------------- Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugins from folder /volumio/app/plugins/ Apr 21 10:43:55 volumio-mac volumio[28594]: info: Adding plugin upnp to MyMusic Plugins Apr 21 10:43:55 volumio-mac volumio[28594]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 21 10:43:55 volumio-mac volumio[28594]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugins from folder /data/plugins/ Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "system"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "appearance"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "network"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Refreshing Cached IP Addresses Apr 21 10:43:55 volumio-mac sudo[28664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 10:43:55 volumio-mac sudo[28664]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:55 volumio-mac sudo[28664]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:55 volumio-mac sudo[28666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 10:43:55 volumio-mac sudo[28666]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:55 volumio-mac sudo[28666]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "services"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "alsa_controller"... Apr 21 10:43:55 volumio-mac sudo[28679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 21 10:43:55 volumio-mac sudo[28679]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:55 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "wizard"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "networkfs"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Cannot mount NAS happyshowNAS at system boot, trial number 1 ,retrying in 5 seconds Apr 21 10:43:55 volumio-mac volumio[28594]: info: Starting Udev Watcher for removable devices Apr 21 10:43:55 volumio-mac volumio[28594]: info: Ignoring mount for partition: boot Apr 21 10:43:55 volumio-mac volumio[28594]: info: Ignoring mount for partition: volumio Apr 21 10:43:55 volumio-mac volumio[28594]: info: Ignoring mount for partition: volumio_data Apr 21 10:43:55 volumio-mac volumio[28594]: info: Ignoring mount for partition: volumioHD Apr 21 10:43:55 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "volumio_command_line_client"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "upnp"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: [1745246635565] Starting Upmpd Daemon Apr 21 10:43:55 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "my_music"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "mpd"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Plugin upnp_browser is not enabled Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "alarm-clock"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "airplay_emulation"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Starting Shairport Sync Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "last_100"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "webradio"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "i2s_dacs"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: I2S DAC not set, start Auto-detection Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "volumiodiscovery"... Apr 21 10:43:55 volumio-mac volumio[28594]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 10:43:55 volumio-mac volumio[28594]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 10:43:55 volumio-mac volumio[28594]: *** WARNING *** For more information see Apr 21 10:43:55 volumio-mac node[28594]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 10:43:55 volumio-mac volumio[28594]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 10:43:55 volumio-mac volumio[28594]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 10:43:55 volumio-mac volumio[28594]: *** WARNING *** For more information see Apr 21 10:43:55 volumio-mac node[28594]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 10:43:55 volumio-mac node[28594]: *** WARNING *** For more information see Apr 21 10:43:55 volumio-mac node[28594]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 10:43:55 volumio-mac node[28594]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 10:43:55 volumio-mac node[28594]: *** WARNING *** For more information see Apr 21 10:43:55 volumio-mac volumio[28594]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 21 10:43:55 volumio-mac volumio[28594]: info: Discovery: Started advertising with name: Volumio-Mac Apr 21 10:43:55 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "spop"... Apr 21 10:43:55 volumio-mac volumio[28594]: info: Loading plugin "ytcr"... Apr 21 10:43:56 volumio-mac volumio[28594]: info: Loading plugin "ytmusic"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "outputs"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "albumart"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Plugin example_plugin is not enabled Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "inputs"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "updater_comm"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Plugin mpdemulation is not enabled Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "rest_api"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "websocket"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Starting Socket.io Server version 2.3.0 Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "80s80s"... Apr 21 10:43:57 volumio-mac volumio[28594]: Forking 7 albumart workers Apr 21 10:43:57 volumio-mac volumio[28594]: info: Applying required configuration parameters for plugin 80s80s Apr 21 10:43:57 volumio-mac volumio[28594]: info: [1745246637345] [80s80s] API delay: 30 Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "radio_paradise"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Applying required configuration parameters for plugin radio_paradise Apr 21 10:43:57 volumio-mac volumio[28594]: info: [1745246637417] [RadioParadise] API delay: 5 Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "swarmstation"... Apr 21 10:43:57 volumio-mac volumio[28594]: Starting albumart workers Apr 21 10:43:57 volumio-mac volumio[28594]: Starting albumart workers Apr 21 10:43:57 volumio-mac volumio[28594]: Starting albumart workers Apr 21 10:43:57 volumio-mac volumio[28594]: Starting albumart workers Apr 21 10:43:57 volumio-mac volumio[28594]: Starting albumart workers Apr 21 10:43:57 volumio-mac volumio[28594]: info: Applying required configuration parameters for plugin swarmstation Apr 21 10:43:57 volumio-mac volumio[28594]: info: [1745246637493] [Swarmstation] API delay: 5 Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "backup_restore"... Apr 21 10:43:57 volumio-mac volumio[28594]: Starting albumart workers Apr 21 10:43:57 volumio-mac volumio[28594]: Starting albumart workers Apr 21 10:43:57 volumio-mac volumio[28594]: info: Applying required configuration parameters for plugin backup_restore Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "music_services_shield"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Applying required configuration parameters for plugin music_services_shield Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "Systeminfo"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading plugin "lastfm"... Apr 21 10:43:57 volumio-mac volumio[28594]: info: Loading i18n strings for locale en Apr 21 10:43:57 volumio-mac volumio[28594]: Updating browse sources language Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::initPlayerControls Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: Express server listening on port 3000 Apr 21 10:43:57 volumio-mac volumio[28594]: [Metrics] WebUI: 2s 827.02ms Apr 21 10:43:57 volumio-mac volumio[28594]: info: Setting Device type: x86 Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreStateMachine::resetVolumioState Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreStateMachine::getcurrentVolume Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:43:57 volumio-mac volumio[28594]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 21 10:43:57 volumio-mac volumio[28594]: info: Completed loading Core Plugins Apr 21 10:43:57 volumio-mac volumio[28594]: info: Preparing to generate the ALSA configuration file Apr 21 10:43:57 volumio-mac volumio[28594]: info: Volumio Network Manager: Network status updated: 3 Apr 21 10:43:57 volumio-mac volumio[28594]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 21 10:43:57 volumio-mac volumio[28594]: verbose: New Socket.io Connection to 192.168.50.21:3000 from 192.168.50.71 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Apr 21 10:43:57 volumio-mac volumio[28594]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:43:57 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:43:57 volumio-mac volumio[28594]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Apr 21 10:43:57 volumio-mac volumio[28594]: info: VolumeController:: Volume=0 Mute =false Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreStateMachine::pushState Apr 21 10:43:57 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioPushState Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreStateMachine::updateTrackBlock Apr 21 10:43:57 volumio-mac volumio[28594]: info: CorePlayQueue::getTrackBlock Apr 21 10:43:57 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 10:43:57 volumio-mac volumio[28594]: info: Reloading queue from file Apr 21 10:43:57 volumio-mac volumio[28594]: info: Asound.conf file unchanged, so no further update is needed Apr 21 10:43:57 volumio-mac volumio[28594]: info: Output device has changed, restarting MPD Apr 21 10:43:58 volumio-mac sudo[28818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 10:43:58 volumio-mac sudo[28818]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac sudo[28818]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac volumio[28594]: info: Output device has changed, restarting Shairport Sync Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:43:58 volumio-mac sudo[28822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 10:43:58 volumio-mac sudo[28822]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac systemd[1]: musicservicesshield.service: Succeeded. Apr 21 10:43:58 volumio-mac systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 21 10:43:58 volumio-mac systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 21 10:43:58 volumio-mac systemd[1]: Stopping Music Player Daemon... Apr 21 10:43:58 volumio-mac volumio[28594]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 10:43:58 volumio-mac volumio[28594]: info: ___________ START PLUGINS ___________ Apr 21 10:43:58 volumio-mac volumio[28594]: info: ControllerMpd::onStart: Initializing MPD Apr 21 10:43:58 volumio-mac volumio[28594]: info: Creating MPD Configuration file Apr 21 10:43:58 volumio-mac systemd[1]: mpd.service: Succeeded. Apr 21 10:43:58 volumio-mac systemd[1]: Stopped Music Player Daemon. Apr 21 10:43:58 volumio-mac sudo[28828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 10:43:58 volumio-mac sudo[28828]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:43:58 volumio-mac sudo[28828]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac systemd[1]: Starting Music Player Daemon... Apr 21 10:43:58 volumio-mac sudo[28832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 10:43:58 volumio-mac sudo[28832]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac volumio[28594]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:43:58 volumio-mac systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 21 10:43:58 volumio-mac systemd[1]: mpd.service: Succeeded. Apr 21 10:43:58 volumio-mac systemd[1]: Stopped Music Player Daemon. Apr 21 10:43:58 volumio-mac systemd[1]: Starting Music Player Daemon... Apr 21 10:43:58 volumio-mac volumio[28594]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:43:58 volumio-mac volumio[28594]: info: [1745246638084] CoreMusicLibrary::Adding element Last_100 Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:43:58 volumio-mac volumio[28594]: info: [1745246638085] CoreMusicLibrary::Adding element Webradio Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 10:43:58 volumio-mac volumio[28594]: info: Initializing BBC Radios Apr 21 10:43:58 volumio-mac sudo[28837]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 21 10:43:58 volumio-mac sudo[28837]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac sudo[28837]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: Creating Spotify config file Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:43:58 volumio-mac volumio[28594]: info: [1745246638148] CoreMusicLibrary::Adding element YouTube Music Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source YouTube Music Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:43:58 volumio-mac volumio[28594]: info: [1745246638150] CoreMusicLibrary::Adding element 80s80s Radio Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source YouTube Music Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source 80s80s Radio Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:43:58 volumio-mac volumio[28594]: info: [1745246638151] CoreMusicLibrary::Adding element Radio Paradise Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source YouTube Music Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source 80s80s Radio Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source Radio Paradise Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:43:58 volumio-mac volumio[28594]: info: [1745246638152] CoreMusicLibrary::Adding element SWARM Station Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source YouTube Music Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source 80s80s Radio Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source Radio Paradise Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source SWARM Station Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 10:43:58 volumio-mac volumio[28594]: info: [1745246638232] CoreMusicLibrary::Adding element LastFM Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source YouTube Music Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source 80s80s Radio Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source Radio Paradise Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source SWARM Station Apr 21 10:43:58 volumio-mac volumio[28594]: Cannot find translation for source LastFM Apr 21 10:43:58 volumio-mac volumio[28594]: info: [LastFM] scrobbler initiated! Apr 21 10:43:58 volumio-mac volumio[28594]: info: [LastFM] extended logging: false Apr 21 10:43:58 volumio-mac volumio[28594]: info: [LastFM] try scrobble stream/radio plays: false Apr 21 10:43:58 volumio-mac volumio[28594]: info: [LastFM] Left init routine Apr 21 10:43:58 volumio-mac volumio[28594]: info: [LastFM] Socket already connected: true Apr 21 10:43:58 volumio-mac volumio[28594]: info: Volumio Calling Home Apr 21 10:43:58 volumio-mac sudo[28879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Apr 21 10:43:58 volumio-mac sudo[28879]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreStateMachine::setRepeat null single undefined Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreStateMachine::pushState Apr 21 10:43:58 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioPushState Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreStateMachine::setRandom false Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreStateMachine::pushState Apr 21 10:43:58 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioPushState Apr 21 10:43:58 volumio-mac volumio[28594]: info: Listing playlists Apr 21 10:43:58 volumio-mac volumio[28594]: info: Listing playlists Apr 21 10:43:58 volumio-mac volumio[28594]: info: MPD Permissions set Apr 21 10:43:58 volumio-mac volumio[28594]: info: MPD Permissions set Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 21 10:43:58 volumio-mac volumio[28594]: info: VolumeController:: Volume=0 Mute =false Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:43:58 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreStateMachine::pushState Apr 21 10:43:58 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioPushState Apr 21 10:43:58 volumio-mac volumio[28594]: info: Spotify config file written Apr 21 10:43:58 volumio-mac sudo[28898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 21 10:43:58 volumio-mac sudo[28898]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac systemd[1]: Stopping go-librespot Daemon... Apr 21 10:43:58 volumio-mac systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Apr 21 10:43:58 volumio-mac systemd[1]: go-librespot-daemon.service: Succeeded. Apr 21 10:43:58 volumio-mac systemd[1]: Stopped go-librespot Daemon. Apr 21 10:43:58 volumio-mac systemd[1]: Started go-librespot Daemon. Apr 21 10:43:58 volumio-mac mpd[28844]: Apr 21 10:43 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 21 10:43:58 volumio-mac go-librespot[28904]: go-librespot daemon starting... Apr 21 10:43:58 volumio-mac sudo[28898]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac go-librespot[28904]: time="2025-04-21T10:43:58-04:00" level=info msg="running go-librespot 0.2.0" Apr 21 10:43:58 volumio-mac go-librespot[28904]: time="2025-04-21T10:43:58-04:00" level=debug msg="app state loaded" Apr 21 10:43:58 volumio-mac go-librespot[28904]: time="2025-04-21T10:43:58-04:00" level=debug msg="stored credentials not found" Apr 21 10:43:58 volumio-mac go-librespot[28904]: time="2025-04-21T10:43:58-04:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 21 10:43:58 volumio-mac sudo[28879]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 10:43:58 volumio-mac volumio[28594]: info: No need to fix Spotify hosts Apr 21 10:43:58 volumio-mac volumio[28594]: info: Starting Shairport Sync Apr 21 10:43:58 volumio-mac volumio[28594]: info: Starting Shairport Sync Apr 21 10:43:58 volumio-mac sudo[28925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh Apr 21 10:43:58 volumio-mac sudo[28925]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac sudo[28928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 10:43:58 volumio-mac sudo[28928]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 21 10:43:58 volumio-mac volumio[28594]: info: Starting Shairport Sync Apr 21 10:43:58 volumio-mac systemd[1]: shairport-sync.service: Succeeded. Apr 21 10:43:58 volumio-mac systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 21 10:43:58 volumio-mac sudo[28935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 10:43:58 volumio-mac sudo[28935]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac sudo[28940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 10:43:58 volumio-mac sudo[28940]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:43:58 volumio-mac systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 10:43:58 volumio-mac sudo[28928]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac volumio[28594]: info: Shairport-Sync Started Apr 21 10:43:58 volumio-mac volumio[28594]: Error adding Membership: Error: addMembership EINVAL Apr 21 10:43:58 volumio-mac systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 21 10:43:58 volumio-mac systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 21 10:43:58 volumio-mac systemd[1]: shairport-sync.service: Succeeded. Apr 21 10:43:58 volumio-mac systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 21 10:43:58 volumio-mac systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 10:43:58 volumio-mac sudo[28940]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac sudo[28935]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac volumio[28594]: info: Shairport-Sync Started Apr 21 10:43:58 volumio-mac volumio[28594]: info: Shairport-Sync Started Apr 21 10:43:58 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:43:58 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:43:58 volumio-mac systemd[1]: Started Music Player Daemon. Apr 21 10:43:58 volumio-mac sudo[28832]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac sudo[28822]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac volumio[28594]: error: MPD error: The expression evaluated to a falsy value: Apr 21 10:43:58 volumio-mac volumio[28594]: assert.ok(self.idling) Apr 21 10:43:58 volumio-mac volumio[28594]: error: The expression evaluated to a falsy value: Apr 21 10:43:58 volumio-mac volumio[28594]: assert.ok(self.idling) Apr 21 10:43:58 volumio-mac volumio[28594]: error: updateQueue error: null Apr 21 10:43:58 volumio-mac volumio[28594]: info: MPD running with PID28844 Apr 21 10:43:58 volumio-mac volumio[28594]: ,establishing connection Apr 21 10:43:58 volumio-mac volumio[28594]: error: updateQueue error: null Apr 21 10:43:58 volumio-mac systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 21 10:43:58 volumio-mac volumio[28950]: cset: --> shielding system active with Apr 21 10:43:58 volumio-mac volumio[28950]: cset: "system" cpuset of CPUSPEC(1-7) with 266 tasks running Apr 21 10:43:58 volumio-mac volumio[28950]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Apr 21 10:43:58 volumio-mac systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 21 10:43:58 volumio-mac systemd[1]: Reloading. Apr 21 10:43:58 volumio-mac systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 21 10:43:58 volumio-mac sudo[28925]: pam_unix(sudo:session): session closed for user root Apr 21 10:43:58 volumio-mac volumio[28594]: info: succeeded Apr 21 10:43:59 volumio-mac volumio-remote-updater[912]: [2025-04-21 10:43:59] [connect] Successful connection Apr 21 10:43:59 volumio-mac volumio-remote-updater[912]: [2025-04-21 10:43:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745246639 101 Apr 21 10:43:59 volumio-mac volumio[28594]: 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: 4 Apr 21 10:44:00 volumio-mac sudo[28679]: pam_unix(sudo:session): session closed for user root Apr 21 10:44:00 volumio-mac volumio[28594]: info: Cannot mount NAS happyshowNAS at system boot, trial number 2 ,retrying in 5 seconds Apr 21 10:44:01 volumio-mac volumio[28594]: info: go-librespot daemon successfully initialized Apr 21 10:44:02 volumio-mac volumio[28594]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetVisibleSources Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:44:02 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:44:02 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 21 10:44:02 volumio-mac volumio[28594]: info: Received Get System Info Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 21 10:44:02 volumio-mac volumio[28594]: info: Discovery: Getting this device information Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:44:02 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 21 10:44:02 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:44:02 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:44:02 volumio-mac volumio[28594]: info: Listing playlists Apr 21 10:44:03 volumio-mac volumio[28594]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 21 10:44:04 volumio-mac volumio[28594]: info: Initializing connection to go-librespot Websocket Apr 21 10:44:05 volumio-mac volumio[28594]: info: Cannot mount NAS happyshowNAS at system boot, trial number 3 ,retrying in 5 seconds Apr 21 10:44:05 volumio-mac sudo[29003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 10:44:05 volumio-mac sudo[29003]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:44:05 volumio-mac sudo[29003]: pam_unix(sudo:session): session closed for user root Apr 21 10:44:05 volumio-mac sudo[29006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 10:44:05 volumio-mac sudo[29006]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:44:05 volumio-mac sudo[29006]: pam_unix(sudo:session): session closed for user root Apr 21 10:44:06 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:44:06 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:44:07 volumio-mac sudo[29009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 21 10:44:07 volumio-mac sudo[29009]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 10:44:07 volumio-mac sudo[29009]: pam_unix(sudo:session): session closed for user root Apr 21 10:44:07 volumio-mac volumio[28594]: Cannot compose Albumart path Apr 21 10:44:08 volumio-mac volumio[28594]: info: Upmpdcli Daemon Started Apr 21 10:44:10 volumio-mac volumio[28594]: info: Cannot mount NAS happyshowNAS at system boot, trial number 4 ,retrying in 5 seconds Apr 21 10:44:15 volumio-mac volumio[28594]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 21 10:44:15 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:44:15 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:44:15 volumio-mac volumio[28594]: info: Listing playlists Apr 21 10:44:15 volumio-mac volumio[28594]: info: Listing playlists Apr 21 10:44:25 volumio-mac volumio[28594]: info: CoreCommandRouter::volumioGetState Apr 21 10:44:25 volumio-mac volumio[28594]: info: CorePlayQueue::getTrack 0 Apr 21 10:44:28 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 10:44:28 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 10:44:28 volumio-mac volumio[28594]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 21 10:44:28 volumio-mac volumio[28594]: error: Plugin music_service ytcr failed to complete 'onStart' in a timely fashion Apr 21 10:44:28 volumio-mac volumio[28594]: info: ------------------------------------------- Apr 21 10:44:28 volumio-mac volumio[28594]: info: ----- MyVolumio plugins startup ---- Apr 21 10:44:28 volumio-mac volumio[28594]: info: ------------------------------------------- Apr 21 10:44:28 volumio-mac volumio[28594]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 21 10:44:28 volumio-mac go-librespot[28904]: time="2025-04-21T10:44:28-04:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: i/o timeout" Apr 21 10:44:28 volumio-mac systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 21 10:44:28 volumio-mac systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 21 10:44:29 volumio-mac ntpd[21122]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 21 10:44:31 volumio-mac volumio[28594]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 10:44:31 volumio-mac volumio[28594]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com Apr 21 10:44:31 volumio-mac volumio[28594]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Apr 21 10:44:31 volumio-mac volumio[28594]: errno: -3007, Apr 21 10:44:31 volumio-mac volumio[28594]: code: 'ENOTFOUND', Apr 21 10:44:31 volumio-mac volumio[28594]: syscall: 'getaddrinfo', Apr 21 10:44:31 volumio-mac volumio[28594]: hostname: 'ws.audioscrobbler.com' Apr 21 10:44:31 volumio-mac volumio[28594]: } Apr 21 10:44:31 volumio-mac volumio[28594]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 10:44:31 volumio-mac sudo[29091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-21 10:43 Apr 21 10:44:31 volumio-mac sudo[29091]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"