Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

OTBR add-on do not want to properly start #3815

Open
frabar55 opened this issue Oct 28, 2024 · 0 comments
Open

OTBR add-on do not want to properly start #3815

frabar55 opened this issue Oct 28, 2024 · 0 comments

Comments

@frabar55
Copy link

Describe the issue you are experiencing

Hello everybody, I'm triyng to install OTBR add on but I always receive the error documented in the attached file, i.e OTBR do not want to start!

What type of installation are you running?

Home Assistant Supervised

Which operating system are you running on?

Debian

Which add-on are you reporting an issue with?

OpenThread Border Router

What is the version of the add-on?

2.11.1

Steps to reproduce the issue

...

System Health information

System Information

version core-2024.10.4
installation_type Home Assistant Supervised
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.12.4
os_name Linux
os_version 6.1.0-26-amd64
arch x86_64
timezone Europe/Rome
config_dir /config
Home Assistant Community Store
GitHub API ok
GitHub Content ok
GitHub Web ok
HACS Data ok
GitHub API Calls Remaining 5000
Installed Version 2.0.1
Stage running
Available Repositories 1453
Downloaded Repositories 15
Home Assistant Cloud
logged_in true
subscription_expiration 8 novembre 2024 alle ore 01:00
relayer_connected true
relayer_region eu-central-1
remote_enabled true
remote_connected true
alexa_enabled true
google_enabled false
remote_server eu-central-1-3.ui.nabu.casa
certificate_status ready
instance_id a83fc7a2262248c197e667b38dd28daf
can_reach_cert_server ok
can_reach_cloud_auth ok
can_reach_cloud ok
Home Assistant Supervisor
host_os Debian GNU/Linux 12 (bookworm)
update_channel stable
supervisor_version supervisor-2024.10.3
agent_version 1.6.0
docker_version 27.3.1
disk_total 250.9 GB
disk_used 89.7 GB
healthy true
supported true
host_connectivity true
supervisor_connectivity true
ntp_synchronized false
virtualization
supervisor_api ok
version_api ok
installed_addons Mosquitto broker (6.4.1), Get HACS (1.3.1), Advanced SSH & Web Terminal (19.0.0), Zigbee2MQTT (1.40.2-1), Samba share (12.3.2), Studio Code Server (5.17.2), Matter Server (6.6.0), OpenThread Border Router (2.11.1)
Dashboards
dashboards 2
resources 8
views 10
mode storage
Recorder
oldest_recorder_run 18 ottobre 2024 alle ore 12:49
current_recorder_run 28 ottobre 2024 alle ore 16:18
estimated_db_size 966.70 MiB
database_engine sqlite
database_version 3.45.3

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

