search

home-assistant / supervisor

:house_with_garden: Home Assistant Supervisor
https://home-assistant.io/hassio/
Apache License 2.0
1.76k stars 641 forks source link

Add-ons missing - Official and 3rd party #2955

Closed jspanitz closed 3 years ago

jspanitz commented 3 years ago

Describe the issue you are experiencing

Addons from the official store and from 3rd parties hosted on github.com disappeared. This occurs under 5.11, 5.12 and now 6.x. This was a clean install around 3 months ago on a RP4. Supervisor complains it can find guthub.com. Dropping to the CLI and doing an nslookup or ping of github.com fails. Other random sites seem to complete successfully. Added static entries to the docker container via CLI, name resolution then succeeds. Still can't add official store or 3rd part stores, supervisor still complains. A complete system shutdown and restart of the OS occasionally brings back official store. Official store will occasionally come back but then disappear again after 24 ~48 hours. Upgraded to OS 6.x and so far official store has stayed visible for over 24 hours but still can't add 3rd part stores back.

What is the used version of the Supervisor?

supervisor-2021.06.0

What type of installation are you running?

Home Assistant OS

Which operating system are you running on?

Home Assistant Operating System

What is the version of your installed operating system?

Home Assistant OS 6.0

What version of Home Assistant Core is installed?

core-2021.6.3

Steps to reproduce the issue

  1. Open Add-Ons panel is HA. Wait for store to disappear.

Anything in the Supervisor logs that might be useful for us?

Same issue noted here - but bug was closed before resolution - https://github.com/home-assistant/supervisor/issues/2774

Problem still exists after update to OS 6.0 - Official add-ons are present for now, other add-ons still missing and can not be added - ex: adding https://github.com/home-assistant/addons results in log file below

21-06-11 20:43:55 INFO (MainThread) [supervisor.core] Start Home Assistant Core
21-06-11 20:43:55 INFO (SyncWorker_5) [supervisor.docker.interface] Starting homeassistant
21-06-11 20:43:56 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready
21-06-11 20:44:12 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.STARTUP
21-06-11 20:44:12 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-06-11 20:44:17 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
21-06-11 20:44:35 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance
21-06-11 20:44:35 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.APPLICATION' starting 2 add-ons
21-06-11 20:44:37 INFO (SyncWorker_5) [supervisor.docker.addon] Starting Docker add-on homeassistant/aarch64-addon-almond with version 1.1.2
21-06-11 20:44:39 INFO (SyncWorker_1) [supervisor.docker.addon] Starting Docker add-on homeassistant/aarch64-addon-configurator with version 5.3.1
21-06-11 20:44:44 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled
21-06-11 20:44:44 INFO (MainThread) [supervisor.core] Supervisor is up and running
21-06-11 20:44:44 INFO (MainThread) [supervisor.host.info] Updating local host information
21-06-11 20:44:44 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json
21-06-11 20:44:44 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING
21-06-11 20:44:44 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE
21-06-11 20:44:44 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON
21-06-11 20:44:44 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM
21-06-11 20:44:44 INFO (MainThread) [supervisor.resolution.check] System checks complete
21-06-11 20:44:44 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
21-06-11 20:44:45 INFO (MainThread) [supervisor.host.services] Updating service information
21-06-11 20:44:45 INFO (MainThread) [supervisor.host.network] Updating local network information
21-06-11 20:44:49 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request initialize
21-06-11 20:44:49 INFO (MainThread) [supervisor.api.proxy] WebSocket access from core_almond
21-06-11 20:44:49 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request running
21-06-11 20:44:49 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
21-06-11 20:44:49 INFO (MainThread) [supervisor.host] Host information reload completed
21-06-11 20:44:50 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-06-11 20:44:50 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
21-06-11 20:44:50 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete
21-06-11 20:45:44 INFO (MainThread) [supervisor.snapshots] Found 9 snapshot files
21-06-11 20:45:44 INFO (MainThread) [supervisor.snapshots] Found 9 snapshot files
21-06-11 20:46:30 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/home-assistant/addons repository
21-06-11 20:46:36 ERROR (MainThread) [supervisor.store.git] Can't clone https://github.com/home-assistant/addons repository: Cmd('git') failed due to: exit code(128)
  cmdline: git clone -v --recursive --depth=1 --shallow-submodules https://github.com/home-assistant/addons /data/addons/git/96a017aa
  stderr: 'Cloning into '/data/addons/git/96a017aa'...
fatal: unable to access 'https://github.com/home-assistant/addons/': Could not resolve host: github.com
'.
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.module] Create new issue IssueType.FATAL_ERROR - ContextType.STORE / 96a017aa
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.EXECUTE_REMOVE - ContextType.STORE / 96a017aa
21-06-11 20:46:36 ERROR (MainThread) [supervisor.store] Can't load data from repository https://github.com/home-assistant/addons
21-06-11 20:46:36 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.fixups.store_execute_remove] Remove invalid Store: 96a017aa
21-06-11 20:46:36 INFO (MainThread) [supervisor.store.git] Removing custom add-on repository https://github.com/home-assistant/addons
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.check] System checks complete
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
21-06-11 20:46:36 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete

