-- Logs begin at Thu 2019-02-14 17:12:00 +07, end at Thu 2024-07-18 19:29:59 +07. -- Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 18 19:28:50 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:50 volumio systemd[1]: Starting Daily apt download activities... Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:50 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 18 19:28:50 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 18 19:28:50 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 18 19:28:50 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 18 19:28:50 volumio volumio[944]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 18 19:28:50 volumio volumio[944]: info: Received Get System Version Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 18 19:28:50 volumio volumio[944]: info: Received Get System Info Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 19:28:50 volumio volumio[944]: info: Discovery: Getting this device information Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:28:50 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:50 volumio volumio[944]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 18 19:28:50 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 18 19:28:51 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:51 volumio systemd[1]: apt-daily.service: Succeeded. Jul 18 19:28:51 volumio systemd[1]: Started Daily apt download activities. Jul 18 19:28:51 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jul 18 19:28:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 18 19:28:51 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:51 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 18 19:28:51 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:51 volumio volumio[944]: info: MyVolumio token set successfully Jul 18 19:28:51 volumio volumio[944]: info: MYVOLUMIO: Adding device Jul 18 19:28:51 volumio volumio[944]: info: MYVOLUMIO: Evaluating Server Jul 18 19:28:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:51 volumio volumio[944]: info: Discovery: A device disappeared from network Jul 18 19:28:51 volumio volumio[944]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jul 18 19:28:51 volumio volumio[944]: info: Discovery: A device disappeared from network Jul 18 19:28:51 volumio volumio[944]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jul 18 19:28:51 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 18 19:28:51 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jul 18 19:28:52 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:52 volumio volumio[944]: info: MyVolumio status changed Jul 18 19:28:52 volumio volumio[944]: info: Streaming services startup Jul 18 19:28:52 volumio volumio[944]: info: Starting Streaming Daemon Jul 18 19:28:52 volumio volumio[944]: info: Removing browser output: myVolumio user plan is not superstar Jul 18 19:28:52 volumio volumio[944]: info: Removing audio output: Jul 18 19:28:52 volumio volumio[944]: info: Stoppping Tunnel 1 Jul 18 19:28:52 volumio sudo[1804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 18 19:28:52 volumio sudo[1804]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:52 volumio sudo[1806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 18 19:28:52 volumio sudo[1806]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:52 volumio sudo[1804]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:52 volumio sudo[1806]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 18 19:28:52 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:52 volumio volumio[944]: info: Remote SSH Stopped Jul 18 19:28:52 volumio volumio[944]: error: Cannot start Volumio Streaming Daemon Jul 18 19:28:52 volumio volumio[944]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 18 19:28:52 volumio volumio[944]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 18 19:28:52 volumio volumio[944]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jul 18 19:28:52 volumio volumio[944]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jul 18 19:28:52 volumio volumio[944]: info: Setting Geolocation for MyVolumio to as1 Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:52 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:52 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:52 volumio volumio[944]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 18 19:28:52 volumio volumio[944]: info: Preparing to save Alsa Options, stopping services first Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:28:52 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::volumioPause Jul 18 19:28:52 volumio volumio[944]: info: CoreStateMachine::pause Jul 18 19:28:52 volumio volumio[944]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"value":"hifiberry-dac","label":"HiFiBerry DAC"},"output_device":{"value":1,"label":"HiFiBerry DAC"},"disallowPush":true} Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:52 volumio volumio[944]: info: Enabling I2S DAC: HiFiBerry DAC Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Jul 18 19:28:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio sudo[1813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jul 18 19:28:53 volumio sudo[1813]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:53 volumio sudo[1813]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:53 volumio volumio[944]: info: No Overlays Loaded Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dac Jul 18 19:28:53 volumio sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Jul 18 19:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Jul 18 19:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Jul 18 19:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Jul 18 19:28:53 volumio sudo[1816]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:53 volumio volumio[944]: warn: Unable to locate the device HiFiBerry DAC a reboot may be required. Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio volumio[944]: Invalid card number. Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 18 19:28:53 volumio volumio[944]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 18 19:28:53 volumio volumio[944]: info: Disabling external Volume Control Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Jul 18 19:28:53 volumio volumio[944]: info: Preparing to generate the ALSA configuration file Jul 18 19:28:53 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:53 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jul 18 19:28:53 volumio sudo[1836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:53 volumio sudo[1836]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:53 volumio sudo[1838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 18 19:28:53 volumio sudo[1838]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:53 volumio sudo[1838]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:53 volumio volumio[944]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jul 18 19:28:53 volumio nmbd[765]: [2024/07/18 19:28:53.462888, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 18 19:28:53 volumio nmbd[765]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.3.68 for name WORKGROUP<1d>. Jul 18 19:28:53 volumio nmbd[765]: This response was from IP 192.168.3.253, reporting an IP address of 192.168.3.253. Jul 18 19:28:53 volumio nmbd[765]: [2024/07/18 19:28:53.463462, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 18 19:28:53 volumio nmbd[765]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.3.68 for name WORKGROUP<1d>. Jul 18 19:28:53 volumio nmbd[765]: This response was from IP 192.168.3.253, reporting an IP address of 192.168.3.253. Jul 18 19:28:53 volumio volumio[944]: info: I2S Param [object Object] successfully enabled Jul 18 19:28:53 volumio volumio[944]: info: Updating MyVolumio device info Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: VolumeController:: Volume=undefined Mute =false Jul 18 19:28:53 volumio volumio[944]: info: CoreStateMachine::pushState Jul 18 19:28:53 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::volumioPushState Jul 18 19:28:53 volumio volumio[944]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 18 19:28:53 volumio volumio[944]: wlan0 Interface doesn't support scanning : Device or resource busy Jul 18 19:28:53 volumio volumio[944]: info: Cannot use regular scanning, forcing with ap-force Jul 18 19:28:53 volumio sudo[1846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 18 19:28:53 volumio sudo[1846]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:53 volumio sudo[1846]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:53 volumio volumio[944]: command failed: Device or resource busy (-16) Jul 18 19:28:53 volumio volumio[944]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 18 19:28:53 volumio volumio[944]: command failed: Device or resource busy (-16) Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 18 19:28:53 volumio volumio[944]: info: Getting Alsa Cards List without I2S DAC Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:53 volumio volumio[944]: Invalid card number. Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 18 19:28:53 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:53 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:53 volumio volumio[944]: info: Asound.conf file written Jul 18 19:28:53 volumio sudo[1857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 18 19:28:53 volumio sudo[1857]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:53 volumio sudo[1857]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:53 volumio volumio[944]: No state is present for card b1 Jul 18 19:28:53 volumio volumio[944]: /usr/share/alsa/init/bcm2835:14: control element not found Jul 18 19:28:53 volumio volumio[944]: No state is present for card b1 Jul 18 19:28:53 volumio volumio[944]: No state is present for card Headphones Jul 18 19:28:53 volumio volumio[944]: /usr/share/alsa/init/bcm2835:20: control element not found Jul 18 19:28:53 volumio volumio[944]: No state is present for card Headphones Jul 18 19:28:53 volumio volumio[944]: info: Output device has changed, restarting MPD Jul 18 19:28:54 volumio sudo[1862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 18 19:28:54 volumio volumio[944]: info: Output device has changed, restarting Shairport Sync Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:54 volumio sudo[1862]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:54 volumio sudo[1862]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:54 volumio sudo[1864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 18 19:28:54 volumio sudo[1864]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:54 volumio systemd[1]: Stopping Music Player Daemon... Jul 18 19:28:54 volumio volumio[944]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 18 19:28:54 volumio volumio[944]: info: Output device has changed, restarting MPD Jul 18 19:28:54 volumio volumio[944]: info: Output device has changed, restarting Shairport Sync Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:54 volumio sudo[1871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 18 19:28:54 volumio sudo[1871]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:54 volumio sudo[1871]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:54 volumio sudo[1873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 18 19:28:54 volumio sudo[1873]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:54 volumio volumio[944]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:54 volumio systemd[1]: mpd.service: Succeeded. Jul 18 19:28:54 volumio systemd[1]: Stopped Music Player Daemon. Jul 18 19:28:54 volumio volumio[944]: info: MPD Permissions set Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio systemd[1]: Starting Music Player Daemon... Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:28:54 volumio volumio[944]: info: Starting Shairport Sync Jul 18 19:28:54 volumio volumio[944]: info: Starting Shairport Sync Jul 18 19:28:54 volumio sudo[1836]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:54 volumio sudo[1889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 18 19:28:54 volumio sudo[1889]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:54 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:54 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 18 19:28:54 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 18 19:28:54 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 18 19:28:54 volumio sudo[1892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 18 19:28:54 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 18 19:28:54 volumio sudo[1892]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:54 volumio sudo[1879]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 18 19:28:54 volumio sudo[1879]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:28:54 volumio sudo[1879]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:54 volumio sudo[1889]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:54 volumio volumio[944]: info: Shairport-Sync Started Jul 18 19:28:54 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 18 19:28:54 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 18 19:28:54 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 18 19:28:54 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 18 19:28:54 volumio sudo[1892]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:54 volumio volumio[944]: info: Shairport-Sync Started Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:54 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:54 volumio volumio[944]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 18 19:28:54 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:55 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:55 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:55 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:28:55 volumio mpd[1896]: Jul 18 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 18 19:28:55 volumio systemd[1]: Started Music Player Daemon. Jul 18 19:28:55 volumio sudo[1873]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:55 volumio sudo[1864]: pam_unix(sudo:session): session closed for user root Jul 18 19:28:55 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:55 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:55 volumio volumio[944]: error: MPD error: The expression evaluated to a falsy value: Jul 18 19:28:55 volumio volumio[944]: assert.ok(self.idling) Jul 18 19:28:55 volumio volumio[944]: error: The expression evaluated to a falsy value: Jul 18 19:28:55 volumio volumio[944]: assert.ok(self.idling) Jul 18 19:28:55 volumio volumio[944]: error: updateQueue error: null Jul 18 19:28:56 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:56 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:56 volumio volumio[944]: info: MYVOLUMIO: Adding device Jul 18 19:28:56 volumio volumio[944]: info: MYVOLUMIO: Evaluating Server Jul 18 19:28:57 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:57 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:57 volumio volumio[944]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 18 19:28:57 volumio volumio[944]: info: CoreStateMachine::getcurrentVolume Jul 18 19:28:57 volumio volumio[944]: info: CoreCommandRouter::volumioRetrievevolume Jul 18 19:28:57 volumio volumio[944]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jul 18 19:28:57 volumio volumio[944]: info: VolumeController:: Volume=undefined Mute =false Jul 18 19:28:57 volumio volumio[944]: info: CoreStateMachine::pushState Jul 18 19:28:57 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:28:57 volumio volumio[944]: info: CoreCommandRouter::volumioPushState Jul 18 19:28:57 volumio volumio[944]: info: CoreStateMachine::updateTrackBlock Jul 18 19:28:57 volumio volumio[944]: info: CorePlayQueue::getTrackBlock Jul 18 19:28:57 volumio volumio[944]: info: CoreCommandRouter::volumioRetrievevolume Jul 18 19:28:57 volumio volumio[944]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jul 18 19:28:57 volumio volumio[944]: info: VolumeController:: Volume=undefined Mute =false Jul 18 19:28:57 volumio volumio[944]: info: CoreStateMachine::pushState Jul 18 19:28:57 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:28:57 volumio volumio[944]: info: CoreCommandRouter::volumioPushState Jul 18 19:28:57 volumio volumio[944]: info: Setting Geolocation for MyVolumio to as1 Jul 18 19:28:57 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:57 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:57 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:57 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:58 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:58 volumio volumio[944]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 18 19:28:58 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:58 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:58 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:58 volumio volumio[944]: info: Updating MyVolumio device info Jul 18 19:28:58 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:58 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:58 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 19:28:59 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:59 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:59 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:59 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:59 volumio volumio[944]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 18 19:28:59 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:59 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:28:59 volumio volumio[944]: info: MyVolumio login type: Token Jul 18 19:29:03 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jul 18 19:29:03 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 18 19:29:03 volumio volumio-remote-updater[611]: No test mode Jul 18 19:29:03 volumio volumio-remote-updater[611]: No alpha test mode Jul 18 19:29:03 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 18 19:29:04 volumio volumio[944]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 18 19:29:04 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 18 19:29:04 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jul 18 19:29:04 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 18 19:29:04 volumio systemd[1]: systemd-timedated.service: Succeeded. Jul 18 19:29:04 volumio volumio-remote-updater[611]: No test mode Jul 18 19:29:04 volumio volumio-remote-updater[611]: No alpha test mode Jul 18 19:29:04 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 18 19:29:05 volumio volumio[944]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 18 19:29:05 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 18 19:29:06 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork Jul 18 19:29:06 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo Jul 18 19:29:07 volumio sudo[1927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 18 19:29:07 volumio sudo[1927]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:07 volumio sudo[1927]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:07 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Jul 18 19:29:07 volumio volumio[944]: info: Saving new wireless network Jul 18 19:29:07 volumio sudo[1930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Jul 18 19:29:07 volumio sudo[1930]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:07 volumio sudo[1930]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:07 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jul 18 19:29:07 volumio volumio[944]: info: Discovery: Restarting Advertising due to device name change Jul 18 19:29:07 volumio sudo[1933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jul 18 19:29:07 volumio sudo[1933]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:07 volumio systemd[1]: Starting Wireless Services... Jul 18 19:29:07 volumio wireless.js[1935]: Cleaning previous... Jul 18 19:29:07 volumio systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 18 19:29:08 volumio volumio[944]: info: Discovery: A device disappeared from network Jul 18 19:29:08 volumio volumio[944]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jul 18 19:29:08 volumio volumio[944]: info: Discovery: A device disappeared from network Jul 18 19:29:08 volumio volumio[944]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jul 18 19:29:08 volumio systemd[1]: hostapd.service: Succeeded. Jul 18 19:29:08 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 18 19:29:08 volumio sudo[1949]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 18 19:29:08 volumio sudo[1949]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:08 volumio avahi-daemon[649]: Withdrawing address record for 192.168.211.1 on wlan0. Jul 18 19:29:08 volumio avahi-daemon[649]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jul 18 19:29:08 volumio avahi-daemon[649]: Interface wlan0.IPv4 no longer relevant for mDNS. Jul 18 19:29:08 volumio sudo[1949]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:08 volumio sudo[1951]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 18 19:29:08 volumio sudo[1951]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:08 volumio sudo[1951]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:09 volumio wireless.js[1935]: Stopped aP Jul 18 19:29:09 volumio sudo[1958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 18 19:29:09 volumio sudo[1958]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:09 volumio sudo[1958]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:09 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 18 19:29:09 volumio sudo[1960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jul 18 19:29:09 volumio sudo[1960]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:09 volumio sudo[1960]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:09 volumio sudo[1967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 18 19:29:09 volumio sudo[1967]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:09 volumio sudo[1967]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:09 volumio sudo[1969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jul 18 19:29:09 volumio sudo[1969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:09 volumio sudo[1969]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:09 volumio wireless.js[1935]: SETTING APPROPRIATE REG DOMAIN: TH Jul 18 19:29:09 volumio sudo[1974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 18 19:29:09 volumio sudo[1974]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:09 volumio sudo[1974]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:09 volumio sudo[1976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set TH Jul 18 19:29:09 volumio sudo[1976]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:09 volumio sudo[1976]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:09 volumio wireless.js[1935]: SUCCESSFULLY SET NEW REGDOMAIN: TH Jul 18 19:29:09 volumio wireless.js[1935]: Start wireless flow Jul 18 19:29:09 volumio wireless.js[1935]: Stopped hotspot (if there).. Jul 18 19:29:09 volumio sudo[1981]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 18 19:29:09 volumio sudo[1981]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:09 volumio sudo[1981]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:09 volumio sudo[1983]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 18 19:29:09 volumio sudo[1983]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:10 volumio sudo[1983]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:10 volumio wireless.js[1935]: DHCP IP Jul 18 19:29:10 volumio wireless.js[1935]: Start ap Jul 18 19:29:10 volumio wpa_supplicant[1985]: Successfully initialized wpa_supplicant Jul 18 19:29:10 volumio sudo[1986]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jul 18 19:29:10 volumio sudo[1986]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:10 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 18 19:29:10 volumio dhcpcd[1987]: dev: loaded udev Jul 18 19:29:10 volumio dhcpcd-run-hooks[1996]: wlan0: starting wpa_supplicant Jul 18 19:29:10 volumio dhcpcd-run-hooks[2001]: wlan0: failed to start wpa_supplicant Jul 18 19:29:10 volumio dhcpcd-run-hooks[2002]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Jul 18 19:29:10 volumio dhcpcd[1987]: wlan0: connected to Access Point `' Jul 18 19:29:10 volumio dhcpcd[1987]: DUID 00:01:00:01:2d:f2:1d:9a:b8:27:eb:3b:2e:4d Jul 18 19:29:10 volumio dhcpcd[1987]: eth0: IAID eb:3b:2e:4d Jul 18 19:29:10 volumio dhcpcd[1987]: eth0: adding address fe80::7c65:d3ee:2acd:4bc Jul 18 19:29:10 volumio dhcpcd[1987]: ipv6_addaddr1: Permission denied Jul 18 19:29:10 volumio dhcpcd[1987]: wlan0: waiting for carrier Jul 18 19:29:11 volumio dhcpcd[1987]: eth0: soliciting a DHCP lease Jul 18 19:29:11 volumio dhcpcd[1987]: eth0: offered 192.168.3.68 from 192.168.3.1 Jul 18 19:29:11 volumio dhcpcd[1987]: eth0: leased 192.168.3.68 for 86400 seconds Jul 18 19:29:11 volumio dhcpcd[1987]: eth0: adding route to 192.168.3.0/24 Jul 18 19:29:11 volumio dhcpcd[1987]: eth0: adding default route via 192.168.3.1 Jul 18 19:29:11 volumio dhcpcd[1987]: eth0: dhcp_envoption 213: Operation not supported Jul 18 19:29:11 volumio dhcpcd[1987]: eth0: dhcp_envoption 213: Operation not supported Jul 18 19:29:11 volumio wpa_supplicant[2000]: wlan0: Trying to associate with SSID 'SummerHome' Jul 18 19:29:11 volumio dhcpcd[1987]: forked to background, child pid 2039 Jul 18 19:29:11 volumio sudo[1986]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:11 volumio wireless.js[1935]: trying... Jul 18 19:29:11 volumio sudo[2041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 18 19:29:11 volumio sudo[2041]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:11 volumio sudo[2041]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:11 volumio dhcpcd[2039]: eth0: soliciting an IPv6 router Jul 18 19:29:11 volumio dhcpcd[2039]: wlan0: carrier acquired Jul 18 19:29:11 volumio dhcpcd[2039]: wlan0: connected to Access Point `SummerHome' Jul 18 19:29:11 volumio wpa_supplicant[2000]: wlan0: Associated with 60:aa:ef:85:a1:68 Jul 18 19:29:11 volumio wpa_supplicant[2000]: wlan0: CTRL-EVENT-CONNECTED - Connection to 60:aa:ef:85:a1:68 completed [id=0 id_str=] Jul 18 19:29:11 volumio wpa_supplicant[2000]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jul 18 19:29:11 volumio dhcpcd[2039]: wlan0: IAID eb:6e:7b:18 Jul 18 19:29:11 volumio dhcpcd[2039]: wlan0: adding address fe80::28ea:de0e:1532:6bf2 Jul 18 19:29:11 volumio dhcpcd[2039]: ipv6_addaddr1: Permission denied Jul 18 19:29:11 volumio dhcpcd[2039]: wlan0: carrier lost Jul 18 19:29:12 volumio dhcpcd[2039]: wlan0: carrier acquired Jul 18 19:29:12 volumio dhcpcd[2039]: wlan0: IAID eb:6e:7b:18 Jul 18 19:29:12 volumio volumio[944]: info: Discovery: Started advertising with name: Volumio Jul 18 19:29:12 volumio wireless.js[1935]: trying... Jul 18 19:29:12 volumio sudo[2064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 18 19:29:12 volumio sudo[2064]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:12 volumio sudo[2064]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:12 volumio dhcpcd[2039]: wlan0: soliciting a DHCP lease Jul 18 19:29:12 volumio dhcpcd[2039]: wlan0: soliciting an IPv6 router Jul 18 19:29:12 volumio dhcpcd[2039]: wlan0: offered 192.168.3.250 from 192.168.3.1 Jul 18 19:29:12 volumio dhcpcd[2039]: wlan0: probing address 192.168.3.250/24 Jul 18 19:29:13 volumio volumio[944]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jul 18 19:29:13 volumio wireless.js[1935]: trying... Jul 18 19:29:13 volumio sudo[2068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 18 19:29:13 volumio sudo[2068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:13 volumio sudo[2068]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:13 volumio ntpd[794]: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=93 secs Jul 18 19:29:14 volumio wireless.js[1935]: trying... Jul 18 19:29:14 volumio sudo[2071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 18 19:29:14 volumio sudo[2071]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:14 volumio sudo[2071]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:15 volumio wireless.js[1935]: trying... Jul 18 19:29:15 volumio sudo[2074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 18 19:29:15 volumio sudo[2074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:15 volumio sudo[2074]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:16 volumio wireless.js[1935]: trying... Jul 18 19:29:16 volumio sudo[2077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 18 19:29:16 volumio sudo[2077]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:16 volumio sudo[2077]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:17 volumio wireless.js[1935]: trying... Jul 18 19:29:17 volumio sudo[2080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 18 19:29:17 volumio sudo[2080]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:17 volumio sudo[2080]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:17 volumio dhcpcd[2039]: wlan0: leased 192.168.3.250 for 86400 seconds Jul 18 19:29:17 volumio avahi-daemon[649]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.250. Jul 18 19:29:17 volumio avahi-daemon[649]: New relevant interface wlan0.IPv4 for mDNS. Jul 18 19:29:17 volumio dhcpcd[2039]: wlan0: adding route to 192.168.3.0/24 Jul 18 19:29:17 volumio avahi-daemon[649]: Registering new address record for 192.168.3.250 on wlan0.IPv4. Jul 18 19:29:17 volumio dhcpcd[2039]: wlan0: adding default route via 192.168.3.1 Jul 18 19:29:17 volumio dhcpcd[2039]: wlan0: dhcp_envoption 213: Operation not supported Jul 18 19:29:17 volumio dnsmasq[905]: reading /etc/resolv.conf Jul 18 19:29:17 volumio dnsmasq[905]: using nameserver 192.168.3.1#53 Jul 18 19:29:17 volumio dnsmasq[905]: using nameserver 208.67.222.222#53 Jul 18 19:29:17 volumio dnsmasq[905]: using nameserver 208.67.220.220#53 Jul 18 19:29:18 volumio wireless.js[1935]: trying... Jul 18 19:29:18 volumio sudo[2104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 18 19:29:18 volumio sudo[2104]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:18 volumio sudo[2104]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:18 volumio wireless.js[1935]: Connected to: ----SummerHome Jul 18 19:29:18 volumio wireless.js[1935]: ---- Jul 18 19:29:18 volumio sudo[2107]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 18 19:29:18 volumio sudo[2107]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:18 volumio sudo[2107]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:18 volumio wireless.js[1935]: ... joined AP, wlan0 IPv4 is 192.168.3.250, ipV6 is undefined Jul 18 19:29:18 volumio wireless.js[1935]: It's done! AP Jul 18 19:29:18 volumio systemd[1]: Started Wireless Services. Jul 18 19:29:18 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 18 19:29:18 volumio sudo[1933]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:18 volumio volumio[944]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jul 18 19:29:18 volumio ntpd[794]: Listen normally on 5 wlan0 192.168.3.250:123 Jul 18 19:29:18 volumio ntpd[794]: new interface(s) found: waking up resolver Jul 18 19:29:23 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Jul 18 19:29:23 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Jul 18 19:29:23 volumio sudo[2113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 18 19:29:23 volumio sudo[2113]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:23 volumio sudo[2113]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:23 volumio sudo[2116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 18 19:29:23 volumio sudo[2116]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:23 volumio sudo[2116]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:25 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:25 volumio volumio[944]: info: Retrieving Cloud Streaming UI Jul 18 19:29:25 volumio volumio[944]: info: Getting Tidal Cloud Configuration Jul 18 19:29:25 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:25 volumio volumio[944]: info: Getting Qobuz Cloud Configuration Jul 18 19:29:25 volumio volumio[944]: info: Asking plugin for UI Config Jul 18 19:29:25 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:25 volumio volumio[944]: info: Getting Spotify Cloud Configuration Jul 18 19:29:25 volumio volumio[944]: info: Asking plugin for UI Config Jul 18 19:29:25 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:25 volumio volumio[944]: info: Saving Spotify Acccount Jul 18 19:29:25 volumio volumio[944]: info: Got Tidal Cloud Configuration Jul 18 19:29:25 volumio volumio[944]: info: Got it Jul 18 19:29:25 volumio volumio[944]: info: Got it Jul 18 19:29:25 volumio volumio[944]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 18 19:29:25 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:25 volumio volumio[944]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 18 19:29:27 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Jul 18 19:29:27 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jul 18 19:29:27 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Jul 18 19:29:27 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Jul 18 19:29:27 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jul 18 19:29:28 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Jul 18 19:29:28 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Jul 18 19:29:28 volumio volumio[944]: info: Refreshing Cached IP Addresses Jul 18 19:29:28 volumio sudo[2128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jul 18 19:29:28 volumio sudo[2128]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:28 volumio sudo[2130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 18 19:29:28 volumio sudo[2130]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:28 volumio sudo[2130]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:28 volumio sudo[2128]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:28 volumio sudo[2133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 18 19:29:28 volumio systemd[1]: upmpdcli.service: Succeeded. Jul 18 19:29:28 volumio sudo[2133]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:28 volumio sudo[2133]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:31 volumio volumio[944]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jul 18 19:29:31 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jul 18 19:29:31 volumio volumio[944]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined Jul 18 19:29:31 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Jul 18 19:29:31 volumio volumio[944]: info: CoreCommandRouter::Reload Ui Jul 18 19:29:31 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Jul 18 19:29:31 volumio volumio[944]: info: Wizard terminated Successfully Jul 18 19:29:31 volumio volumio[944]: info: CoreCommandRouter::volumiosetStartupVolume Jul 18 19:29:31 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 19:29:31 volumio volumio[944]: info: Player Reboot required after I2S DAC has been enabled in wizard Jul 18 19:29:32 volumio sudo[2139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 18 19:29:32 volumio sudo[2139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:32 volumio sudo[2139]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:32 volumio sudo[2141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 18 19:29:32 volumio sudo[2141]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:32 volumio sudo[2141]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:32 volumio volumio[944]: verbose: New Socket.io Connection to 192.168.3.68 from 192.168.3.117 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::volumioGetVisibleSources Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:32 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 18 19:29:32 volumio volumio[944]: info: Received Get System Info Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 19:29:32 volumio volumio[944]: info: Discovery: Getting this device information Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:32 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:32 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:32 volumio volumio[944]: info: Listing playlists Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 18 19:29:32 volumio sudo[2145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 18 19:29:32 volumio sudo[2145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:32 volumio sudo[2145]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:32 volumio sudo[2147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 18 19:29:32 volumio sudo[2147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:32 volumio sudo[2147]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:32 volumio volumio[944]: verbose: New Socket.io Connection to 192.168.3.68 from 192.168.3.117 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::volumioGetVisibleSources Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:32 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:32 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 18 19:29:33 volumio volumio[944]: info: Received Get System Info Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 19:29:33 volumio volumio[944]: info: Discovery: Getting this device information Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:33 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:33 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:33 volumio volumio[944]: info: Listing playlists Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 18 19:29:33 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 18 19:29:34 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 18 19:29:34 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:29:34 volumio volumio[944]: info: Received Get System Info Jul 18 19:29:34 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 19:29:34 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 19:29:34 volumio volumio[944]: info: Discovery: Getting this device information Jul 18 19:29:34 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:34 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:34 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 19:29:36 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 18 19:29:36 volumio volumio[944]: info: Received Get System Info Jul 18 19:29:36 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 19:29:36 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 19:29:36 volumio volumio[944]: info: Discovery: Getting this device information Jul 18 19:29:36 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:36 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:36 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 19:29:38 volumio sudo[2192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 18 19:29:38 volumio sudo[2192]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:38 volumio sudo[2192]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:38 volumio sudo[2194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 18 19:29:38 volumio sudo[2194]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:38 volumio sudo[2194]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:38 volumio sudo[2198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 18 19:29:38 volumio sudo[2198]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 19:29:38 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 18 19:29:38 volumio sudo[2198]: pam_unix(sudo:session): session closed for user root Jul 18 19:29:38 volumio volumio[944]: info: Upmpdcli Daemon Started Jul 18 19:29:38 volumio volumio[2200]: writing RSA key Jul 18 19:29:42 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 18 19:29:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 18 19:29:51 volumio volumio[944]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 18 19:29:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 18 19:29:51 volumio volumio[944]: info: Received Get System Version Jul 18 19:29:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 18 19:29:51 volumio volumio[944]: info: Received Get System Info Jul 18 19:29:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 19:29:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 19:29:51 volumio volumio[944]: info: Discovery: Getting this device information Jul 18 19:29:51 volumio volumio[944]: info: CoreCommandRouter::volumioGetState Jul 18 19:29:51 volumio volumio[944]: info: CorePlayQueue::getTrack 0 Jul 18 19:29:51 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 19:29:51 volumio ntpd[794]: Soliciting pool server 2001:c38:2000:180:d82a:1aff:fe38:f84b Jul 18 19:29:52 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:54 volumio volumio[944]: info: Retrieving Cloud Streaming UI Jul 18 19:29:54 volumio volumio[944]: info: Getting Tidal Cloud Configuration Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:54 volumio volumio[944]: info: Getting Qobuz Cloud Configuration Jul 18 19:29:54 volumio volumio[944]: info: Asking plugin for UI Config Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:54 volumio volumio[944]: info: Getting Spotify Cloud Configuration Jul 18 19:29:54 volumio volumio[944]: info: Asking plugin for UI Config Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:54 volumio volumio[944]: info: Saving Spotify Acccount Jul 18 19:29:54 volumio volumio[944]: info: Got Tidal Cloud Configuration Jul 18 19:29:54 volumio volumio[944]: info: Got it Jul 18 19:29:54 volumio volumio[944]: info: Got it Jul 18 19:29:54 volumio volumio[944]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 19:29:54 volumio volumio[944]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::volumioGetBrowseSources Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::volumioGetBrowseSources Jul 18 19:29:54 volumio volumio[944]: info: CoreCommandRouter::volumioGetBrowseSources Jul 18 19:29:55 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 18 19:29:55 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 18 19:29:58 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 18 19:29:58 volumio volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 18 19:29:58 volumio volumio[944]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 19:29:58 volumio volumio[944]: Error: getaddrinfo -3007 Jul 18 19:29:58 volumio volumio[944]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Jul 18 19:29:58 volumio volumio[944]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Jul 18 19:29:58 volumio volumio[944]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Jul 18 19:29:58 volumio volumio[944]: code: -3007, Jul 18 19:29:58 volumio volumio[944]: errno: -3007, Jul 18 19:29:58 volumio volumio[944]: syscall: 'getaddrinfo' Jul 18 19:29:58 volumio volumio[944]: } Jul 18 19:29:58 volumio volumio[944]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 19:29:59 volumio sudo[2260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-18 19:28 Jul 18 19:29:59 volumio sudo[2260]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"