2024-10-28 16:18:48.900 INFO (MainThread) [supervisor.resolution.check] System checks complete
2024-10-28 16:18:48.900 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state running
2024-10-28 16:18:48.976 INFO (MainThread) [supervisor.jobs] 'OSManager.reload' blocked from execution, no Home Assistant OS available
2024-10-28 16:18:48.976 INFO (MainThread) [supervisor.host.services] Updating service information
2024-10-28 16:18:48.981 INFO (MainThread) [supervisor.host.network] Updating local network information
2024-10-28 16:18:49.086 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
2024-10-28 16:18:49.100 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
2024-10-28 16:18:49.100 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state running
2024-10-28 16:18:49.101 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete
2024-10-28 16:18:49.106 INFO (MainThread) [supervisor.host.manager] Host information reload completed
2024-10-28 16:23:28.061 WARNING (MainThread) [supervisor.addons.options] Unknown option 'mqtt' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:23:28.061 WARNING (MainThread) [supervisor.addons.options] Unknown option 'homeassistant' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:23:28.061 WARNING (MainThread) [supervisor.addons.options] Unknown option 'permit_join' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:23:28.061 WARNING (MainThread) [supervisor.addons.options] Unknown option 'frontend' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:23:28.061 WARNING (MainThread) [supervisor.addons.options] Unknown option 'ota' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:23:28.061 WARNING (MainThread) [supervisor.addons.options] Unknown option 'disable_automatic_update_check' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:23:28.061 WARNING (MainThread) [supervisor.addons.options] Unknown option 'advanced' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:25:49.819 INFO (MainThread) [supervisor.addons.addon] No core_openthread_border_router addon Docker image homeassistant/amd64-addon-otbr found
2024-10-28 16:25:49.819 INFO (MainThread) [supervisor.docker.interface] Downloading docker image homeassistant/amd64-addon-otbr with tag 2.11.1.
2024-10-28 16:25:58.962 INFO (MainThread) [supervisor.addons.addon] Creating Home Assistant add-on data folder /data/addons/data/core_openthread_border_router
2024-10-28 16:25:58.963 INFO (MainThread) [supervisor.docker.interface] Downloading docker image homeassistant/amd64-addon-otbr with tag 2.11.1.
2024-10-28 16:26:00.125 INFO (MainThread) [supervisor.addons.manager] Add-on 'core_openthread_border_router' successfully installed
2024-10-28 16:26:58.760 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:26:59.848 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:27:03.480 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:27:03.491 INFO (SyncWorker_3) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:27:03.988 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:27:05.171 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:27:47.084 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:27:47.089 INFO (SyncWorker_0) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:27:47.629 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:27:48.849 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:28:28.054 WARNING (MainThread) [supervisor.addons.options] Unknown option 'mqtt' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.055 WARNING (MainThread) [supervisor.addons.options] Unknown option 'homeassistant' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.055 WARNING (MainThread) [supervisor.addons.options] Unknown option 'permit_join' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.055 WARNING (MainThread) [supervisor.addons.options] Unknown option 'frontend' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.055 WARNING (MainThread) [supervisor.addons.options] Unknown option 'ota' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.055 WARNING (MainThread) [supervisor.addons.options] Unknown option 'disable_automatic_update_check' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.055 WARNING (MainThread) [supervisor.addons.options] Unknown option 'advanced' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.078 WARNING (MainThread) [supervisor.addons.options] Unknown option 'mqtt' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.078 WARNING (MainThread) [supervisor.addons.options] Unknown option 'homeassistant' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.078 WARNING (MainThread) [supervisor.addons.options] Unknown option 'permit_join' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.078 WARNING (MainThread) [supervisor.addons.options] Unknown option 'frontend' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.078 WARNING (MainThread) [supervisor.addons.options] Unknown option 'ota' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.078 WARNING (MainThread) [supervisor.addons.options] Unknown option 'disable_automatic_update_check' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:28.078 WARNING (MainThread) [supervisor.addons.options] Unknown option 'advanced' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:28:30.768 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:28:30.775 INFO (SyncWorker_3) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:28:31.315 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:28:32.392 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:29:14.345 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:29:14.349 INFO (SyncWorker_7) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:29:14.891 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:29:15.969 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:29:57.913 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:29:57.917 INFO (SyncWorker_1) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:29:58.439 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:29:59.636 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:30:41.593 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:30:41.597 INFO (SyncWorker_1) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:30:42.082 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:30:43.364 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:31:25.352 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:31:25.355 INFO (SyncWorker_3) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:31:25.873 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:31:26.998 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:32:08.956 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:32:08.968 INFO (SyncWorker_3) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:32:09.515 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:32:10.565 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:32:52.525 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:32:52.529 INFO (SyncWorker_0) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:32:53.076 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:32:54.153 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:33:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'mqtt' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:33:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'homeassistant' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:33:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'permit_join' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:33:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'frontend' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:33:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'ota' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:33:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'disable_automatic_update_check' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:33:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'advanced' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:33:36.115 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon OpenThread Border Router is failed, restarting...
2024-10-28 16:33:36.119 INFO (SyncWorker_7) [supervisor.docker.manager] Cleaning addon_core_openthread_border_router application
2024-10-28 16:33:36.701 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-otbr with version 2.11.1
2024-10-28 16:33:37.836 INFO (MainThread) [supervisor.api.middleware.security] /network/info access from core_openthread_border_router
2024-10-28 16:34:19.786 ERROR (MainThread) [asyncio] Task exception was never retrieved
future: <Task finished name='Task-2511' coro=<Addon.watchdog_container() done, defined at /usr/src/supervisor/supervisor/addons/addon.py:1468> exception=AddonsJobError('Rate limit exceeded, more than 10 calls in 0:30:00')>
Traceback (most recent call last):
  File "/usr/src/supervisor/supervisor/addons/addon.py", line 1482, in watchdog_container
    await self._restart_after_problem(event.state)
  File "/usr/src/supervisor/supervisor/jobs/decorator.py", line 291, in wrapper
    raise on_condition(
supervisor.exceptions.AddonsJobError: Rate limit exceeded, more than 10 calls in 0:30:00
2024-10-28 16:38:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'mqtt' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:38:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'homeassistant' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:38:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'permit_join' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:38:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'frontend' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:38:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'ota' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:38:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'disable_automatic_update_check' for Zigbee2MQTT (45df7312_zigbee2mqtt)
2024-10-28 16:38:28.143 WARNING (MainThread) [supervisor.addons.options] Unknown option 'advanced' for Zigbee2MQTT (45df7312_zigbee2mqtt)

Anything in the add-on logs that might be useful for us?

-----------------------------------------------------------
 Add-on: OpenThread Border Router
 OpenThread Border Router add-on
-----------------------------------------------------------
 Add-on version: 2.11.1
 You are running the latest version of this add-on.
 System: Debian GNU/Linux 12 (bookworm)  (amd64 / qemux86-64)
 Home Assistant Core: 2024.10.4
 Home Assistant Supervisor: 2024.10.3
-----------------------------------------------------------
 Please, share the above information when looking for help
 or support in, e.g., GitHub, forums or the Discord chat.
-----------------------------------------------------------
s6-rc: info: service banner successfully started
s6-rc: info: service universal-silabs-flasher: starting
[16:29:15] INFO: Flashing firmware is disabled
s6-rc: info: service universal-silabs-flasher successfully started
s6-rc: info: service otbr-agent: starting
[16:29:16] INFO: Setup OTBR firewall...
[16:29:16] INFO: Starting otbr-agent...
[NOTE]-AGENT---: Running 0.3.0-ff7227ea-dirty
[NOTE]-AGENT---: Thread version: 1.3.0
[NOTE]-AGENT---: Thread interface: wpan0
[NOTE]-AGENT---: Radio URL: spinel+hdlc+uart:///dev/ttyUSB0?uart-baudrate=460800&uart-flow-control
[NOTE]-AGENT---: Radio URL: trel://enp1s0
[NOTE]-ILS-----: Infra link selected: enp1s0
[INFO]-RCP_HOS-: OpenThread log level changed to 5
49d.17:14:52.002 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:0, cmd:RESET
49d.17:14:52.002 [D] P-SpinelDrive-: Waiting response: key=0
49d.17:14:54.005 [W] P-SpinelDrive-: Wait for response timeout
49d.17:14:54.005 [I] P-SpinelDrive-: co-processor self reset successfully
49d.17:14:54.005 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:1, cmd:PROP_VALUE_GET, key:PROTOCOL_VERSION
49d.17:14:54.005 [D] P-SpinelDrive-: Waiting response: key=1
49d.17:14:56.007 [W] P-SpinelDrive-: Wait for response timeout
49d.17:14:56.007 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:1, cmd:PROP_VALUE_GET, key:PROTOCOL_VERSION
49d.17:14:56.007 [D] P-SpinelDrive-: Waiting response: key=1
49d.17:14:58.009 [W] P-SpinelDrive-: Wait for response timeout
49d.17:14:58.009 [C] Platform------: Init() at spinel_driver.cpp:82: Failure
49d.17:14:58.009 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:1, cmd:PROP_VALUE_GET, key:PROTOCOL_VERSION
49d.17:14:58.009 [D] P-SpinelDrive-: Waiting response: key=1
49d.17:15:00.011 [W] P-SpinelDrive-: Wait for response timeout
[16:29:54] WARNING: otbr-agent exited with code 1 (by signal 0).
Chain OTBR_FORWARD_INGRESS (0 references)
target     prot opt source               destination         
DROP       all  --  anywhere             anywhere             PKTTYPE = unicast
DROP       all  --  anywhere             anywhere             match-set otbr-ingress-deny-src src
ACCEPT     all  --  anywhere             anywhere             match-set otbr-ingress-allow-dst dst
DROP       all  --  anywhere             anywhere             PKTTYPE = unicast
ACCEPT     all  --  anywhere             anywhere            
otbr-ingress-deny-src
otbr-ingress-deny-src-swap
otbr-ingress-allow-dst
otbr-ingress-allow-dst-swap
Chain OTBR_FORWARD_EGRESS (0 references)
target     prot opt source               destination         
ACCEPT     all  --  anywhere             anywhere            
[16:29:54] INFO: OTBR firewall teardown completed.
s6-svlisten1: fatal: /run/s6-rc/servicedirs/otbr-agent failed permanently or its supervisor died
s6-rc: warning: unable to start service otbr-agent: command exited 1
s6-rc: info: service legacy-cont-init: stopping
s6-rc: info: service universal-silabs-flasher: stopping
s6-rc: info: service mdns: stopping
/run/s6/basedir/scripts/rc.init: warning: s6-rc failed to properly bring all the services up! Check your logs (in /run/uncaught-logs/current if you have in-container logging) for more information.
/run/s6/basedir/scripts/rc.init: fatal: stopping the container.
s6-rc: info: service universal-silabs-flasher successfully stopped
s6-rc: info: service banner: stopping
Default: mDNSResponder (Engineering Build) (Oct  7 2024 16:49:24) stopping
s6-rc: info: service banner successfully stopped
s6-rc: info: service legacy-cont-init successfully stopped
s6-rc: info: service fix-attrs: stopping
s6-rc: info: service fix-attrs successfully stopped
s6-rc: info: service s6rc-oneshot-runner: stopping
s6-rc: info: service s6rc-oneshot-runner successfully stopped
[16:29:54] INFO: mDNS ended with exit code 4 (signal 0)...
s6-rc: info: service mdns successfully stopped

Additional information

No response

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

1 participant