Can't ping github.com or www.github.com
![image](https://user-images.githubusercontent.com/51183445/121781771-4b020300-cb74-11eb-96d6-c9fedbeb7309.png)

Manually added entries fixes name resolution issue
![image](https://user-images.githubusercontent.com/51183445/121781697-0a09ee80-cb74-11eb-9a7d-b8bff40015fc.png)

![image](https://user-images.githubusercontent.com/51183445/121781710-15f5b080-cb74-11eb-9f01-a7ec28e4af59.png)

Same ping / lookup to google.com works just find with no entries added:
![image](https://user-images.githubusercontent.com/51183445/121781722-1e4deb80-cb74-11eb-9609-0065e6f90dae.png)

Trying to add repo after still fails but doesn't show in logs.  Refresh repos shows:
21-06-11 21:01:35 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/home-assistant/addons repository
21-06-11 21:01:40 ERROR (MainThread) [supervisor.store.git] Can't update https://github.com/home-assistant/addons repo: Cmd('git') failed due to: exit code(128)
  cmdline: git fetch -v --update-shallow --depth=1 origin
  stderr: 'fatal: unable to access 'https://github.com/home-assistant/addons/': Could not resolve host: github.com'.
21-06-11 21:01:40 INFO (MainThread) [supervisor.resolution.module] Create new issue IssueType.CORRUPT_REPOSITORY - ContextType.STORE / core
21-06-11 21:01:40 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.EXECUTE_RESET - ContextType.STORE / core
21-06-11 21:01:40 ERROR (MainThread) [asyncio] Task exception was never retrieved
future: <Task finished name='Task-1871' coro=<Repository.update() done, defined at /usr/src/supervisor/supervisor/store/repository.py:106> exception=StoreGitError()>
Traceback (most recent call last):
  File "/usr/src/supervisor/supervisor/store/git.py", line 155, in pull
    await self.sys_run_in_executor(
  File "/usr/local/lib/python3.9/concurrent/futures/thread.py", line 52, in run
    result = self.fn(*self.args, **self.kwargs)
  File "/usr/local/lib/python3.9/site-packages/git/remote.py", line 828, in fetch
    res = self._get_fetch_info_from_stderr(proc, progress)
  File "/usr/local/lib/python3.9/site-packages/git/remote.py", line 702, in _get_fetch_info_from_stderr
    proc.wait(stderr=stderr_text)
  File "/usr/local/lib/python3.9/site-packages/git/cmd.py", line 450, in wait
    raise GitCommandError(remove_password_if_present(self.args), status, errstr)
git.exc.GitCommandError: Cmd('git') failed due to: exit code(128)
  cmdline: git fetch -v --update-shallow --depth=1 origin
  stderr: 'fatal: unable to access 'https://github.com/home-assistant/addons/': Could not resolve host: github.com'
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
  File "/usr/src/supervisor/supervisor/store/repository.py", line 110, in update
    await self.git.pull()
  File "/usr/src/supervisor/supervisor/jobs/decorator.py", line 107, in wrapper
    raise err
  File "/usr/src/supervisor/supervisor/jobs/decorator.py", line 105, in wrapper
    return await self._method(*args, **kwargs)
  File "/usr/src/supervisor/supervisor/store/git.py", line 195, in pull
    raise StoreGitError() from err
supervisor.exceptions.StoreGitError
21-06-11 21:01:40 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove
21-06-11 21:01:40 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove
21-06-11 21:04:53 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/home-assistant/addons repository
21-06-11 21:04:57 ERROR (MainThread) [supervisor.store] https://github.com/home-assistant/addons is not a valid add-on repository
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.module] Create new issue IssueType.CORRUPT_REPOSITORY - ContextType.STORE / 96a017aa
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.EXECUTE_REMOVE - ContextType.STORE / 96a017aa
21-06-11 21:04:57 WARNING (MainThread) [supervisor.store.data] No repository information exists at /data/addons/git/96a017aa
21-06-11 21:04:57 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.fixups.store_execute_remove] Remove invalid Store: 96a017aa
21-06-11 21:04:57 INFO (MainThread) [supervisor.store.git] Removing custom add-on repository https://github.com/home-assistant/addons
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.check] System checks complete
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
21-06-11 21:04:57 INFO (MainThread) [supervisor.resolution.fixups.store_execute_reset] Reset corrupt Store: core
21-06-11 21:04:57 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/home-assistant/addons repository
21-06-11 21:04:58 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete

_Originally posted by @jspanitz in https://github.com/home-assistant/supervisor/issues/2774#issuecomment-859904586_

And hourly it in my sup log:

21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.check] System checks complete
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.fixups.store_execute_remove] Remove invalid Store: core
21-06-12 14:44:34 ERROR (MainThread) [supervisor.store.repository] Can't remove built-in repositories!
21-06-12 14:44:34 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete
21-06-12 14:44:34 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
21-06-12 14:44:47 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json
21-06-12 14:45:00 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/home-assistant/addons repository
21-06-12 14:45:04 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove
21-06-12 14:45:04 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove
21-06-12 15:30:19 INFO (MainThread) [supervisor.snapshots] Found 7 snapshot files
21-06-12 15:30:19 INFO (MainThread) [supervisor.snapshots] Found 7 snapshot files

Additional information

No response

jspanitz commented 3 years ago

Can't ping github.com or www.github.com image

Manually added entries fixes name resolution issue image

image

Same ping / lookup to google.com works just find with no entries added: image

jspanitz commented 3 years ago

Continued testing shows the odd, random behavior of DNS resolution

Now google doesn't respond. Of course GitHub does as static host entries are still in place. image

Then a bit later google resolved again. image

Please note, a continuous ping and nslookups are performed on another device at the same time using the same network / DNS servers with zero issues.

bbohannan commented 3 years ago

I am also having the exact same problem. Supervisor version supervisor-2021.06.0, core version core-2021.6.4, running HomeAssistantOS image for MacOS/VirtualBox created June 9 2021 at 12:37 AM.

