-- Logs begin at Tue 2025-04-01 02:00:15 KST, end at Sun 2025-04-27 06:18:42 KST. -- Apr 27 06:17:00 volumio sudo[1981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 27 06:17:00 volumio sudo[1981]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:00 volumio systemd[1]: Started MyVolumio SSH Tunnel. Apr 27 06:17:00 volumio sudo[1981]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:00 volumio volumio[909]: info: Remote SSH Started Apr 27 06:17:00 volumio autossh[1984]: port set to 0, monitoring disabled Apr 27 06:17:00 volumio autossh[1984]: starting ssh (count 1) Apr 27 06:17:00 volumio autossh[1984]: ssh child pid is 1987 Apr 27 06:17:00 volumio volumio[909]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 27 06:17:00 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:17:00 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:00 volumio volumiossh-tunnel[1983]: Warning: Permanently added '[as1.myvolumio.org]:2222,[128.199.166.162]:2222' (RSA) to the list of known hosts. Apr 27 06:17:08 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 06:17:08 volumio volumio[909]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 27 06:17:08 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 27 06:17:08 volumio volumio[909]: info: Received Get System Version Apr 27 06:17:08 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 06:17:08 volumio volumio[909]: info: Received Get System Info Apr 27 06:17:08 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:17:08 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:17:08 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:17:08 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:17:08 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:08 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:17:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:17:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:17:16 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:17:16 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:17:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:17:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Apr 27 06:17:20 volumio volumio[909]: info: Loading i18n strings for locale ko Apr 27 06:17:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Apr 27 06:17:20 volumio volumio[909]: info: Setting timezone to Asia/Seoul Apr 27 06:17:20 volumio sudo[2022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Apr 27 06:17:20 volumio sudo[2022]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:20 volumio sudo[2022]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:20 volumio sudo[2025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Seoul /etc/localtime Apr 27 06:17:20 volumio sudo[2025]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:20 volumio sudo[2025]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:20 volumio sudo[2028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Apr 27 06:17:20 volumio sudo[2028]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:20 volumio sudo[2028]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:20 volumio sudo[2031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Seoul Apr 27 06:17:20 volumio sudo[2031]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:20 volumio sudo[2031]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 27 06:17:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 27 06:17:20 volumio sudo[2034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 27 06:17:20 volumio sudo[2034]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:20 volumio volumio[909]: Updating browse sources language Apr 27 06:17:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 06:17:20 volumio volumio[909]: info: Fetching Streaming Services browse cache Apr 27 06:17:21 volumio sudo[2034]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:21 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Apr 27 06:17:21 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 06:17:22 volumio volumio-remote-updater[621]: No test mode Apr 27 06:17:22 volumio volumio-remote-updater[621]: No alpha test mode Apr 27 06:17:22 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 27 06:17:22 volumio volumio[909]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 27 06:17:22 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Apr 27 06:17:41 volumio volumio[909]: info: System name has changed, restarting Shairport Sync Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:41 volumio volumio[909]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 06:17:41 volumio volumio[909]: info: Updating MyVolumio device info Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:41 volumio volumio[909]: info: Discovery: Restarting Advertising due to device name change Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Apr 27 06:17:41 volumio sudo[2073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 27 06:17:41 volumio sudo[2073]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:41 volumio sudo[2073]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:41 volumio systemd[1]: upmpdcli.service: Succeeded. Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:41 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 27 06:17:41 volumio volumio[909]: info: Starting Shairport Sync Apr 27 06:17:41 volumio sudo[2078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Apr 27 06:17:41 volumio sudo[2078]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:41 volumio sudo[2078]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:41 volumio volumio[909]: info: Permissions for /etc/hosts set Apr 27 06:17:41 volumio sudo[2081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 06:17:41 volumio sudo[2081]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:41 volumio volumio[909]: info: Hostname now is volumio_ap4 Apr 27 06:17:41 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 06:17:41 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 06:17:41 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 06:17:41 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 06:17:41 volumio sudo[2081]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:41 volumio volumio[909]: info: Shairport-Sync Started Apr 27 06:17:41 volumio sudo[2087]: volumio : unable to resolve host volumio Apr 27 06:17:41 volumio sudo[2087]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:41 volumio sudo[2087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Apr 27 06:17:41 volumio sudo[2087]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:41 volumio sudo[2087]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:41 volumio volumio[909]: info: Permissions for /etc/avahi/services/volumio.service Apr 27 06:17:41 volumio avahi-daemon[597]: Files changed, reloading. Apr 27 06:17:41 volumio avahi-daemon[597]: Loading service file /services/volumio.service. Apr 27 06:17:41 volumio volumio[909]: info: Avahi name changed to volumio_ap4 Apr 27 06:17:41 volumio sudo[2084]: volumio : unable to resolve host volumio Apr 27 06:17:41 volumio sudo[2084]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:41 volumio sudo[2084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio_ap4 Apr 27 06:17:41 volumio sudo[2084]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:41 volumio sudo[2084]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:41 volumio volumio[909]: error: Cannot set new hostname: Error: Command failed: /usr/bin/sudo /bin/hostname volumio_ap4 Apr 27 06:17:41 volumio volumio[909]: sudo: unable to resolve host volumio: System error Apr 27 06:17:41 volumio volumio[909]: hostname: the specified hostname is invalid Apr 27 06:17:42 volumio volumio[909]: info: Successfully Updated MyVolumio device Apr 27 06:17:42 volumio volumio[909]: info: Discovery: A device disappeared from network Apr 27 06:17:42 volumio volumio[909]: info: Discovery: Device volumio disappeared from network Apr 27 06:17:42 volumio volumio[909]: info: Discovery: A device disappeared from network Apr 27 06:17:42 volumio avahi-daemon[597]: Service "Volumio_AP4" (/services/volumio.service) successfully established. Apr 27 06:17:46 volumio volumio[909]: info: Discovery: Started advertising with name: Volumio_AP4 Apr 27 06:17:46 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:17:46 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:17:46 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:17:46 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:17:46 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:46 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:17:47 volumio volumio[909]: info: Discovery: adding 0e1e0656-c9fc-4853-8510-af0fafb2dc5b Apr 27 06:17:47 volumio volumio[909]: info: Discovery: Found device Volumio_AP4 Apr 27 06:17:47 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:17:47 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:47 volumio volumio[909]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Apr 27 06:17:47 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:17:47 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:17:47 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:17:47 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:17:47 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:47 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:17:50 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Apr 27 06:17:50 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 06:17:50 volumio systemd[1]: systemd-timedated.service: Succeeded. Apr 27 06:17:50 volumio volumio-remote-updater[621]: No test mode Apr 27 06:17:50 volumio volumio-remote-updater[621]: No alpha test mode Apr 27 06:17:50 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 27 06:17:51 volumio volumio[909]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 27 06:17:51 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 27 06:17:51 volumio sudo[2117]: volumio : unable to resolve host volumio Apr 27 06:17:51 volumio sudo[2117]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:51 volumio sudo[2117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf Apr 27 06:17:51 volumio sudo[2117]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:51 volumio sudo[2119]: volumio : unable to resolve host volumio Apr 27 06:17:51 volumio sudo[2119]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:51 volumio sudo[2119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL Apr 27 06:17:51 volumio sudo[2119]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:51 volumio sudo[2119]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:51 volumio volumio[909]: info: Internal perms successfully set Apr 27 06:17:51 volumio sudo[2117]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:51 volumio volumio[909]: info: smb.conf Permissions set Apr 27 06:17:51 volumio sudo[2127]: volumio : unable to resolve host volumio Apr 27 06:17:51 volumio sudo[2127]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:51 volumio sudo[2127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 27 06:17:51 volumio sudo[2127]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:51 volumio sudo[2125]: volumio : unable to resolve host volumio Apr 27 06:17:51 volumio sudo[2125]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:51 volumio sudo[2125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 06:17:51 volumio sudo[2125]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:51 volumio sudo[2125]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:51 volumio sudo[2122]: volumio : unable to resolve host volumio Apr 27 06:17:51 volumio sudo[2122]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:51 volumio sudo[2122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 06:17:51 volumio sudo[2122]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:51 volumio sudo[2122]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:51 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 27 06:17:51 volumio sudo[2127]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:51 volumio volumio[909]: info: Upmpdcli Daemon Started Apr 27 06:17:51 volumio volumio[2132]: writing RSA key Apr 27 06:17:51 volumio sudo[2129]: volumio : unable to resolve host volumio Apr 27 06:17:51 volumio sudo[2129]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:51 volumio sudo[2129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service Apr 27 06:17:51 volumio sudo[2129]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:51 volumio nmbd[758]: [2025/04/27 06:17:51.756214, 0] ../source3/nmbd/nmbd.c:58(terminate) Apr 27 06:17:51 volumio systemd[1]: Stopping Samba NMB Daemon... Apr 27 06:17:51 volumio nmbd[758]: Got SIGTERM: going down... Apr 27 06:17:51 volumio systemd[1]: nmbd.service: Succeeded. Apr 27 06:17:51 volumio systemd[1]: Stopped Samba NMB Daemon. Apr 27 06:17:51 volumio systemd[1]: Starting Samba NMB Daemon... Apr 27 06:17:52 volumio nmbd[2179]: [2025/04/27 06:17:52.048371, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 27 06:17:52 volumio nmbd[2179]: started asyncdns process 2180 Apr 27 06:17:52 volumio nmbd[2179]: [2025/04/27 06:17:52.053986, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 27 06:17:52 volumio nmbd[2179]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 27 06:17:52 volumio systemd[1]: Started Samba NMB Daemon. Apr 27 06:17:52 volumio sudo[2129]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:52 volumio sudo[2182]: volumio : unable to resolve host volumio Apr 27 06:17:52 volumio sudo[2182]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:52 volumio sudo[2182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service Apr 27 06:17:52 volumio sudo[2182]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:52 volumio systemd[1]: Stopping Samba SMB Daemon... Apr 27 06:17:52 volumio systemd[1]: smbd.service: Main process exited, code=killed, status=15/TERM Apr 27 06:17:52 volumio systemd[1]: smbd.service: Succeeded. Apr 27 06:17:52 volumio systemd[1]: Stopped Samba SMB Daemon. Apr 27 06:17:52 volumio systemd[1]: Starting Samba SMB Daemon... Apr 27 06:17:52 volumio winbindd[1004]: [2025/04/27 06:17:52.668307, 0] ../source3/winbindd/winbindd_samr.c:672(sam_sid_to_name) Apr 27 06:17:52 volumio winbindd[1004]: sam_sid_to_name: possible deadlock - trying to lookup SID S-1-5-21-3067202316-2612994097-2700195476-501 Apr 27 06:17:52 volumio winbindd[1004]: [2025/04/27 06:17:52.668986, 0] ../source3/winbindd/winbindd_samr.c:672(sam_sid_to_name) Apr 27 06:17:52 volumio winbindd[1004]: sam_sid_to_name: possible deadlock - trying to lookup SID S-1-5-21-3067202316-2612994097-2700195476-514 Apr 27 06:17:52 volumio smbd[2185]: [2025/04/27 06:17:52.687120, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 27 06:17:52 volumio smbd[2185]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 27 06:17:52 volumio systemd[1]: Started Samba SMB Daemon. Apr 27 06:17:52 volumio sudo[2182]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:52 volumio volumio[909]: info: SAMBA Restarted Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 27 06:17:53 volumio volumio[909]: info: Preparing to save Alsa Options, stopping services first Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:17:53 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::volumioPause Apr 27 06:17:53 volumio volumio[909]: info: CoreStateMachine::pause Apr 27 06:17:53 volumio volumio[909]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"value":"soekris-dac","label":"Soekris dam 1021"},"output_device":{"value":1,"label":"Soekris dam 1021"},"disallowPush":true} Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:53 volumio volumio[909]: info: Enabling I2S DAC: Soekris dam 1021 Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:53 volumio sudo[2192]: volumio : unable to resolve host volumio Apr 27 06:17:53 volumio sudo[2192]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:53 volumio sudo[2192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Apr 27 06:17:53 volumio sudo[2192]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:53 volumio sudo[2192]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:53 volumio volumio[909]: sudo: unable to resolve host volumio: System error Apr 27 06:17:53 volumio volumio[909]: info: No Overlays Loaded Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:53 volumio volumio[909]: warn: Unable to locate the device Soekris dam 1021 a reboot may be required. Apr 27 06:17:53 volumio sudo[2195]: volumio : unable to resolve host volumio Apr 27 06:17:53 volumio sudo[2195]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:53 volumio sudo[2195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dac Apr 27 06:17:53 volumio sudo[2195]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Apr 27 06:17:53 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Apr 27 06:17:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Apr 27 06:17:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Apr 27 06:17:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Apr 27 06:17:53 volumio volumio[909]: Invalid card number. Apr 27 06:17:53 volumio sudo[2195]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 27 06:17:54 volumio volumio[909]: info: Updating Volume Controller Parameters: Device: 2 Name: Soekris dam 1021 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 27 06:17:54 volumio volumio[909]: info: Disabling external Volume Control Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 27 06:17:54 volumio volumio[909]: info: Preparing to generate the ALSA configuration file Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 27 06:17:54 volumio systemd-udevd[2208]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 2' failed with exit code 99. Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 27 06:17:54 volumio volumio[909]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 27 06:17:54 volumio volumio[909]: info: I2S Param [object Object] successfully enabled Apr 27 06:17:54 volumio sudo[2220]: volumio : unable to resolve host volumio Apr 27 06:17:54 volumio sudo[2220]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:54 volumio sudo[2220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 27 06:17:54 volumio sudo[2220]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 27 06:17:54 volumio volumio[909]: info: Getting Alsa Cards List without I2S DAC Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:54 volumio sudo[2222]: volumio : unable to resolve host volumio Apr 27 06:17:54 volumio sudo[2222]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:54 volumio sudo[2222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 27 06:17:54 volumio sudo[2222]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:54 volumio sudo[2222]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 27 06:17:54 volumio volumio[909]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 27 06:17:54 volumio volumio[909]: sudo: unable to resolve host volumio: System error Apr 27 06:17:54 volumio volumio[909]: wlan0 Interface doesn't support scanning : Device or resource busy Apr 27 06:17:54 volumio volumio[909]: info: Cannot use regular scanning, forcing with ap-force Apr 27 06:17:54 volumio sudo[2235]: volumio : unable to resolve host volumio Apr 27 06:17:54 volumio sudo[2235]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:54 volumio sudo[2235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 27 06:17:54 volumio sudo[2235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:54 volumio sudo[2235]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:54 volumio volumio[909]: sudo: unable to resolve host volumio: System error Apr 27 06:17:54 volumio volumio[909]: command failed: Device or resource busy (-16) Apr 27 06:17:54 volumio volumio[909]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Apr 27 06:17:54 volumio volumio[909]: sudo: unable to resolve host volumio: System error Apr 27 06:17:54 volumio volumio[909]: command failed: Device or resource busy (-16) Apr 27 06:17:54 volumio volumio[909]: info: VolumeController:: Volume=undefined Mute =false Apr 27 06:17:54 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:17:54 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:17:54 volumio volumio[909]: info: Asound.conf file written Apr 27 06:17:54 volumio sudo[2252]: volumio : unable to resolve host volumio Apr 27 06:17:54 volumio sudo[2252]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:54 volumio sudo[2252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 27 06:17:54 volumio sudo[2252]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:54 volumio sudo[2252]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:54 volumio volumio[909]: sudo: unable to resolve host volumio: System error Apr 27 06:17:54 volumio volumio[909]: No state is present for card b1 Apr 27 06:17:54 volumio volumio[909]: /usr/share/alsa/init/bcm2835:14: control element not found Apr 27 06:17:54 volumio volumio[909]: No state is present for card b1 Apr 27 06:17:54 volumio volumio[909]: No state is present for card Headphones Apr 27 06:17:54 volumio volumio[909]: /usr/share/alsa/init/bcm2835:20: control element not found Apr 27 06:17:54 volumio volumio[909]: No state is present for card Headphones Apr 27 06:17:54 volumio volumio[909]: No state is present for card sndrpihifiberry Apr 27 06:17:54 volumio volumio[909]: Found hardware: "RPi-simple" "" "" "" "" Apr 27 06:17:54 volumio volumio[909]: Hardware is initialized using a generic method Apr 27 06:17:54 volumio volumio[909]: No state is present for card sndrpihifiberry Apr 27 06:17:54 volumio volumio[909]: info: Output device has changed, restarting MPD Apr 27 06:17:54 volumio volumio[909]: info: Output device has changed, restarting Shairport Sync Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:54 volumio sudo[2257]: volumio : unable to resolve host volumio Apr 27 06:17:54 volumio sudo[2257]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:54 volumio sudo[2257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 06:17:54 volumio sudo[2257]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:54 volumio sudo[2257]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:54 volumio sudo[2259]: volumio : unable to resolve host volumio Apr 27 06:17:54 volumio sudo[2259]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:54 volumio sudo[2259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 06:17:54 volumio sudo[2259]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:54 volumio volumio[909]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 06:17:54 volumio volumio[909]: info: Output device has changed, restarting MPD Apr 27 06:17:54 volumio systemd[1]: Stopping Music Player Daemon... Apr 27 06:17:54 volumio volumio[909]: info: Output device has changed, restarting Shairport Sync Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:54 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:54 volumio systemd[1]: mpd.service: Succeeded. Apr 27 06:17:54 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 06:17:55 volumio sudo[2266]: volumio : unable to resolve host volumio Apr 27 06:17:55 volumio sudo[2266]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:55 volumio sudo[2266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 06:17:55 volumio sudo[2266]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:55 volumio sudo[2266]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:55 volumio sudo[2268]: volumio : unable to resolve host volumio Apr 27 06:17:55 volumio sudo[2268]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:55 volumio systemd[1]: Starting Music Player Daemon... Apr 27 06:17:55 volumio sudo[2268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 06:17:55 volumio sudo[2268]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:55 volumio volumio[909]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 06:17:55 volumio volumio[909]: info: MPD Permissions set Apr 27 06:17:55 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 27 06:17:55 volumio systemd[1]: mpd.service: Succeeded. Apr 27 06:17:55 volumio volumio[909]: info: MPD Permissions set Apr 27 06:17:55 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 06:17:55 volumio systemd[1]: Starting Music Player Daemon... Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio sudo[2220]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:17:55 volumio volumio[909]: info: Starting Shairport Sync Apr 27 06:17:55 volumio volumio[909]: info: Starting Shairport Sync Apr 27 06:17:55 volumio sudo[2285]: volumio : unable to resolve host volumio Apr 27 06:17:55 volumio sudo[2285]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:55 volumio sudo[2285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 06:17:55 volumio sudo[2285]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:55 volumio sudo[2287]: volumio : unable to resolve host volumio Apr 27 06:17:55 volumio sudo[2287]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:55 volumio sudo[2275]: root : unable to resolve host volumio Apr 27 06:17:55 volumio sudo[2275]: sudo: unable to resolve host volumio: System error Apr 27 06:17:55 volumio sudo[2275]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:17:55 volumio sudo[2287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 06:17:55 volumio sudo[2287]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:55 volumio sudo[2275]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 06:17:55 volumio sudo[2275]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:17:55 volumio sudo[2275]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:55 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 06:17:55 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 06:17:55 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 06:17:55 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 06:17:55 volumio sudo[2287]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:55 volumio sudo[2285]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:55 volumio volumio[909]: info: Shairport-Sync Started Apr 27 06:17:55 volumio volumio[909]: info: Shairport-Sync Started Apr 27 06:17:56 volumio mpd[2291]: Apr 27 06:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 27 06:17:56 volumio systemd[1]: Started Music Player Daemon. Apr 27 06:17:56 volumio sudo[2259]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:56 volumio sudo[2268]: pam_unix(sudo:session): session closed for user root Apr 27 06:17:56 volumio volumio[909]: error: MPD error: The expression evaluated to a falsy value: Apr 27 06:17:56 volumio volumio[909]: assert.ok(self.idling) Apr 27 06:17:56 volumio volumio[909]: error: The expression evaluated to a falsy value: Apr 27 06:17:56 volumio volumio[909]: assert.ok(self.idling) Apr 27 06:17:56 volumio volumio[909]: error: updateQueue error: null Apr 27 06:17:57 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:17:57 volumio volumio[909]: info: Retrieving Cloud Streaming UI Apr 27 06:17:57 volumio volumio[909]: info: Getting Tidal Cloud Configuration Apr 27 06:17:57 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:17:57 volumio volumio[909]: info: Getting Qobuz Cloud Configuration Apr 27 06:17:57 volumio volumio[909]: info: Asking plugin for UI Config Apr 27 06:17:57 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:17:57 volumio volumio[909]: info: Getting Spotify Cloud Configuration Apr 27 06:17:57 volumio volumio[909]: info: Asking plugin for UI Config Apr 27 06:17:57 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:17:57 volumio volumio[909]: info: Saving Spotify Acccount Apr 27 06:17:57 volumio volumio[909]: info: Got Tidal Cloud Configuration Apr 27 06:17:57 volumio volumio[909]: info: Got it Apr 27 06:17:57 volumio volumio[909]: info: Got it Apr 27 06:17:57 volumio volumio[909]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 27 06:17:57 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:17:57 volumio volumio[909]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 27 06:17:58 volumio volumio[909]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 27 06:17:58 volumio volumio[909]: info: CoreStateMachine::getcurrentVolume Apr 27 06:17:58 volumio volumio[909]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 06:17:58 volumio volumio[909]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 27 06:17:58 volumio volumio[909]: info: VolumeController:: Volume=undefined Mute =false Apr 27 06:17:58 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:17:58 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:58 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:17:58 volumio volumio[909]: info: CoreStateMachine::updateTrackBlock Apr 27 06:17:58 volumio volumio[909]: info: CorePlayQueue::getTrackBlock Apr 27 06:17:58 volumio volumio[909]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 06:17:58 volumio volumio[909]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 27 06:17:58 volumio volumio[909]: info: VolumeController:: Volume=undefined Mute =false Apr 27 06:17:58 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:17:58 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:17:58 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:17:59 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Apr 27 06:17:59 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 27 06:17:59 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Apr 27 06:17:59 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Apr 27 06:17:59 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 27 06:18:02 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 27 06:18:02 volumio volumio[909]: info: CoreCommandRouter::Reload Ui Apr 27 06:18:02 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Apr 27 06:18:02 volumio volumio[909]: info: Wizard terminated Successfully Apr 27 06:18:02 volumio volumio[909]: info: CoreCommandRouter::volumiosetStartupVolume Apr 27 06:18:02 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 06:18:02 volumio volumio[909]: info: Player Reboot required after I2S DAC has been enabled in wizard Apr 27 06:18:03 volumio sudo[2352]: volumio : unable to resolve host volumio Apr 27 06:18:03 volumio sudo[2352]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:03 volumio sudo[2352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 06:18:03 volumio sudo[2352]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:18:03 volumio sudo[2352]: pam_unix(sudo:session): session closed for user root Apr 27 06:18:03 volumio sudo[2350]: volumio : unable to resolve host volumio Apr 27 06:18:03 volumio sudo[2350]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:03 volumio sudo[2350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 06:18:03 volumio sudo[2350]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:18:03 volumio sudo[2350]: pam_unix(sudo:session): session closed for user root Apr 27 06:18:03 volumio sudo[2356]: volumio : unable to resolve host volumio Apr 27 06:18:03 volumio sudo[2356]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:03 volumio sudo[2356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 06:18:03 volumio sudo[2356]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:18:03 volumio sudo[2356]: pam_unix(sudo:session): session closed for user root Apr 27 06:18:03 volumio sudo[2358]: volumio : unable to resolve host volumio Apr 27 06:18:03 volumio sudo[2358]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:03 volumio sudo[2358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 06:18:03 volumio sudo[2358]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:18:03 volumio sudo[2358]: pam_unix(sudo:session): session closed for user root Apr 27 06:18:03 volumio volumio[909]: verbose: New Socket.io Connection to 192.168.219.109 from 192.168.219.107 UA: Mozilla/5.0 (Linux; Android 12; SM-N976N Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.111 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:03 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::volumioGetQueue Apr 27 06:18:03 volumio volumio[909]: info: CoreStateMachine::getQueue Apr 27 06:18:03 volumio volumio[909]: info: CorePlayQueue::getQueue Apr 27 06:18:03 volumio volumio[909]: info: Listing playlists Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 06:18:03 volumio volumio[909]: info: Received Get System Info Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:03 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:03 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:03 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 06:18:03 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 27 06:18:05 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 06:18:05 volumio volumio[909]: info: Received Get System Info Apr 27 06:18:05 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:05 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:05 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:05 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:05 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:05 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:05 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 27 06:18:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 06:18:06 volumio volumio[909]: info: Received Get System Info Apr 27 06:18:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:06 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:06 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:06 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:06 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:13 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 27 06:18:14 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Apr 27 06:18:15 volumio volumio[909]: info: Preload queue cleared Apr 27 06:18:15 volumio volumio[909]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::ClearQueue Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::stop Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 06:18:15 volumio volumio[909]: info: CorePlayQueue::clearPlayQueue Apr 27 06:18:15 volumio volumio[909]: info: CorePlayQueue::saveQueue Apr 27 06:18:15 volumio volumio[909]: info: CoreCommandRouter::volumioPushQueue Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::addQueueItems Apr 27 06:18:15 volumio volumio[909]: info: CorePlayQueue::addQueueItems Apr 27 06:18:15 volumio volumio[909]: info: Preload queue cleared Apr 27 06:18:15 volumio volumio[909]: info: Adding Item to queue: http://streams.calmradio.com:9328/stream Apr 27 06:18:15 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 27 06:18:15 volumio volumio[909]: info: CoreCommandRouter::volumioPushQueue Apr 27 06:18:15 volumio volumio[909]: info: CorePlayQueue::saveQueue Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::updateTrackBlock Apr 27 06:18:15 volumio volumio[909]: info: CorePlayQueue::getTrackBlock Apr 27 06:18:15 volumio volumio[909]: info: CoreCommandRouter::volumioPlay Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::play index 0 Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::stop Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::play index undefined Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 06:18:15 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:15 volumio volumio[909]: info: CoreStateMachine::startPlaybackTimer Apr 27 06:18:15 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:15 volumio volumio[909]: info: [1745702295684] ControllerWebradio::clearAddPlayTrack Apr 27 06:18:15 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 06:18:15 volumio volumio[909]: info: sendMpdCommand stop took 5 milliseconds Apr 27 06:18:15 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 06:18:15 volumio volumio[909]: info: Apr 27 06:18:15 volumio volumio[909]: ---------------------------- MPD announces system playlist update Apr 27 06:18:15 volumio volumio[909]: info: Ignoring MPD Status Update Apr 27 06:18:15 volumio volumio[909]: info: sendMpdCommand clear took 3 milliseconds Apr 27 06:18:15 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand load "http://streams.calmradio.com:9328/stream" Apr 27 06:18:15 volumio volumio[909]: info: Apr 27 06:18:15 volumio volumio[909]: ---------------------------- MPD announces system playlist update Apr 27 06:18:15 volumio volumio[909]: info: Ignoring MPD Status Update Apr 27 06:18:15 volumio volumio[909]: error: updateQueue error: null Apr 27 06:18:15 volumio volumio[909]: info: ------------------------------ 7ms Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:16 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand add "http://streams.calmradio.com:9328/stream" Apr 27 06:18:16 volumio volumio[909]: error: updateQueue error: null Apr 27 06:18:16 volumio volumio[909]: info: Apr 27 06:18:16 volumio volumio[909]: ---------------------------- MPD announces system playlist update Apr 27 06:18:16 volumio volumio[909]: info: Ignoring MPD Status Update Apr 27 06:18:16 volumio volumio[909]: info: ------------------------------ 730ms Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand add "http://streams.calmradio.com:9328/stream" took 3 milliseconds Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand play Apr 27 06:18:16 volumio volumio[909]: info: Apr 27 06:18:16 volumio volumio[909]: ---------------------------- MPD announces system playlist update Apr 27 06:18:16 volumio volumio[909]: info: Ignoring MPD Status Update Apr 27 06:18:16 volumio volumio[909]: info: ------------------------------ 7ms Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand play took 6 milliseconds Apr 27 06:18:16 volumio volumio[909]: info: ------------------------------ 5ms Apr 27 06:18:16 volumio volumio[909]: info: Apr 27 06:18:16 volumio volumio[909]: ---------------------------- MPD announces state update: player Apr 27 06:18:16 volumio volumio[909]: info: ControllerMpd::getState Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand status Apr 27 06:18:16 volumio volumio[909]: info: Apr 27 06:18:16 volumio volumio[909]: ---------------------------- MPD announces state update: player Apr 27 06:18:16 volumio volumio[909]: info: ControllerMpd::getState Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand status Apr 27 06:18:16 volumio volumio[909]: info: Apr 27 06:18:16 volumio volumio[909]: ---------------------------- MPD announces state update: player Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand status took 5 milliseconds Apr 27 06:18:16 volumio volumio[909]: info: ControllerMpd::getState Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand status Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand status took 5 milliseconds Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::parseState Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::parseState Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 06:18:16 volumio volumio[909]: info: Apr 27 06:18:16 volumio volumio[909]: ---------------------------- MPD announces state update: player Apr 27 06:18:16 volumio volumio[909]: info: ControllerMpd::getState Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand status Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand status took 8 milliseconds Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand status took 3 milliseconds Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::parseState Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::parseTrackInfo Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::parseTrackInfo Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::parseState Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 06:18:16 volumio volumio[909]: info: ControllerMpd::pushState Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::servicePushState Apr 27 06:18:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:16 volumio volumio[909]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://streams.calmradio.com:9328/stream","trackType":""} Apr 27 06:18:16 volumio volumio[909]: verbose: CURRENT POSITION 0 Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::syncState stateService play Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus stop Apr 27 06:18:16 volumio volumio[909]: info: ControllerMpd::pushState Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::servicePushState Apr 27 06:18:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:16 volumio volumio[909]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://streams.calmradio.com:9328/stream","trackType":""} Apr 27 06:18:16 volumio volumio[909]: verbose: CURRENT POSITION 0 Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::syncState stateService play Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play Apr 27 06:18:16 volumio volumio[909]: info: Received an update from plugin. extracting info from payload Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:16 volumio volumio[909]: info: ------------------------------ 45ms Apr 27 06:18:16 volumio volumio[909]: info: ------------------------------ 55ms Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand playlistinfo took 41 milliseconds Apr 27 06:18:16 volumio volumio[909]: info: sendMpdCommand playlistinfo took 37 milliseconds Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::parseTrackInfo Apr 27 06:18:16 volumio volumio[909]: verbose: ControllerMpd::parseTrackInfo Apr 27 06:18:16 volumio volumio[909]: info: ControllerMpd::pushState Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::servicePushState Apr 27 06:18:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:16 volumio volumio[909]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://streams.calmradio.com:9328/stream","trackType":""} Apr 27 06:18:16 volumio volumio[909]: verbose: CURRENT POSITION 0 Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::syncState stateService play Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play Apr 27 06:18:16 volumio volumio[909]: info: Received an update from plugin. extracting info from payload Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:16 volumio volumio[909]: info: ControllerMpd::pushState Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::servicePushState Apr 27 06:18:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:16 volumio volumio[909]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://streams.calmradio.com:9328/stream","trackType":""} Apr 27 06:18:16 volumio volumio[909]: verbose: CURRENT POSITION 0 Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::syncState stateService play Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play Apr 27 06:18:16 volumio volumio[909]: info: Received an update from plugin. extracting info from payload Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:16 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:16 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:16 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:16 volumio volumio[909]: info: ------------------------------ 115ms Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 107ms Apr 27 06:18:17 volumio volumio[909]: info: Apr 27 06:18:17 volumio volumio[909]: ---------------------------- MPD announces system playlist update Apr 27 06:18:17 volumio volumio[909]: info: Ignoring MPD Status Update Apr 27 06:18:17 volumio volumio[909]: info: Apr 27 06:18:17 volumio volumio[909]: ---------------------------- MPD announces state update: player Apr 27 06:18:17 volumio volumio[909]: info: ControllerMpd::getState Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand status Apr 27 06:18:17 volumio volumio[909]: info: Apr 27 06:18:17 volumio volumio[909]: ---------------------------- MPD announces system playlist update Apr 27 06:18:17 volumio volumio[909]: info: Ignoring MPD Status Update Apr 27 06:18:17 volumio volumio[909]: info: Apr 27 06:18:17 volumio volumio[909]: ---------------------------- MPD announces state update: player Apr 27 06:18:17 volumio volumio[909]: info: ControllerMpd::getState Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand status Apr 27 06:18:17 volumio volumio[909]: info: Apr 27 06:18:17 volumio volumio[909]: ---------------------------- MPD announces system playlist update Apr 27 06:18:17 volumio volumio[909]: info: Ignoring MPD Status Update Apr 27 06:18:17 volumio volumio[909]: info: Apr 27 06:18:17 volumio volumio[909]: ---------------------------- MPD announces state update: player Apr 27 06:18:17 volumio volumio[909]: info: ControllerMpd::getState Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand status Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 10ms Apr 27 06:18:17 volumio volumio[909]: info: sendMpdCommand status took 7 milliseconds Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 7ms Apr 27 06:18:17 volumio volumio[909]: info: sendMpdCommand status took 5 milliseconds Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::parseState Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::parseState Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 06:18:17 volumio volumio[909]: info: Apr 27 06:18:17 volumio volumio[909]: ---------------------------- MPD announces system playlist update Apr 27 06:18:17 volumio volumio[909]: info: Ignoring MPD Status Update Apr 27 06:18:17 volumio volumio[909]: info: Apr 27 06:18:17 volumio volumio[909]: ---------------------------- MPD announces state update: player Apr 27 06:18:17 volumio volumio[909]: info: ControllerMpd::getState Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand status Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 11ms Apr 27 06:18:17 volumio volumio[909]: info: sendMpdCommand status took 9 milliseconds Apr 27 06:18:17 volumio volumio[909]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 27 06:18:17 volumio volumio[909]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 6ms Apr 27 06:18:17 volumio volumio[909]: info: sendMpdCommand status took 4 milliseconds Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::parseState Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::parseTrackInfo Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::parseTrackInfo Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::parseState Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 06:18:17 volumio volumio[909]: info: ControllerMpd::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::servicePushState Apr 27 06:18:17 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:17 volumio volumio[909]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Calm Radio - This Channel is reserved for Premium Members - Upgrade to Premium","artist":"CALMRADIO.COM - Concertos","album":null,"uri":"http://streams.calmradio.com:9328/stream","trackType":""} Apr 27 06:18:17 volumio volumio[909]: verbose: CURRENT POSITION 0 Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::syncState stateService play Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play Apr 27 06:18:17 volumio volumio[909]: info: Received an update from plugin. extracting info from payload Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:17 volumio volumio[909]: info: ControllerMpd::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::servicePushState Apr 27 06:18:17 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:17 volumio volumio[909]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Calm Radio - This Channel is reserved for Premium Members - Upgrade to Premium","artist":"CALMRADIO.COM - Concertos","album":null,"uri":"http://streams.calmradio.com:9328/stream","trackType":""} Apr 27 06:18:17 volumio volumio[909]: verbose: CURRENT POSITION 0 Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::syncState stateService play Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play Apr 27 06:18:17 volumio volumio[909]: info: Received an update from plugin. extracting info from payload Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 72ms Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 69ms Apr 27 06:18:17 volumio volumio[909]: info: sendMpdCommand playlistinfo took 55 milliseconds Apr 27 06:18:17 volumio volumio[909]: info: sendMpdCommand playlistinfo took 53 milliseconds Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::parseTrackInfo Apr 27 06:18:17 volumio volumio[909]: verbose: ControllerMpd::parseTrackInfo Apr 27 06:18:17 volumio volumio[909]: info: ControllerMpd::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::servicePushState Apr 27 06:18:17 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:17 volumio volumio[909]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Calm Radio - This Channel is reserved for Premium Members - Upgrade to Premium","artist":"CALMRADIO.COM - Concertos","album":null,"uri":"http://streams.calmradio.com:9328/stream","trackType":""} Apr 27 06:18:17 volumio volumio[909]: verbose: CURRENT POSITION 0 Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::syncState stateService play Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play Apr 27 06:18:17 volumio volumio[909]: info: Received an update from plugin. extracting info from payload Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:17 volumio volumio[909]: info: ControllerMpd::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::servicePushState Apr 27 06:18:17 volumio volumio[909]: info: CorePlayQueue::getTrack 0 Apr 27 06:18:17 volumio volumio[909]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Calm Radio - This Channel is reserved for Premium Members - Upgrade to Premium","artist":"CALMRADIO.COM - Concertos","album":null,"uri":"http://streams.calmradio.com:9328/stream","trackType":""} Apr 27 06:18:17 volumio volumio[909]: verbose: CURRENT POSITION 0 Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::syncState stateService play Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::syncState currentStatus play Apr 27 06:18:17 volumio volumio[909]: info: Received an update from plugin. extracting info from payload Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:17 volumio volumio[909]: info: CoreStateMachine::pushState Apr 27 06:18:17 volumio volumio[909]: info: CoreCommandRouter::volumioPushState Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 123ms Apr 27 06:18:17 volumio volumio[909]: info: ------------------------------ 117ms Apr 27 06:18:19 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:19 volumio sudo[2399]: volumio : unable to resolve host volumio Apr 27 06:18:19 volumio sudo[2399]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:20 volumio sudo[2399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 06:18:20 volumio sudo[2399]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:18:20 volumio sudo[2399]: pam_unix(sudo:session): session closed for user root Apr 27 06:18:20 volumio sudo[2397]: volumio : unable to resolve host volumio Apr 27 06:18:20 volumio sudo[2397]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:20 volumio sudo[2397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 06:18:20 volumio sudo[2397]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:18:20 volumio sudo[2397]: pam_unix(sudo:session): session closed for user root Apr 27 06:18:20 volumio sudo[2403]: volumio : unable to resolve host volumio Apr 27 06:18:20 volumio sudo[2403]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:20 volumio sudo[2403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 06:18:20 volumio sudo[2403]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:18:20 volumio sudo[2403]: pam_unix(sudo:session): session closed for user root Apr 27 06:18:20 volumio sudo[2405]: volumio : unable to resolve host volumio Apr 27 06:18:20 volumio sudo[2405]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:20 volumio sudo[2405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 06:18:20 volumio sudo[2405]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 06:18:20 volumio sudo[2405]: pam_unix(sudo:session): session closed for user root Apr 27 06:18:20 volumio volumio[909]: verbose: New Socket.io Connection to 192.168.219.109 from 192.168.219.107 UA: Mozilla/5.0 (Linux; Android 12; SM-N976N Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.111 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::volumioGetQueue Apr 27 06:18:20 volumio volumio[909]: info: CoreStateMachine::getQueue Apr 27 06:18:20 volumio volumio[909]: info: CorePlayQueue::getQueue Apr 27 06:18:20 volumio volumio[909]: info: Listing playlists Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 06:18:20 volumio volumio[909]: info: Received Get System Info Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:20 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 06:18:20 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 27 06:18:21 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 06:18:21 volumio volumio[909]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 27 06:18:21 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 27 06:18:21 volumio volumio[909]: info: Received Get System Version Apr 27 06:18:21 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 06:18:21 volumio volumio[909]: info: Received Get System Info Apr 27 06:18:21 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:21 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:21 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:21 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:21 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:22 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 27 06:18:22 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 06:18:22 volumio volumio[909]: info: Received Get System Info Apr 27 06:18:22 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:22 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:22 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:22 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:22 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:23 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 06:18:23 volumio volumio[909]: info: Received Get System Info Apr 27 06:18:23 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:23 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:23 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:23 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:23 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:30 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 27 06:18:32 volumio volumio[909]: info: CoreCommandRouter::Close All Modals sent Apr 27 06:18:32 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Apr 27 06:18:33 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 27 06:18:33 volumio volumio[909]: info: CURURI: playlists Apr 27 06:18:33 volumio volumio[909]: info: Listing playlists Apr 27 06:18:33 volumio volumio[909]: info: Preload queue cleared Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:18:38 volumio volumio[909]: info: Retrieving Cloud Streaming UI Apr 27 06:18:38 volumio volumio[909]: info: Getting Tidal Cloud Configuration Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:18:38 volumio volumio[909]: info: Getting Qobuz Cloud Configuration Apr 27 06:18:38 volumio volumio[909]: info: Asking plugin for UI Config Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:18:38 volumio volumio[909]: info: Getting Spotify Cloud Configuration Apr 27 06:18:38 volumio volumio[909]: info: Asking plugin for UI Config Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:18:38 volumio volumio[909]: info: Saving Spotify Acccount Apr 27 06:18:38 volumio volumio[909]: info: Got Tidal Cloud Configuration Apr 27 06:18:38 volumio volumio[909]: info: Got it Apr 27 06:18:38 volumio volumio[909]: info: Got it Apr 27 06:18:38 volumio volumio[909]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 06:18:38 volumio volumio[909]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::volumioGetBrowseSources Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::volumioGetBrowseSources Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::volumioGetBrowseSources Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 27 06:18:38 volumio volumio[909]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 27 06:18:38 volumio volumio[909]: info: Received Get System Version Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 06:18:38 volumio volumio[909]: info: Received Get System Info Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 06:18:38 volumio volumio[909]: info: Discovery: Getting this device information Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::volumioGetState Apr 27 06:18:38 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 06:18:42 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 27 06:18:42 volumio volumio[909]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 27 06:18:42 volumio volumio[909]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 06:18:42 volumio volumio[909]: Error: getaddrinfo -3007 Apr 27 06:18:42 volumio volumio[909]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Apr 27 06:18:42 volumio volumio[909]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Apr 27 06:18:42 volumio volumio[909]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Apr 27 06:18:42 volumio volumio[909]: code: -3007, Apr 27 06:18:42 volumio volumio[909]: errno: -3007, Apr 27 06:18:42 volumio volumio[909]: syscall: 'getaddrinfo' Apr 27 06:18:42 volumio volumio[909]: } Apr 27 06:18:42 volumio volumio[909]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 06:18:42 volumio sudo[2454]: volumio : unable to resolve host volumio Apr 27 06:18:42 volumio sudo[2454]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 27 06:18:42 volumio sudo[2454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-27 06:17 Apr 27 06:18:42 volumio sudo[2454]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"