-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2025-04-21 21:15:48 UTC. -- Apr 21 21:15:08 volumio ntpd[646]: receive: Unexpected origin timestamp 0xe676adb3.79cbaa31 does not match aorg 0000000000.00000000 from server@185.168.228.58 xmt 0xebb133dc.2ba99709 Apr 21 21:15:08 volumio ntpd[646]: receive: Unexpected origin timestamp 0xe676adb3.79cd7537 does not match aorg 0000000000.00000000 from server@94.130.184.193 xmt 0xebb133dc.2cdaafff Apr 21 21:15:08 volumio systemd[1]: Starting Daily apt download activities... Apr 21 21:15:08 volumio ntpd[646]: receive: Unexpected origin timestamp 0xe676adb3.79c0cf74 does not match aorg 0000000000.00000000 from server@81.7.16.52 xmt 0xebb133dc.2e348af4 Apr 21 21:15:08 volumio ntpd[646]: receive: Unexpected origin timestamp 0xe676adb3.79d01c6e does not match aorg 0000000000.00000000 from server@104.238.26.11 xmt 0xebb133dc.2f374203 Apr 21 21:15:08 volumio ntpd[646]: receive: Unexpected origin timestamp 0xe676adb3.79c8cb2f does not match aorg 0000000000.00000000 from server@77.24.107.53 xmt 0xebb133dc.2dba9509 Apr 21 21:15:08 volumio ntpd[646]: Soliciting pool server 168.119.211.223 Apr 21 21:15:09 volumio systemd[1]: apt-daily.service: Succeeded. Apr 21 21:15:09 volumio systemd[1]: Started Daily apt download activities. Apr 21 21:15:09 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Apr 21 21:15:09 volumio ntpd[646]: Soliciting pool server 94.16.122.152 Apr 21 21:15:09 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 21 21:15:09 volumio systemd[1]: Started Daily apt upgrade and clean activities. Apr 21 21:15:10 volumio ntpd[646]: Soliciting pool server 85.215.166.214 Apr 21 21:15:11 volumio volumio[804]: info: mDNS: A device disapperared from network Apr 21 21:15:11 volumio volumio[804]: info: mDNS: Device volumio disapperared from network Apr 21 21:15:11 volumio volumio[804]: info: mDNS: A device disapperared from network Apr 21 21:15:11 volumio ntpd[646]: Soliciting pool server 212.18.3.19 Apr 21 21:15:11 volumio volumio[804]: info: Discovery: adding undefined Apr 21 21:15:11 volumio volumio[804]: info: mDNS: Found device Volumio Apr 21 21:15:11 volumio volumio[804]: info: CoreCommandRouter::volumioGetState Apr 21 21:15:11 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:11 volumio volumio[804]: info: Discovery: this is already registered, undefined Apr 21 21:15:11 volumio volumio[804]: info: mDNS: Found device Volumio Apr 21 21:15:11 volumio volumio[804]: info: CoreCommandRouter::volumioGetState Apr 21 21:15:11 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 21 21:15:11 volumio volumio[804]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 21 21:15:11 volumio volumio[804]: info: Adding plugin bluetooth to MyMusic Plugins Apr 21 21:15:11 volumio volumio[804]: info: Adding plugin multiroom to MyMusic Plugins Apr 21 21:15:11 volumio volumio[804]: info: Adding plugin metavolumio to MyMusic Plugins Apr 21 21:15:11 volumio volumio[804]: info: Adding plugin cd_controller to MyMusic Plugins Apr 21 21:15:12 volumio volumio[804]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 21 21:15:12 volumio volumio[804]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 21 21:15:12 volumio volumio[804]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 21 21:15:12 volumio ntpd[646]: Soliciting pool server 144.91.126.59 Apr 21 21:15:13 volumio ntpd[646]: Soliciting pool server 188.34.165.100 Apr 21 21:15:13 volumio volumio[804]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 21 21:15:13 volumio volumio[804]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:13 volumio volumio[804]: info: Starting MyVolumio Remote Streaming Endpoints Apr 21 21:15:13 volumio volumio[804]: info: MyVolumio not started Apr 21 21:15:13 volumio volumio[804]: info: Initializing device activation check Apr 21 21:15:13 volumio volumio[804]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 21 21:15:13 volumio volumio[804]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 21 21:15:13 volumio volumio[804]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 21 21:15:13 volumio volumio[804]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 21 21:15:13 volumio volumio[804]: info: Streaming services startup Apr 21 21:15:13 volumio volumio[804]: info: Starting Streaming Daemon Apr 21 21:15:13 volumio sudo[1502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 21 21:15:13 volumio sudo[1502]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:13 volumio systemd[1]: Stopping Volumio Streaming Daemon... Apr 21 21:15:13 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM Apr 21 21:15:13 volumio systemd[1]: volumio-streaming-daemon.service: Succeeded. Apr 21 21:15:13 volumio systemd[1]: Stopped Volumio Streaming Daemon. Apr 21 21:15:13 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 21 21:15:13 volumio sudo[1502]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:13 volumio volumio-streaming-daemon[1508]: ############################ Apr 21 21:15:13 volumio volumio-streaming-daemon[1508]: # Volumio Streaming Daemon # Apr 21 21:15:13 volumio volumio-streaming-daemon[1508]: # Running on port 7777 # Apr 21 21:15:13 volumio volumio-streaming-daemon[1508]: ############################ Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 21 21:15:13 volumio volumio-streaming-daemon[1508]: Environment: production Apr 21 21:15:13 volumio volumio[804]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 21 21:15:13 volumio volumio[804]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Apr 21 21:15:13 volumio volumio[804]: info: Received Get System Version Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 21:15:13 volumio volumio[804]: info: Received Get System Info Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 21 21:15:13 volumio volumio[804]: info: Discovery: Getting this device information Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::volumioGetState Apr 21 21:15:13 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:13 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:15 volumio volumio[804]: info: Enabling I2S DAC: IQaudIO Pi-DigiAMP+ Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:15 volumio sudo[1519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Apr 21 21:15:15 volumio sudo[1519]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:15 volumio sudo[1519]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:15 volumio volumio[804]: info: No Overlays Loaded Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Apr 21 21:15:15 volumio sudo[1522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay iqaudio-dacplus Apr 21 21:15:15 volumio sudo[1522]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:15 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Apr 21 21:15:15 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/status Apr 21 21:15:15 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Apr 21 21:15:15 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Apr 21 21:15:15 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/mute-gpios Apr 21 21:15:15 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Apr 21 21:15:15 volumio volumio[804]: warn: Unable to locate the device IQaudIO Pi-DigiAMP+ a reboot may be required. Apr 21 21:15:15 volumio sudo[1522]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:15 volumio volumio[804]: info: Found match in i2s Card Database: setting mixer Digital for card IQaudIO Pi-DigiAMP+ Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 21 21:15:15 volumio volumio[804]: info: Updating Volume Controller Parameters: Device: 2 Name: IQaudIO Pi-DigiAMP+ Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 21 21:15:15 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 21 21:15:16 volumio volumio[804]: info: Preparing to generate the ALSA configuration file Apr 21 21:15:16 volumio kernel: pcm512x 1-004c: Failed to reset device: -121 Apr 21 21:15:16 volumio kernel: pcm512x: probe of 1-004c failed with error -121 Apr 21 21:15:16 volumio volumio[804]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 21:15:16 volumio volumio[804]: info: Data script executed Apr 21 21:15:16 volumio volumio[804]: info: I2S Param [object Object] successfully enabled Apr 21 21:15:16 volumio volumio[804]: info: VolumeController:: Volume=undefined Mute =false Apr 21 21:15:16 volumio volumio[804]: info: CoreStateMachine::pushState Apr 21 21:15:16 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 21 21:15:16 volumio sudo[1557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 21 21:15:16 volumio sudo[1557]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 21:15:16 volumio volumio[804]: info: Getting Alsa Cards List without I2S DAC Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:16 volumio volumio[804]: Invalid card number. Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 21 21:15:16 volumio volumio[804]: info: Asound.conf file written Apr 21 21:15:16 volumio sudo[1568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 21 21:15:16 volumio sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio sudo[1568]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:16 volumio volumio[804]: No state is present for card b1 Apr 21 21:15:16 volumio volumio[804]: No state is present for card Headphones Apr 21 21:15:16 volumio volumio[804]: info: Output device has changed, restarting MPD Apr 21 21:15:16 volumio sudo[1573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 21:15:16 volumio volumio[804]: info: Output device has changed, restarting Shairport Sync Apr 21 21:15:16 volumio sudo[1573]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:16 volumio sudo[1573]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:16 volumio sudo[1575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 21:15:16 volumio sudo[1575]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio systemd[1]: Stopping Music Player Daemon... Apr 21 21:15:16 volumio volumio[804]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 21:15:16 volumio volumio[804]: info: Output device has changed, restarting MPD Apr 21 21:15:16 volumio systemd[1]: mpd.service: Succeeded. Apr 21 21:15:16 volumio systemd[1]: Stopped Music Player Daemon. Apr 21 21:15:16 volumio systemd[1]: Starting Music Player Daemon... Apr 21 21:15:16 volumio sudo[1582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 21 21:15:16 volumio sudo[1582]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio volumio[804]: info: Output device has changed, restarting Shairport Sync Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:16 volumio sudo[1582]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:16 volumio sudo[1586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 21 21:15:16 volumio sudo[1586]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 21 21:15:16 volumio volumio[804]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 21 21:15:16 volumio sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 21 21:15:16 volumio sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio sudo[1593]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:16 volumio volumio[804]: info: MPD Permissions set Apr 21 21:15:16 volumio volumio[804]: info: MPD Permissions set Apr 21 21:15:16 volumio volumio[804]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 21 21:15:16 volumio volumio[804]: wlan0 Interface doesn't support scanning : Device or resource busy Apr 21 21:15:16 volumio volumio[804]: info: Cannot use regular scanning, forcing with ap-force Apr 21 21:15:16 volumio volumio-streaming-daemon[1508]: Environment: production Apr 21 21:15:16 volumio systemd[1]: mpd.service: Succeeded. Apr 21 21:15:16 volumio systemd[1]: Stopped Music Player Daemon. Apr 21 21:15:16 volumio sudo[1596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 21 21:15:16 volumio sudo[1596]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio systemd[1]: Starting Music Player Daemon... Apr 21 21:15:16 volumio sudo[1596]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:16 volumio volumio[804]: command failed: Device or resource busy (-16) Apr 21 21:15:16 volumio volumio[804]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Apr 21 21:15:16 volumio volumio[804]: command failed: Device or resource busy (-16) Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 21:15:16 volumio volumio[804]: info: Fetching Streaming Services browse cache Apr 21 21:15:16 volumio volumio[804]: info: Starting Shairport Sync Apr 21 21:15:16 volumio volumio[804]: info: Starting Shairport Sync Apr 21 21:15:16 volumio sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 21:15:16 volumio sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio sudo[1612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 21:15:16 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 21 21:15:16 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 21 21:15:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 21 21:15:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 21:15:16 volumio sudo[1610]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 21 21:15:16 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 21 21:15:16 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 21 21:15:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 21 21:15:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 21:15:17 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:17 volumio volumio[804]: info: Shairport-Sync Started Apr 21 21:15:17 volumio volumio[804]: info: Shairport-Sync Started Apr 21 21:15:17 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:17 volumio volumio[804]: info: Retrieving Cloud Streaming UI Apr 21 21:15:17 volumio volumio[804]: info: Getting Tidal Cloud Configuration Apr 21 21:15:17 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:17 volumio volumio[804]: info: Getting Qobuz Cloud Configuration Apr 21 21:15:17 volumio volumio[804]: info: Asking plugin for UI Config Apr 21 21:15:17 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:17 volumio volumio[804]: info: Getting Spotify Cloud Configuration Apr 21 21:15:17 volumio volumio[804]: info: Asking plugin for UI Config Apr 21 21:15:17 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:17 volumio volumio[804]: info: Saving Spotify Acccount Apr 21 21:15:17 volumio volumio[804]: info: Got Tidal Cloud Configuration Apr 21 21:15:17 volumio volumio[804]: info: Got it Apr 21 21:15:17 volumio volumio[804]: info: Got it Apr 21 21:15:17 volumio volumio[804]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 21 21:15:17 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:17 volumio volumio[804]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 21 21:15:17 volumio mpd[1615]: Apr 21 21:15 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 21 21:15:17 volumio mpd[1615]: Apr 21 21:15 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 21 21:15:17 volumio mpd[1615]: Apr 21 21:15 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 21 21:15:17 volumio systemd[1]: Started Music Player Daemon. Apr 21 21:15:17 volumio sudo[1586]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:17 volumio sudo[1575]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:18 volumio volumio[804]: error: MPD error: The expression evaluated to a falsy value: Apr 21 21:15:18 volumio volumio[804]: assert.ok(self.idling) Apr 21 21:15:18 volumio volumio[804]: error: updateQueue error: null Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 21 21:15:18 volumio volumio[804]: info: CoreStateMachine::getcurrentVolume Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 21:15:18 volumio volumio[804]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 21:15:18 volumio volumio[804]: info: VolumeController:: Volume=undefined Mute =false Apr 21 21:15:18 volumio volumio[804]: info: CoreStateMachine::pushState Apr 21 21:15:18 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Apr 21 21:15:18 volumio volumio[804]: info: CoreStateMachine::updateTrackBlock Apr 21 21:15:18 volumio volumio[804]: info: CorePlayQueue::getTrackBlock Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 21:15:18 volumio volumio[804]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 21:15:18 volumio volumio[804]: info: VolumeController:: Volume=undefined Mute =false Apr 21 21:15:18 volumio volumio[804]: info: CoreStateMachine::pushState Apr 21 21:15:18 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:18 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Apr 21 21:15:19 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 21 21:15:19 volumio volumio[804]: info: CoreCommandRouter::Reload Ui Apr 21 21:15:19 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Apr 21 21:15:19 volumio volumio[804]: info: Wizard terminated Successfully Apr 21 21:15:19 volumio volumio[804]: info: Player Reboot required after I2S DAC has been enabled in wizard Apr 21 21:15:19 volumio sudo[1557]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:20 volumio sudo[1637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 21:15:20 volumio sudo[1637]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:20 volumio sudo[1637]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:20 volumio sudo[1639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 21:15:20 volumio sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:20 volumio sudo[1639]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:20 volumio volumio[804]: verbose: New Socket.io Connection to 192.168.178.26 from 192.168.178.57 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:137.0) Gecko/20100101 Firefox/137.0 Total Clients: 3 Apr 21 21:15:20 volumio sudo[1643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 21:15:20 volumio sudo[1643]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:20 volumio sudo[1643]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:20 volumio sudo[1645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 21:15:20 volumio sudo[1645]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:20 volumio sudo[1645]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:20 volumio volumio[804]: verbose: New Socket.io Connection to 192.168.178.26 from 192.168.178.57 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:137.0) Gecko/20100101 Firefox/137.0 Total Clients: 4 Apr 21 21:15:20 volumio volumio[804]: info: CoreCommandRouter::volumioGetState Apr 21 21:15:20 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:20 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 21 21:15:20 volumio volumio[804]: info: CoreCommandRouter::volumioGetVisibleSources Apr 21 21:15:20 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 21:15:20 volumio volumio[804]: info: Listing playlists Apr 21 21:15:20 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 21 21:15:20 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 21 21:15:20 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 21 21:15:20 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 21 21:15:23 volumio volumio[804]: error: updateQueue error: null Apr 21 21:15:23 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 21 21:15:23 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 21 21:15:23 volumio volumio[804]: info: MyVolumio login type: Token Apr 21 21:15:23 volumio volumio[804]: info: VolumeController::SetAlsaVolume15 Apr 21 21:15:23 volumio volumio[804]: info: CoreStateMachine::pushState Apr 21 21:15:23 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:23 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 21:15:23 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Apr 21 21:15:23 volumio volumio[804]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 21:15:24 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 21 21:15:24 volumio volumio[804]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 21 21:15:24 volumio volumio[804]: info: MYVOLUMIO: Adding device Apr 21 21:15:24 volumio volumio[804]: info: MYVOLUMIO: Evaluating Server Apr 21 21:15:24 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 21 21:15:24 volumio volumio[804]: info: MyVolumio login type: Token Apr 21 21:15:25 volumio volumio[804]: info: MyVolumio status changed Apr 21 21:15:25 volumio volumio[804]: info: Streaming services startup Apr 21 21:15:25 volumio volumio[804]: info: Re-Starting Streaming Daemon Apr 21 21:15:25 volumio volumio[804]: info: Removing browser output: myVolumio user plan is not superstar Apr 21 21:15:25 volumio volumio[804]: info: Removing audio output: Apr 21 21:15:25 volumio volumio[804]: info: Stoppping Tunnel 1 Apr 21 21:15:25 volumio sudo[1669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 21 21:15:25 volumio sudo[1669]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:25 volumio sudo[1669]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:25 volumio volumio-streaming-daemon[1508]: Restarting daemon Apr 21 21:15:25 volumio volumio-streaming-daemon[1508]: Environment: production Apr 21 21:15:25 volumio volumio[804]: info: Remote SSH Stopped Apr 21 21:15:25 volumio volumio[804]: info: Setting Geolocation for MyVolumio to eu5 Apr 21 21:15:25 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:25 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:25 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:25 volumio volumio-streaming-daemon[1508]: Environment: production Apr 21 21:15:25 volumio volumio[804]: info: Fetching Streaming Services browse cache Apr 21 21:15:25 volumio volumio[804]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 21 21:15:26 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 21 21:15:26 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 21 21:15:26 volumio volumio[804]: info: Updating MyVolumio device info Apr 21 21:15:26 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:26 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 21 21:15:27 volumio volumio[804]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 21:15:27 volumio volumio[804]: info: Getting Alsa Cards List without I2S DAC Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:27 volumio volumio[804]: Invalid card number. Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 21 21:15:27 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 21 21:15:29 volumio volumio[804]: info: MYVOLUMIO: Adding device Apr 21 21:15:29 volumio volumio[804]: info: MYVOLUMIO: Evaluating Server Apr 21 21:15:30 volumio volumio[804]: info: Setting Geolocation for MyVolumio to eu5 Apr 21 21:15:30 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:30 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:30 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:30 volumio volumio[804]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 21 21:15:31 volumio volumio[804]: info: Updating MyVolumio device info Apr 21 21:15:31 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:31 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:31 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:32 volumio volumio[804]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 21 21:15:34 volumio volumio[804]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::volumioGetState Apr 21 21:15:34 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:34 volumio volumio[804]: info: Restoring Previous Volume level: 15 false false Apr 21 21:15:34 volumio volumio[804]: info: Volume configurations have been set Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 21 21:15:34 volumio volumio[804]: info: Updating Volume Controller Parameters: Device: 2 Name: IQaudIO Pi-DigiAMP+ Mixer: Digital Max Vol: 30 Vol Curve; logarithmic Vol Steps: 1 Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:34 volumio volumio[804]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 21:15:34 volumio volumio[804]: info: Getting Alsa Cards List without I2S DAC Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 21:15:34 volumio volumio[804]: Invalid card number. Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 21 21:15:34 volumio volumio[804]: info: VolumeController:: Volume=undefined Mute =false Apr 21 21:15:34 volumio volumio[804]: info: CoreStateMachine::pushState Apr 21 21:15:34 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:34 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Apr 21 21:15:38 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 21 21:15:38 volumio volumio[804]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 21 21:15:38 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 21 21:15:38 volumio volumio[804]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Apr 21 21:15:38 volumio volumio[804]: info: Received Get System Version Apr 21 21:15:38 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 21:15:38 volumio volumio[804]: info: Received Get System Info Apr 21 21:15:38 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 21 21:15:38 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 21 21:15:38 volumio volumio[804]: info: Discovery: Getting this device information Apr 21 21:15:38 volumio volumio[804]: info: CoreCommandRouter::volumioGetState Apr 21 21:15:38 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:38 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 21 21:15:39 volumio volumio[804]: info: VolumeController::SetAlsaVolume15 Apr 21 21:15:39 volumio volumio[804]: info: CoreStateMachine::pushState Apr 21 21:15:39 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Apr 21 21:15:39 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Apr 21 21:15:39 volumio volumio[804]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:44 volumio volumio[804]: info: Retrieving Cloud Streaming UI Apr 21 21:15:44 volumio volumio[804]: info: Getting Tidal Cloud Configuration Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:44 volumio volumio[804]: info: Getting Qobuz Cloud Configuration Apr 21 21:15:44 volumio volumio[804]: info: Asking plugin for UI Config Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:44 volumio volumio[804]: info: Getting Spotify Cloud Configuration Apr 21 21:15:44 volumio volumio[804]: info: Asking plugin for UI Config Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:44 volumio volumio[804]: info: Saving Spotify Acccount Apr 21 21:15:44 volumio volumio[804]: info: Got Tidal Cloud Configuration Apr 21 21:15:44 volumio volumio[804]: info: Got it Apr 21 21:15:44 volumio volumio[804]: info: Got it Apr 21 21:15:44 volumio volumio[804]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 21:15:44 volumio volumio[804]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::volumioGetBrowseSources Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 21 21:15:44 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 21 21:15:45 volumio volumio[804]: info: Disabling MyMusic plugin upnp Apr 21 21:15:45 volumio sudo[1714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 21 21:15:45 volumio sudo[1714]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:45 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 21 21:15:45 volumio volumio[804]: error: Upnp client error: Error: This socket has been ended by the other party Apr 21 21:15:45 volumio volumio[804]: info: Disabling MyMusic plugin airplay_emulation Apr 21 21:15:45 volumio volumio[804]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Apr 21 21:15:45 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 21:15:45 volumio volumio[804]: Cannot find translation for sourceMedia Servers Apr 21 21:15:45 volumio volumio[804]: info: Disabling plugin airplay_emulation Apr 21 21:15:45 volumio volumio[804]: info: Done. Apr 21 21:15:45 volumio sudo[1717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Apr 21 21:15:45 volumio sudo[1717]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:45 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 21 21:15:45 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 21 21:15:45 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 21 21:15:45 volumio sudo[1717]: pam_unix(sudo:session): session closed for user root Apr 21 21:15:45 volumio volumio[804]: info: Shairport-Sync Stopped Apr 21 21:15:46 volumio volumio[804]: info: Disabling MyMusic plugin upnp_browser Apr 21 21:15:46 volumio volumio[804]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Apr 21 21:15:46 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 21:15:46 volumio volumio[804]: info: Disabling plugin upnp_browser Apr 21 21:15:46 volumio volumio[804]: info: Done. Apr 21 21:15:47 volumio volumio[804]: info: Disabling MyMusic plugin upnp Apr 21 21:15:47 volumio sudo[1720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 21 21:15:47 volumio sudo[1720]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 21:15:48 volumio volumio[804]: info: Enabling MyMusic plugin upnp Apr 21 21:15:48 volumio volumio[804]: info: Enabling plugin upnp Apr 21 21:15:48 volumio volumio[804]: info: Loading plugin "upnp"... Apr 21 21:15:48 volumio volumio[804]: info: [1745270148185] Starting Upmpd Daemon Apr 21 21:15:48 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 21:15:48 volumio volumio[804]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 21:15:48 volumio volumio[804]: Error: listen EADDRINUSE: address already in use :::6599 Apr 21 21:15:48 volumio volumio[804]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Apr 21 21:15:48 volumio volumio[804]: at listenInCluster (net.js:1366:12) Apr 21 21:15:48 volumio volumio[804]: at Server.listen (net.js:1452:7) Apr 21 21:15:48 volumio volumio[804]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 21 21:15:48 volumio volumio[804]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 21 21:15:48 volumio volumio[804]: at Promise._successFn (/volumio/app/pluginmanager.js:1841:19) Apr 21 21:15:48 volumio volumio[804]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 21 21:15:48 volumio volumio[804]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 21 21:15:48 volumio volumio[804]: code: 'EADDRINUSE', Apr 21 21:15:48 volumio volumio[804]: errno: -98, Apr 21 21:15:48 volumio volumio[804]: syscall: 'listen', Apr 21 21:15:48 volumio volumio[804]: address: '::', Apr 21 21:15:48 volumio volumio[804]: port: 6599 Apr 21 21:15:48 volumio volumio[804]: } Apr 21 21:15:48 volumio volumio[804]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 21:15:48 volumio sudo[1731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-21 21:14 Apr 21 21:15:48 volumio sudo[1731]: 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="1f061e035f7cb2799b32d3520aa8e55cd07df6f9" VOLUMIO_FE_VERSION="9971a09df9c3edfdedf2ecf438999be8aba9db68" VOLUMIO_FE3_VERSION="3974def988c7b2392ddc85f9b8cb4692d5e8fda9" VOLUMIO_BE_VERSION="b3c53a818b9b3d0e5c13c9d346c4d613c4ca426f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 11 Jul 2022 04:03:33 PM CEST" VOLUMIO_VERSION="3.324" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5b2f59e6e90e57f326ca25c7ca839d52"