21-06-12 22:20:36 INFO (MainThread) [supervisor.host.services] Updating service information 21-06-12 22:20:37 INFO (MainThread) [supervisor.host.network] Updating local network information 21-06-12 22:20:37 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information 21-06-12 22:20:37 INFO (MainThread) [supervisor.host] Host information reload completed 21-06-12 22:20:37 INFO (MainThread) [supervisor.host.apparmor] Loading AppArmor Profiles: {'hassio-supervisor'} 21-06-12 22:20:37 INFO (MainThread) [supervisor.host.services] Reloading local service hassos-apparmor.service 21-06-12 22:20:37 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-dns with version 2021.04.0 21-06-12 22:20:37 INFO (MainThread) [supervisor.plugins.dns] Updated /etc/resolv.conf 21-06-12 22:20:37 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-audio with version 2021.04.0 21-06-12 22:20:37 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-cli with version 2021.05.1 21-06-12 22:20:37 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-observer with version 2020.10.1 21-06-12 22:20:37 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-multicast with version 2021.04.0 21-06-12 22:20:37 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json 21-06-12 22:20:38 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to homeassistant/qemux86-64-homeassistant with version landingpage 21-06-12 22:20:38 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 0 Home Assistant secrets 21-06-12 22:20:38 INFO (MainThread) [supervisor.homeassistant.core] Starting HomeAssistant landingpage 21-06-12 22:20:38 INFO (MainThread) [supervisor.hassos] Detect Home Assistant Operating System 6.0 / BootSlot A 21-06-12 22:20:38 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/home-assistant/addons repository 21-06-12 22:20:38 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/hassio-addons/repository repository 21-06-12 22:20:43 ERROR (MainThread) [supervisor.store.git] Can't clone https://github.com/home-assistant/addons repository: Cmd('git') failed due to: exit code(128) cmdline: git clone -v --recursive --depth=1 --shallow-submodules https://github.com/home-assistant/addons /data/addons/core stderr: 'Cloning into '/data/addons/core'... fatal: unable to access 'https://github.com/home-assistant/addons/': Could not resolve host: github.com '. 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.module] Create new issue IssueType.FATAL_ERROR - ContextType.STORE / core 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.EXECUTE_REMOVE - ContextType.STORE / core 21-06-12 22:20:43 ERROR (MainThread) [supervisor.store] Can't load data from repository core 21-06-12 22:20:43 ERROR (MainThread) [supervisor.store.git] Can't clone https://github.com/hassio-addons/repository repository: Cmd('git') failed due to: exit code(128) cmdline: git clone -v --recursive --depth=1 --shallow-submodules https://github.com/hassio-addons/repository /data/addons/git/a0d7b954 stderr: 'Cloning into '/data/addons/git/a0d7b954'... fatal: unable to access 'https://github.com/hassio-addons/repository/': Could not resolve host: github.com '. 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.module] Create new issue IssueType.FATAL_ERROR - ContextType.STORE / a0d7b954 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.EXECUTE_REMOVE - ContextType.STORE / a0d7b954 21-06-12 22:20:43 ERROR (MainThread) [supervisor.store] Can't load data from repository https://github.com/hassio-addons/repository 21-06-12 22:20:43 INFO (MainThread) [supervisor.store] Loading add-ons from store: 0 all - 0 new - 0 remove 21-06-12 22:20:43 INFO (MainThread) [supervisor.addons] Found 0 installed add-ons 21-06-12 22:20:43 INFO (MainThread) [supervisor.snapshots] Found 0 snapshot files 21-06-12 22:20:43 INFO (MainThread) [supervisor.discovery] Loaded 0 messages 21-06-12 22:20:43 INFO (MainThread) [supervisor.ingress] Loaded 0 ingress sessions 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.SETUP 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.check] System checks complete 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-12 22:20:43 INFO (MainThread) [supervisor.jobs] 'ResolutionFixup.run_autofix' blocked from execution, system is not running - CoreState.SETUP 21-06-12 22:20:43 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP 21-06-12 22:20:44 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-12 22:20:44 INFO (MainThread) [main] Running Supervisor 21-06-12 22:20:44 INFO (MainThread) [supervisor.hassos] Rauc: A - marked slot kernel.0 as good 21-06-12 22:20:44 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.INITIALIZE' starting 0 add-ons 21-06-12 22:20:44 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SYSTEM' starting 0 add-ons 21-06-12 22:20:44 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SERVICES' starting 0 add-ons 21-06-12 22:20:44 INFO (MainThread) [supervisor.core] Skiping start of Home Assistant 21-06-12 22:20:44 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.APPLICATION' starting 0 add-ons 21-06-12 22:20:44 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled 21-06-12 22:20:44 INFO (MainThread) [supervisor.core] Supervisor is up and running 21-06-12 22:20:44 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant setup 21-06-12 22:20:44 INFO (MainThread) [supervisor.host.info] Updating local host information 21-06-12 22:20:44 INFO (SyncWorker_0) [supervisor.docker.interface] Updating image homeassistant/qemux86-64-homeassistant:landingpage to homeassistant/qemux86-64-homeassistant:2021.6.4 21-06-12 22:20:44 INFO (SyncWorker_0) [supervisor.docker.interface] Downloading docker image homeassistant/qemux86-64-homeassistant with tag 2021.6.4. 21-06-12 22:20:44 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING 21-06-12 22:20:44 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE 21-06-12 22:20:44 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON 21-06-12 22:20:44 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM 21-06-12 22:20:44 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.CREATE_FULL_SNAPSHOT - ContextType.SYSTEM / None 21-06-12 22:20:44 INFO (MainThread) [supervisor.resolution.check] System checks complete 21-06-12 22:20:44 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING 21-06-12 22:20:44 INFO (MainThread) [supervisor.host.services] Updating service information 21-06-12 22:20:44 INFO (MainThread) [supervisor.host.network] Updating local network information 21-06-12 22:20:45 INFO (MainThread) [supervisor.host] Host information reload completed 21-06-12 22:20:45 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-12 22:20:45 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING 21-06-12 22:20:45 INFO (MainThread) [supervisor.resolution.fixups.store_execute_remove] Remove invalid Store: core 21-06-12 22:20:45 ERROR (MainThread) [supervisor.store.repository] Can't remove built-in repositories! 21-06-12 22:20:45 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete 21-06-12 22:22:14 INFO (SyncWorker_0) [supervisor.docker.interface] Stopping homeassistant application 21-06-12 22:22:17 INFO (SyncWorker_0) [supervisor.docker.interface] Cleaning homeassistant application 21-06-12 22:22:17 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant docker now installed 21-06-12 22:22:17 INFO (MainThread) [supervisor.homeassistant.core] Starting Home Assistant 21-06-12 22:22:17 INFO (MainThread) [supervisor.homeassistant.module] Update pulse/client.config: /data/tmp/homeassistant_pulse 21-06-12 22:22:18 INFO (SyncWorker_2) [supervisor.docker.homeassistant] Starting Home Assistant homeassistant/qemux86-64-homeassistant with version 2021.6.4 21-06-12 22:22:18 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready 21-06-12 22:22:26 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING 21-06-12 22:22:26 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-12 22:22:28 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token 21-06-12 22:22:33 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance 21-06-12 22:22:33 INFO (SyncWorker_2) [supervisor.docker.interface] Cleanup images: ['homeassistant/qemux86-64-homeassistant:landingpage'] 21-06-12 22:30:26 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING 21-06-12 22:30:26 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-12 22:30:36 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING 21-06-12 22:30:36 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete

davrte commented 3 years ago

the problem has not changed. From my supervisor log: `[13:48:58] INFO: Starting local supervisor watchdog...

21-06-13 13:49:01 INFO (MainThread) [main] Initializing Supervisor setup

21-06-13 13:49:01 INFO (MainThread) [supervisor.bootstrap] Initializing Supervisor Sentry

21-06-13 13:49:03 INFO (MainThread) [main] Setting up Supervisor

21-06-13 13:49:19 ERROR (MainThread) [supervisor.store.git] Can't clone https://github.com/home-assistant/addons repository: Cmd('git') failed due to: exit code(128)

cmdline: git clone -v --recursive --depth=1 --shallow-submodules https://github.com/home-assistant/addons /data/addons/core

stderr: 'Cloning into '/data/addons/core'...

fatal: unable to access 'https://github.com/home-assistant/addons/': Could not resolve host: github.com '.

21-06-13 13:49:19 ERROR (MainThread) [supervisor.store] Can't load data from repository core

21-06-13 13:49:23 INFO (MainThread) [main] Running Supervisor

21-06-13 13:50:28 ERROR (MainThread) [supervisor.store.repository] Can't remove built-in repositories!`

jaxbucsfan commented 3 years ago

Same Issue: I recreated this issue by creating a VM using VBOX and exact same results using my Debain 10 installation. This was setup and working for months without any issues and had many addons installed and configured. Something changed at some point, just don't know when.

pvizeli commented 3 years ago

What do you see on ha dns info and ha dns logs if you see the error?

jaxbucsfan commented 3 years ago

root@debian:/home/nick# ha dns logs [INFO] 172.30.32.1:60344 - 51885 "PTR IN 169.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020644583s [INFO] 172.30.32.1:60344 - 21545 "PTR IN 170.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.026074746s [INFO] 172.30.32.1:60344 - 46088 "PTR IN 171.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023118476s [INFO] 172.30.32.1:60344 - 19570 "PTR IN 172.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021357165s [INFO] 172.30.32.1:60344 - 24935 "PTR IN 173.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021506626s [INFO] 172.30.32.1:60344 - 11502 "PTR IN 174.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020958314s [INFO] 172.30.32.1:60344 - 41313 "PTR IN 175.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023258887s [INFO] 172.30.32.1:60344 - 10621 "PTR IN 176.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021639143s [INFO] 172.30.32.1:60344 - 689 "PTR IN 177.128.168.192.in-addr.arpa. udp 46 fals e 512" SERVFAIL qr,rd 46 0.021993582s [INFO] 172.30.32.1:60344 - 36997 "PTR IN 178.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.024557893s [INFO] 172.30.32.1:60344 - 1379 "PTR IN 179.128.168.192.in-addr.arpa. udp 46 fal se 512" SERVFAIL qr,rd 46 0.024521319s [INFO] 172.30.32.1:60344 - 41088 "PTR IN 180.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021401817s [INFO] 172.30.32.1:60344 - 23394 "PTR IN 181.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.02176344s [INFO] 172.30.32.1:60344 - 62745 "PTR IN 182.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.025010927s [INFO] 172.30.32.1:60344 - 56369 "PTR IN 183.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023144295s [INFO] 172.30.32.1:60344 - 57327 "PTR IN 184.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023583965s [INFO] 172.30.32.1:60344 - 32532 "PTR IN 185.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.030333164s [INFO] 172.30.32.1:60344 - 30539 "PTR IN 186.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021359179s [INFO] 172.30.32.1:60344 - 55463 "PTR IN 187.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022589784s [INFO] 172.30.32.1:60344 - 34088 "PTR IN 188.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023192977s [INFO] 172.30.32.1:60344 - 12463 "PTR IN 189.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021620081s [INFO] 172.30.32.1:60344 - 47508 "PTR IN 190.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.029972553s [INFO] 172.30.32.1:60344 - 60153 "PTR IN 191.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021593055s [INFO] 172.30.32.1:60344 - 46019 "PTR IN 192.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022781702s [INFO] 172.30.32.1:60344 - 51838 "PTR IN 193.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023916938s [INFO] 172.30.32.1:60344 - 3243 "PTR IN 194.128.168.192.in-addr.arpa. udp 46 fal se 512" SERVFAIL qr,rd 46 0.020863818s [INFO] 172.30.32.1:60344 - 38571 "PTR IN 195.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.024285691s [INFO] 172.30.32.1:60344 - 10466 "PTR IN 196.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.02163421s [INFO] 172.30.32.1:60344 - 13431 "PTR IN 197.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023959708s [INFO] 172.30.32.1:60344 - 56651 "PTR IN 198.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021697607s [INFO] 172.30.32.1:60344 - 19292 "PTR IN 199.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021491156s [INFO] 172.30.32.1:60344 - 56672 "PTR IN 200.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022580894s [INFO] 172.30.32.1:60344 - 42362 "PTR IN 201.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023049273s [INFO] 172.30.32.1:60344 - 51304 "PTR IN 202.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023901013s [INFO] 172.30.32.1:60344 - 14632 "PTR IN 203.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021879774s [INFO] 172.30.32.1:60344 - 22292 "PTR IN 204.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.019560587s [INFO] 172.30.32.1:60344 - 3681 "PTR IN 205.128.168.192.in-addr.arpa. udp 46 fal se 512" SERVFAIL qr,rd 46 0.02203816s [INFO] 172.30.32.1:60344 - 15982 "PTR IN 206.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.024561455s [INFO] 172.30.32.1:60344 - 28495 "PTR IN 207.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023004476s [INFO] 172.30.32.1:60344 - 292 "PTR IN 208.128.168.192.in-addr.arpa. udp 46 fals e 512" SERVFAIL qr,rd 46 0.022304487s [INFO] 172.30.32.1:60344 - 22475 "PTR IN 209.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022117284s [INFO] 172.30.32.1:60344 - 32499 "PTR IN 210.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.024502237s [INFO] 172.30.32.1:60344 - 52623 "PTR IN 211.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020389439s [INFO] 172.30.32.1:60344 - 43350 "PTR IN 212.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022446181s [INFO] 172.30.32.1:60344 - 59603 "PTR IN 213.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020387206s [INFO] 172.30.32.1:60344 - 34897 "PTR IN 214.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.02435717s [INFO] 172.30.32.1:60344 - 38933 "PTR IN 215.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.028093581s [INFO] 172.30.32.1:60344 - 58062 "PTR IN 216.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021764906s [INFO] 172.30.32.1:60344 - 62059 "PTR IN 217.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.027872566s [INFO] 172.30.32.1:60344 - 54922 "PTR IN 218.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022956787s [INFO] 172.30.32.1:60344 - 50875 "PTR IN 219.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022269723s [INFO] 172.30.32.1:60344 - 60945 "PTR IN 220.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020648442s [INFO] 172.30.32.1:60344 - 65286 "PTR IN 221.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021384056s [INFO] 172.30.32.1:60344 - 43944 "PTR IN 222.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.02696983s [INFO] 172.30.32.1:60344 - 43568 "PTR IN 223.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.026525356s [INFO] 172.30.32.1:60344 - 56089 "PTR IN 224.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.02250953s [INFO] 172.30.32.1:60344 - 49018 "PTR IN 225.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021538609s [INFO] 172.30.32.1:60344 - 47023 "PTR IN 226.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022667677s [INFO] 172.30.32.1:60344 - 289 "PTR IN 227.128.168.192.in-addr.arpa. udp 46 fals e 512" SERVFAIL qr,rd 46 0.021848312s [INFO] 172.30.32.1:60344 - 31368 "PTR IN 228.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021165782s [INFO] 172.30.32.1:60344 - 11816 "PTR IN 229.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020551715s [INFO] 172.30.32.1:60344 - 62839 "PTR IN 230.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.022394082s [INFO] 172.30.32.1:60344 - 10798 "PTR IN 231.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.0258927s [INFO] 172.30.32.1:60344 - 53764 "PTR IN 232.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020215358s [INFO] 172.30.32.1:60344 - 52145 "PTR IN 233.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021832635s [INFO] 172.30.32.1:60344 - 45247 "PTR IN 234.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020635296s [INFO] 172.30.32.1:60344 - 57520 "PTR IN 235.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.02262532s [INFO] 172.30.32.1:60344 - 54578 "PTR IN 236.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.019488362s [INFO] 172.30.32.1:60344 - 44306 "PTR IN 237.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.023351824s [INFO] 172.30.32.1:60344 - 38871 "PTR IN 238.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020487377s [INFO] 172.30.32.1:60344 - 56166 "PTR IN 239.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021063494s [INFO] 172.30.32.1:60344 - 545 "PTR IN 240.128.168.192.in-addr.arpa. udp 46 fals e 512" SERVFAIL qr,rd 46 0.021383269s [INFO] 172.30.32.1:60344 - 27948 "PTR IN 241.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020848524s [INFO] 172.30.32.1:60344 - 38444 "PTR IN 242.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021121877s [INFO] 172.30.32.1:60344 - 39506 "PTR IN 243.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020600317s [INFO] 172.30.32.1:60344 - 16478 "PTR IN 244.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021667173s [INFO] 172.30.32.1:60344 - 6402 "PTR IN 245.128.168.192.in-addr.arpa. udp 46 fal se 512" SERVFAIL qr,rd 46 0.022937903s [INFO] 172.30.32.1:60344 - 58336 "PTR IN 246.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.028654441s [INFO] 172.30.32.1:60344 - 45513 "PTR IN 247.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.020568875s [INFO] 172.30.32.1:60344 - 40071 "PTR IN 248.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.024391082s [INFO] 172.30.32.1:60344 - 37289 "PTR IN 249.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.024930915s [INFO] 172.30.32.1:60344 - 11778 "PTR IN 250.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.026129401s [INFO] 172.30.32.1:60344 - 45713 "PTR IN 251.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.026015592s [INFO] 172.30.32.1:60344 - 18510 "PTR IN 252.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.021416074s [INFO] 172.30.32.1:60344 - 32572 "PTR IN 253.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.024336703s [INFO] 172.30.32.1:60344 - 43940 "PTR IN 254.128.168.192.in-addr.arpa. udp 46 fa lse 512" SERVFAIL qr,rd 46 0.025179638s [INFO] 172.30.32.2:34067 - 9409 "AAAA IN main.codenotary.io. udp 36 false 512" S ERVFAIL qr,rd 36 0.023179662s [INFO] 172.30.32.2:55909 - 9311 "AAAA IN main.codenotary.io. udp 36 false 512" S ERVFAIL qr,aa,rd 36 0.000233338s [INFO] 172.30.32.2:53162 - 36990 "AAAA IN api.codenotary.io. udp 35 false 512" S ERVFAIL qr,rd 35 0.02447341s [INFO] 172.30.32.2:46769 - 15457 "AAAA IN api.codenotary.io. udp 35 false 512" S ERVFAIL qr,aa,rd 35 0.000208651s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,rd 46 0.024887341s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000178898s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000161138s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000162005s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000058492s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000242288s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000189532s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000164135s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000165132s [INFO] 172.30.32.1:44644 - 17355 "AAAA IN aa015h6buqvih86i1.api.met.no. udp 46 f alse 512" SERVFAIL qr,aa,rd 46 0.000162497s

root@debian:/home/nick# ha dns info host: 172.30.32.3 locals:

jspanitz commented 3 years ago

image

➜ ~ ha dns logs [INFO] 172.30.32.1:43382 - 65005 "AAAA IN mobile-apps.home-assistant.io. udp 47 false 512" SERVFAIL qr,aa,rd,ra 47 0.000140997s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,rd,ra 162 0.002397944s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000161757s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000201645s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000706767s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.00021196s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000181497s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000182682s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000211627s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.00016209s [INFO] 172.30.32.1:42782 - 19954 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000166813s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,rd,ra 96 1.877194984s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.00017883s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.00019909s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.000185553s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.000190793s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.000174627s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.000199386s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.000150442s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.000185201s [INFO] 172.30.32.1:60563 - 53243 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 96 0.000189349s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,rd,ra 45 0.002637588s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.000205071s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.000241311s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.000139368s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.000173312s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.000218108s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.000377531s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.002138763s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.000269458s [INFO] 172.30.32.1:49703 - 11039 "AAAA IN dataservice.accuweather.com. udp 45 false 512" SERVFAIL qr,aa,rd,ra 45 0.000322402s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,rd,ra 32 1.373821962s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000203682s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.00022133s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000188035s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000169886s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000164442s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000158312s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.00018883s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000171349s [INFO] 172.30.32.1:39323 - 19610 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000214016s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,rd,ra 33 0.002391759s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000181072s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000098147s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000085332s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000093351s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000167645s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000114128s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000092592s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000081647s [INFO] 172.30.32.1:60372 - 26792 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000079629s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,rd,ra 162 1.262805992s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000196405s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000154757s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000151349s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000140924s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000159775s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.00015772s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000140108s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000144923s [INFO] 172.30.32.1:58497 - 39222 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 162 0.000161739s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,rd,ra 32 0.354205101s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000211904s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000218311s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000229423s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000166719s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000170089s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000149757s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000190942s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000157535s [INFO] 172.30.32.1:34593 - 16525 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000262329s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,rd,ra 33 0.40898713s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000334421s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000243737s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000280255s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000226867s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000319625s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000163405s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000194368s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000314328s [INFO] 172.30.32.1:58872 - 7310 "AAAA IN api.weather.gov. udp 33 false 512" SERVFAIL qr,aa,rd,ra 33 0.000452919s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,rd,ra 32 0.550209225s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000144683s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000179998s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000191516s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.00013409s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000110183s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000569732s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000226811s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000198848s [INFO] 172.30.32.1:47270 - 59517 "AAAA IN api.ecobee.com. udp 32 false 512" SERVFAIL qr,aa,rd,ra 32 0.000184516s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,rd,ra 28 0.119256727s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,aa,rd,ra 28 0.000181793s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,aa,rd,ra 28 0.000726026s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,aa,rd,ra 28 0.000736915s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,aa,rd,ra 28 0.000217589s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,aa,rd,ra 28 0.000196516s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,aa,rd,ra 28 0.000176423s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,aa,rd,ra 28 0.000185831s [INFO] 172.30.32.2:54226 - 11648 "AAAA IN github.com. udp 28 false 512" SERVFAIL qr,aa,rd,ra 28 0.000158812s ➜ ~

At this time there are no static entries in my hosts file

pvizeli commented 3 years ago

Does it work if you disable IPv6 over the network UI?

davrte commented 3 years ago

What do you see on ha dns info and ha dns logs if you see the error?

ha dns info host: 172.30.32.3 locals:

[s6-init] making user provided files available at /var/run/s6/etc...exited 0. [s6-init] ensuring user provided files have correct perms...exited 0. [fix-attrs.d] applying ownership & permissions fixes... [fix-attrs.d] done. [cont-init.d] executing container initialization scripts... [cont-init.d] corefile.sh: executing... [cont-init.d] corefile.sh: exited 0. [cont-init.d] done. [services.d] starting services [services.d] done. .:53 .:5553 CoreDNS-1.8.3 linux/amd64, go1.15.11, 4293992-dirty

jaxbucsfan commented 3 years ago

Does it work if you disable IPv6 over the network UI?

No change with IP6 disabled.

pvizeli commented 3 years ago

The DNS plugin update will fix the problem that your DNS server doesn't respond correctly to the AAAA resolving. It's now on the beta channel and tomorrow on the stable channel

davrte commented 3 years ago

The DNS plugin update will fix the problem that your DNS server doesn't respond correctly to the AAAA resolving. It's now on the beta channel and tomorrow on the stable channel

how can i test it? thank you!

ludeeus commented 3 years ago

image

davrte commented 3 years ago

thanks ludeeus. For me nothing has changed: 21-06-15 10:15:26 INFO (MainThread) [main] Closing Supervisor 21-06-15 10:15:27 INFO (MainThread) [main] Initializing Supervisor setup 21-06-15 10:15:28 INFO (MainThread) [supervisor.bootstrap] Initializing Supervisor Sentry 21-06-15 10:15:28 INFO (MainThread) [main] Setting up Supervisor 21-06-15 10:15:35 ERROR (MainThread) [supervisor.store.git] Can't clone https://github.com/home-assistant/addons repository: Cmd('git') failed due to: exit code(128) cmdline: git clone -v --recursive --depth=1 --shallow-submodules https://github.com/home-assistant/addons /data/addons/core stderr: 'Cloning into '/data/addons/core'... fatal: unable to access 'https://github.com/home-assistant/addons/': Could not resolve host: github.com '. 21-06-15 10:15:35 ERROR (MainThread) [supervisor.store] Can't load data from repository core 21-06-15 10:15:36 INFO (MainThread) [main] Running Supervisor 21-06-15 10:15:38 ERROR (MainThread) [supervisor.store.repository] Can't remove built-in repositories!

ludeeus commented 3 years ago

It install the new plugin version in background after restart

pvizeli commented 3 years ago 
ha su reload
ha dns update
ha dns info

please send the output of that to verify you run on the new plugin

then retry it and send the output of ha dns logs if they is still an issue

davrte commented 3 years ago 
ha su reload
ha dns update
ha dns info

please send the output of that to verify you run on the new plugin

then retry it and send the output of ha dns logs if they is still an issue

ha dns info host: 172.30.32.3 locals:

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0. [fix-attrs.d] applying ownership & permissions fixes... [fix-attrs.d] done. [cont-init.d] executing container initialization scripts... [cont-init.d] corefile.sh: executing... [cont-init.d] corefile.sh: exited 0. [cont-init.d] done. [services.d] starting services [services.d] done. .:53 .:5553 CoreDNS-1.8.4 linux/amd64, go1.15.13, 053c4d5-dirty [INFO] SIGTERM: Shutting down servers then terminating [cont-finish.d] executing container finish scripts... [cont-finish.d] done. [s6-finish] waiting for services. [s6-finish] sending all processes the TERM signal. [s6-finish] sending all processes the KILL signal and exiting. [s6-init] making user provided files available at /var/run/s6/etc...exited 0. [s6-init] ensuring user provided files have correct perms...exited 0. [fix-attrs.d] applying ownership & permissions fixes... [fix-attrs.d] done. [cont-init.d] executing container initialization scripts... [cont-init.d] corefile.sh: executing... [cont-init.d] corefile.sh: exited 0. [cont-init.d] done. [services.d] starting services [services.d] done. .:53 .:5553 CoreDNS-1.8.4 linux/amd64, go1.15.13, 053c4d5-dirty [INFO] SIGTERM: Shutting down servers then terminating [cont-finish.d] executing container finish scripts... [cont-finish.d] done. [s6-finish] waiting for services. [s6-finish] sending all processes the TERM signal. [s6-finish] sending all processes the KILL signal and exiting. [s6-init] making user provided files available at /var/run/s6/etc...exited 0. [s6-init] ensuring user provided files have correct perms...exited 0. [fix-attrs.d] applying ownership & permissions fixes... [fix-attrs.d] done. [cont-init.d] executing container initialization scripts... [cont-init.d] corefile.sh: executing... [cont-init.d] corefile.sh: exited 0. [cont-init.d] done. [services.d] starting services [services.d] done. .:5553 .:53 CoreDNS-1.8.4 linux/amd64, go1.15.13, 053c4d5-dirty

pvizeli commented 3 years ago

That is good, there is no DNS error anymore :) If you want know more what is going on, you can set:

ha su options --logging debug
ha dns restart

But there is no SRVFAIL response anymore, look like the bypass of your DNS server/router is in place.

davrte commented 3 years ago

21-06-15 11:41:19 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING 21-06-15 11:41:19 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-15 11:41:26 DEBUG (MainThread) [supervisor.api.middleware.security] Passthrough /supervisor/ping 21-06-15 11:41:29 INFO (MainThread) [supervisor.api.middleware.security] /dns/restart access from core_ssh 21-06-15 11:41:29 DEBUG (MainThread) [supervisor.plugins.dns] config-dns = ['dns://8.8.8.8', 'dns://1.1.1.1'], local-dns = ['dns://192.168.1.1'] , backup-dns = CloudFlare DoT / debug: True 21-06-15 11:41:29 INFO (MainThread) [supervisor.plugins.dns] Restarting CoreDNS plugin 21-06-15 11:41:29 INFO (SyncWorker_0) [supervisor.docker.interface] Restarting ghcr.io/home-assistant/amd64-hassio-dns 21-06-15 11:41:41 DEBUG (MainThread) [supervisor.api.middleware.security] /app/entrypoint.js access from Home Assistant 21-06-15 11:41:41 DEBUG (MainThread) [supervisor.api.middleware.security] /app/frontend_latest/entrypoint.586ea840.js access from Home Assistant 21-06-15 11:41:42 DEBUG (MainThread) [supervisor.api.middleware.security] /app/static/translations/en-f4ad98584c6b4ec5293e2bacb27e9359.json access from Home Assistant 21-06-15 11:41:44 DEBUG (MainThread) [supervisor.api.middleware.security] /addons access from Home Assistant 21-06-15 11:41:44 DEBUG (MainThread) [supervisor.api.middleware.security] /supervisor/info access from Home Assistant 21-06-15 11:41:47 DEBUG (MainThread) [supervisor.api.middleware.security] /addons/reload access from Home Assistant 21-06-15 11:41:47 WARNING (MainThread) [supervisor.store.git] No valid repository for https://github.com/home-assistant/addons 21-06-15 11:41:47 DEBUG (MainThread) [supervisor.jobs] Job updated; name: storemanager_update_repositories, progress: 10, stage: Check repositories 21-06-15 11:41:47 DEBUG (MainThread) [supervisor.jobs] Job updated; name: storemanager_update_repositories, progress: 90, stage: Update addons 21-06-15 11:41:47 DEBUG (MainThread) [supervisor.jobs] Job updated; name: storemanager_update_repositories, progress: 95, stage: Read addons 21-06-15 11:41:47 INFO (MainThread) [supervisor.store] Loading add-ons from store: 0 all - 0 new - 0 remove 21-06-15 11:41:47 INFO (MainThread) [supervisor.store] Loading add-ons from store: 0 all - 0 new - 0 remove 21-06-15 11:41:47 DEBUG (MainThread) [supervisor.api.middleware.security] /addons access from Home Assistant 21-06-15 11:41:47 DEBUG (MainThread) [supervisor.api.middleware.security] /supervisor/info access from Home Assistant 21-06-15 11:41:52 DEBUG (MainThread) [supervisor.api.middleware.security] /core/stats access from Home Assistant 21-06-15 11:41:52 DEBUG (MainThread) [supervisor.api.middleware.security] /supervisor/logs access from Home Assistant 21-06-15 11:41:52 DEBUG (MainThread) [supervisor.api.middleware.security] /supervisor/stats access from Home Assistant 21-06-15 11:41:52 DEBUG (MainThread) [supervisor.api.middleware.security] /network/info access from Home Assistant 21-06-15 11:41:53 DEBUG (MainThread) [supervisor.api.middleware.security] /supervisor/logs access from Home Assistant

still no addons...

jspanitz commented 3 years ago

Updated to beta - officall add-ons still not showing available updates and still can't add the 3rd party add- ons back in - https://github.com/home-assistant/addons

Can we have this issue opened back again?

image

image

[12:08:32] INFO: Starting local supervisor watchdog... 21-06-15 12:08:34 INFO (MainThread) [main] Initializing Supervisor setup 21-06-15 12:08:35 INFO (MainThread) [supervisor.bootstrap] Initializing Supervisor Sentry 21-06-15 12:08:35 INFO (MainThread) [supervisor.bootstrap] Seting up coresys for machine: raspberrypi4-64 21-06-15 12:08:35 INFO (SyncWorker_0) [supervisor.docker.supervisor] Attaching to Supervisor homeassistant/aarch64-hassio-supervisor with version 2021.06.1 21-06-15 12:08:35 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token 21-06-15 12:08:35 INFO (SyncWorker_0) [supervisor.docker.supervisor] Connecting Supervisor to hassio-network 21-06-15 12:08:35 INFO (SyncWorker_1) [supervisor.docker.interface] Cleanup images: ['homeassistant/aarch64-hassio-supervisor:2021.06.0'] 21-06-15 12:08:36 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.INITIALIZE 21-06-15 12:08:36 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-15 12:08:36 INFO (MainThread) [main] Setting up Supervisor 21-06-15 12:08:36 INFO (MainThread) [supervisor.api] Starting API on 172.30.32.2 21-06-15 12:08:36 INFO (MainThread) [supervisor.hardware.monitor] Started Supervisor hardware monitor 21-06-15 12:08:37 INFO (MainThread) [supervisor.host.info] Updating local host information 21-06-15 12:08:37 INFO (MainThread) [supervisor.host.services] Updating service information 21-06-15 12:08:38 INFO (MainThread) [supervisor.host.network] Updating local network information 21-06-15 12:08:40 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information 21-06-15 12:08:40 INFO (MainThread) [supervisor.host] Host information reload completed 21-06-15 12:08:40 INFO (MainThread) [supervisor.host.apparmor] Loading AppArmor Profiles: {'hassio-supervisor'} 21-06-15 12:08:40 INFO (MainThread) [supervisor.host.services] Reloading local service hassos-apparmor.service 21-06-15 12:08:40 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/aarch64-hassio-dns with version 2021.06.0 21-06-15 12:08:40 INFO (MainThread) [supervisor.plugins.dns] Updated /etc/resolv.conf 21-06-15 12:08:40 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-audio with version 2021.04.0 21-06-15 12:08:40 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-cli with version 2021.05.1 21-06-15 12:08:40 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-observer with version 2020.10.1 21-06-15 12:08:40 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-multicast with version 2021.04.0 21-06-15 12:08:40 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/beta.json 21-06-15 12:08:44 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/raspberrypi4-64-homeassistant with version 2021.6.4 21-06-15 12:08:44 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 1 Home Assistant secrets 21-06-15 12:08:44 INFO (MainThread) [supervisor.hassos] Detect Home Assistant Operating System 6.0 / BootSlot B 21-06-15 12:08:44 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/core repository 21-06-15 12:08:44 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 23 new - 0 remove 21-06-15 12:08:44 INFO (MainThread) [supervisor.addons] Found 7 installed add-ons 21-06-15 12:08:44 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/portainer/aarch64 with version 1.5.0 21-06-15 12:08:44 INFO (SyncWorker_3) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-ssh with version 9.1.3 21-06-15 12:08:44 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/zwavejs2mqtt/aarch64 with version 0.18.0 21-06-15 12:08:44 INFO (SyncWorker_2) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/ssh/aarch64 with version 8.2.3 21-06-15 12:08:44 INFO (SyncWorker_5) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-configurator with version 5.3.1 21-06-15 12:08:44 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-almond with version 1.1.2 21-06-15 12:08:44 INFO (SyncWorker_4) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-letsencrypt with version 4.11.0 21-06-15 12:08:44 INFO (MainThread) [supervisor.snapshots] Found 8 snapshot files 21-06-15 12:08:44 INFO (MainThread) [supervisor.discovery] Loaded 2 messages 21-06-15 12:08:44 INFO (MainThread) [supervisor.ingress] Loaded 0 ingress sessions 21-06-15 12:08:44 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.SETUP 21-06-15 12:08:44 INFO (MainThread) [supervisor.resolution.check] System checks complete 21-06-15 12:08:44 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP 21-06-15 12:08:44 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-15 12:08:44 INFO (MainThread) [supervisor.jobs] 'ResolutionFixup.run_autofix' blocked from execution, system is not running - CoreState.SETUP 21-06-15 12:08:44 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP 21-06-15 12:08:45 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-15 12:08:45 INFO (MainThread) [main] Running Supervisor 21-06-15 12:08:45 INFO (MainThread) [supervisor.hassos] Rauc: B - marked slot kernel.1 as good 21-06-15 12:08:45 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.INITIALIZE' starting 0 add-ons 21-06-15 12:08:45 INFO (MainThread) [supervisor.core] Supervisor reboot detected 21-06-15 12:08:45 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled 21-06-15 12:08:45 INFO (MainThread) [supervisor.core] Supervisor is up and running 21-06-15 12:08:45 INFO (MainThread) [supervisor.host.info] Updating local host information 21-06-15 12:08:45 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING 21-06-15 12:08:45 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE 21-06-15 12:08:45 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON 21-06-15 12:08:45 INFO (MainThread) [supervisor.host.services] Updating service information 21-06-15 12:08:45 INFO (MainThread) [supervisor.host.network] Updating local network information 21-06-15 12:08:45 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM 21-06-15 12:08:45 INFO (MainThread) [supervisor.resolution.check] System checks complete 21-06-15 12:08:45 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING 21-06-15 12:08:46 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request initialize 21-06-15 12:08:46 INFO (MainThread) [supervisor.api.proxy] WebSocket access from core_almond 21-06-15 12:08:46 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request running 21-06-15 12:08:47 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-15 12:08:47 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING 21-06-15 12:08:47 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete 21-06-15 12:08:48 INFO (MainThread) [supervisor.host] Host information reload completed 21-06-15 12:09:24 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/home-assistant/addons repository 21-06-15 12:09:25 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove 21-06-15 12:09:25 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove 21-06-15 12:10:16 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/home-assistant/addons repository 21-06-15 12:10:17 ERROR (MainThread) [supervisor.store] https://github.com/home-assistant/addons is not a valid add-on repository 21-06-15 12:10:17 INFO (MainThread) [supervisor.resolution.module] Create new issue IssueType.CORRUPT_REPOSITORY - ContextType.STORE / 96a017aa 21-06-15 12:10:17 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.EXECUTE_REMOVE - ContextType.STORE / 96a017aa 21-06-15 12:10:17 WARNING (MainThread) [supervisor.store.data] No repository information exists at /data/addons/git/96a017aa 21-06-15 12:10:17 INFO (MainThread) [supervisor.store] Loading add-ons from store: 23 all - 0 new - 0 remove 21-06-15 12:10:17 INFO (MainThread) [supervisor.resolution.fixups.store_execute_remove] Remove invalid Store: 96a017aa 21-06-15 12:10:17 INFO (MainThread) [supervisor.store.git] Removing custom add-on repository https://github.com/home-assistant/addons 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.check] System checks complete 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING 21-06-15 12:10:18 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete

jspanitz commented 3 years ago

Also - I don't like this behavior - bypassing my internal DNS on my firewall / router - I want HA to use my local DNS. Last thing any of us want is an device trying to go directly out to the internet.

pvizeli commented 3 years ago

Perfect, there is also still no github.com resolve issue @jspanitz - This DNS issue trigger a bug which is fixed on 2021.06.2

want HA to use my local DNS. The last thing any of us want is a device trying to go directly out to the internet.

And the result is a not working system like you see. A lot of people can't set up DNS correctly, the reason why we add the fallback to avoid not working system. If all is working again with 2021.06.2 - it means your network setup is not correct and it works only because we fall back to working network config. If you do not want that the system fallback, just fixes the SERVFAIL response of your DNS server.

davrte commented 3 years ago

Perfect, there is also still no github.com resolve issue @jspanitz - This DNS issue trigger a bug which is fixed on 2021.06.2

want HA to use my local DNS. The last thing any of us want is a device trying to go directly out to the internet.

And the result is a not working system like you see. A lot of people can't set up DNS correctly, the reason why we add the fallback to avoid not working system. If all is working again with 2021.06.2 - it means your network setup is not correct and it works only because we fall back to working network config. If you do not want that the system fallback, just fixes the SERVFAIL response of your DNS server.

Thank you pvizeli!!! the addons are back! Just one short question, how can i fix the serverfail response of my dns? Currently i'm on win10 as a host and vmware. The funny thing is that was working fine until a HA update (around 5.10) and didn't change any configuration, how is possible?

jspanitz commented 3 years ago

Perfect, there is also still no github.com resolve issue @jspanitz - This DNS issue trigger a bug which is fixed on 2021.06.2

Just installed, thanks that seems to have resolved

want HA to use my local DNS. The last thing any of us want is a device trying to go directly out to the internet.

And the result is a not working system like you see. A lot of people can't set up DNS correctly, the reason why we add the fallback to avoid not working system. If all is working again with 2021.06.2 - it means your network setup is not correct and it works only because we fall back to working network config. If you do not want that the system fallback, just fixes the SERVFAIL response of your DNS server.

I don't believe the SERVFAIL response is the issue. Testing from multiple other devices points to this being only a HA issue. As many others have stated, this happened around 5.10 and was never an issue before that. No way everyone else with such different setups all made a config change on their home networks that broke HA.

pvizeli commented 3 years ago

The issue is, the response of SERVFAIL on an AAAA query is wrong. That is correct, some resolvers can ignore that issue but not the busybox/musl resolver which is very RFC strict and we use.

jspanitz commented 3 years ago

The issue is, the response of SERVFAIL on an AAAA query is wrong. That is correct, some resolvers can ignore that issue but not the busybox/musl resolver which is very RFC strict and we use.

So I am willing and would like to test this to confirm - what is the request and what is the response you are expecting? Can we force this to occur in HA and then capture the request / response via debug logs?

Madelinot commented 3 years ago

I believe the commonality between all users having this issue, including myself, is that we are all using Amazon Eero Advanced Security. Is that confirmed?

jspanitz commented 3 years ago

I believe the commonality between all users having this issue, including myself, is that we are all using Amazon Eero Advanced Security. Is that confirmed?

No - I am not using any Eero devices. I am using a Sophos XG UTM Firewall Appliance (used to be astaro security linux)

davrte commented 3 years ago

I believe the commonality between all users having this issue, including myself, is that we are all using Amazon Eero Advanced Security. Is that confirmed?

i don't have a eero

jspanitz commented 3 years ago

Opened another bug for the unpermitted cloudflare dns traffic and the fact that HA doesn't play nice with local DNS. https://github.com/home-assistant/supervisor/issues/2966