Since last week i have some strange behavior with some addons. First i thought it was the addon which was not working, but it look likes some new addons won’t work correctly. When i install a new addon, i can start it. Everything in the log files looks ok, it says addon has started, but when i go back to the infotab of the addon, the circle is red that the addon is not running, the start button is shown again, but when i clicked on start, nothing happens. There are no changes to the logfiles. Also if the app can show in the sidebar, when active and i tried to click on it, it shows addon is not active and i can start it. But also here, nothing happens.
Last try was AppDeamon, in the log it shows
“INFO AppDaemon: Configuration read from: /config/appdaemon.yaml”
And in supervisor log:
[supervisor.addons.addon] Creating Home Assistant add-on data folder /data/addons/data/a0d7b954_appdaemon
But i cannot find the files in my HA environment, the only thing supervisor shows is:
“24-03-21 22:03:04 WARNING (MainThread) [supervisor.addons.addon] Timeout while waiting for addon AppDaemon to start, took more than 120 seconds”
and
“24-03-21 22:04:44 WARNING (MainThread) [supervisor.addons.addon] Timeout while waiting for addon File editor to start, took more than 120 seconds”
But the addon log by itself shows it started with no errors.
All my previously installed addons work perfectly, can restart with no errors what so ever, but i tried to install Zigbee2MQTT and AppDeamon or File Editor, these kind of behavior is with these addons. I am afraid i can reinstall everything, but that is so annoying because i lose al the history of my energy, all configurations, etc.
Hope someone has an idea what the issue can be.
I will show the logs after install and start, but HA thinks it is not started.
File Editor:
> 6-rc: info: service s6rc-oneshot-runner: starting
> s6-rc: info: service s6rc-oneshot-runner successfully started
> s6-rc: info: service fix-attrs: starting
> s6-rc: info: service fix-attrs successfully started
> s6-rc: info: service legacy-cont-init: starting
> s6-rc: info: service legacy-cont-init successfully started
> s6-rc: info: service configurator: starting
> s6-rc: info: service configurator successfully started
> s6-rc: info: service legacy-services: starting
> s6-rc: info: service legacy-services successfully started
> INFO:2024-03-21 22:02:44,370:hass_configurator.configurator:Starting server
> INFO:2024-03-21 22:02:44,370:hass_configurator.configurator:Listening on: http://0.0.0.0:8099
> INFO:2024-03-21 22:03:14,066:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 -
> INFO:2024-03-21 22:03:44,141:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 -
> INFO:2024-03-21 22:04:14,213:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 -
> INFO:2024-03-21 22:04:44,290:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 -
Logfile Zigbee2MQTT
[> 22:13:20] INFO: Preparing to start...
> [22:13:20] INFO: Socat not enabled
> [22:13:20] INFO: Starting Zigbee2MQTT...
> Zigbee2MQTT:info 2024-03-21 22:13:22: Logging to console and directory: '/config/zigbee2mqtt/log/2024-03-21.22-13-22' filename: log.txt
> Zigbee2MQTT:info 2024-03-21 22:13:22: Starting Zigbee2MQTT version 1.36.0 (commit #unknown)
> Zigbee2MQTT:info 2024-03-21 22:13:22: Starting zigbee-herdsman (0.35.1)
> Zigbee2MQTT:info 2024-03-21 22:13:22: zigbee-herdsman started (resumed)
> Zigbee2MQTT:info 2024-03-21 22:13:22: Coordinator firmware version: '{"meta":{"maintrel":1,"majorrel":2,"minorrel":7,"product":1,"revision":20221226,"transportrev":2},"type":"zStack3x0"}'
> Zigbee2MQTT:info 2024-03-21 22:13:22: Currently 0 devices are joined:
> Zigbee2MQTT:info 2024-03-21 22:13:22: Zigbee: disabling joining new devices.
> Zigbee2MQTT:info 2024-03-21 22:13:22: Connecting to MQTT server at mqtt://core-mosquitto:1883
> Zigbee2MQTT:info 2024-03-21 22:13:23: Connected to MQTT server
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'zigbee2mqtt/bridge/state', payload '{"state":"online"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: Started frontend on port 8099
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/binary_sensor/1221051039810110150109113116116_0x00124b002a2e34e1/connection_state/config', payload '{"device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"device_class":"connectivity","entity_category":"diagnostic","name":"Connection state","object_id":"zigbee2mqtt_bridge_connection_state","origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"payload_off":"offline","payload_on":"online","state_topic":"zigbee2mqtt/bridge/state","unique_id":"bridge_0x00124b002a2e34e1_connection_state_zigbee2mqtt","value_template":"{{ value_json.state }}"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/binary_sensor/1221051039810110150109113116116_0x00124b002a2e34e1/restart_required/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"}],"availability_mode":"all","device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"device_class":"problem","enabled_by_default":false,"entity_category":"diagnostic","name":"Restart required","object_id":"zigbee2mqtt_bridge_restart_required","origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"payload_off":false,"payload_on":true,"state_topic":"zigbee2mqtt/bridge/info","unique_id":"bridge_0x00124b002a2e34e1_restart_required_zigbee2mqtt","value_template":"{{ value_json.restart_required }}"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/button/1221051039810110150109113116116_0x00124b002a2e34e1/restart/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"}],"availability_mode":"all","command_topic":"zigbee2mqtt/bridge/request/restart","device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"device_class":"restart","name":"Restart","object_id":"zigbee2mqtt_bridge_restart","origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"payload_press":"","unique_id":"bridge_0x00124b002a2e34e1_restart_zigbee2mqtt"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/select/1221051039810110150109113116116_0x00124b002a2e34e1/log_level/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"}],"availability_mode":"all","command_template":"{\"options\": {\"advanced\": {\"log_level\": \"{{ value }}\" } } }","command_topic":"zigbee2mqtt/bridge/request/options","device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"entity_category":"config","name":"Log level","object_id":"zigbee2mqtt_bridge_log_level","options":["info","warn","error","debug"],"origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/bridge/info","unique_id":"bridge_0x00124b002a2e34e1_log_level_zigbee2mqtt","value_template":"{{ value_json.log_level | lower }}"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/sensor/1221051039810110150109113116116_0x00124b002a2e34e1/version/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"}],"availability_mode":"all","device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"entity_category":"diagnostic","icon":"mdi:zigbee","name":"Version","object_id":"zigbee2mqtt_bridge_version","origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/bridge/info","unique_id":"bridge_0x00124b002a2e34e1_version_zigbee2mqtt","value_template":"{{ value_json.version }}"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/sensor/1221051039810110150109113116116_0x00124b002a2e34e1/coordinator_version/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"}],"availability_mode":"all","device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"enabled_by_default":false,"entity_category":"diagnostic","icon":"mdi:chip","name":"Coordinator version","object_id":"zigbee2mqtt_bridge_coordinator_version","origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/bridge/info","unique_id":"bridge_0x00124b002a2e34e1_coordinator_version_zigbee2mqtt","value_template":"{{ value_json.coordinator.meta.revision }}"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/sensor/1221051039810110150109113116116_0x00124b002a2e34e1/network_map/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"}],"availability_mode":"all","device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"enabled_by_default":false,"entity_category":"diagnostic","json_attributes_template":"{{ value_json.data.value | tojson }}","json_attributes_topic":"zigbee2mqtt/bridge/response/networkmap","name":"Network map","object_id":"zigbee2mqtt_bridge_network_map","origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/bridge/response/networkmap","unique_id":"bridge_0x00124b002a2e34e1_network_map_zigbee2mqtt","value_template":"{{ now().strftime('%Y-%m-%d %H:%M:%S') }}"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/sensor/1221051039810110150109113116116_0x00124b002a2e34e1/permit_join_timeout/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"}],"availability_mode":"all","device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"device_class":"duration","entity_category":"diagnostic","name":"Permit join timeout","object_id":"zigbee2mqtt_bridge_permit_join_timeout","origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"state_topic":"zigbee2mqtt/bridge/info","unique_id":"bridge_0x00124b002a2e34e1_permit_join_timeout_zigbee2mqtt","unit_of_measurement":"s","value_template":"{{ iif(value_json.permit_join_timeout is defined, value_json.permit_join_timeout, None) }}"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'homeassistant/switch/1221051039810110150109113116116_0x00124b002a2e34e1/permit_join/config', payload '{"availability":[{"topic":"zigbee2mqtt/bridge/state","value_template":"{{ value_json.state }}"}],"availability_mode":"all","command_topic":"zigbee2mqtt/bridge/request/permit_join","device":{"hw_version":"zStack3x0 20221226","identifiers":["zigbee2mqtt_bridge_0x00124b002a2e34e1"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.36.0"},"icon":"mdi:human-greeting-proximity","name":"Permit join","object_id":"zigbee2mqtt_bridge_permit_join","origin":{"name":"Zigbee2MQTT","sw":"1.36.0","url":"https://www.zigbee2mqtt.io"},"payload_off":"false","payload_on":"true","state_topic":"zigbee2mqtt/bridge/info","unique_id":"bridge_0x00124b002a2e34e1_permit_join_zigbee2mqtt","value_template":"{{ value_json.permit_join | lower }}"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: MQTT publish: topic 'zigbee2mqtt/bridge/state', payload '{"state":"online"}'
> Zigbee2MQTT:info 2024-03-21 22:13:23: Zigbee2MQTT started!
AppDeamon Log:
> s6-rc: info: service s6rc-oneshot-runner: starting
> s6-rc: info: service s6rc-oneshot-runner successfully started
> s6-rc: info: service base-addon-banner: starting
>
> -----------------------------------------------------------
> Add-on: AppDaemon
> Python Apps and Dashboard using AppDaemon 4.x for Home Assistant
> -----------------------------------------------------------
> Add-on version: 0.16.4
> You are running the latest version of this add-on.
> System: Home Assistant OS 12.1 (amd64 / qemux86-64)
> Home Assistant Core: 2024.3.1
> Home Assistant Supervisor: 2024.03.0
> -----------------------------------------------------------
> Please, share the above information when looking for help
> or support in, e.g., GitHub, forums or the Discord chat.
> -----------------------------------------------------------
> s6-rc: info: service base-addon-banner successfully started
> s6-rc: info: service fix-attrs: starting
> s6-rc: info: service base-addon-log-level: starting
> s6-rc: info: service fix-attrs successfully started
> s6-rc: info: service base-addon-log-level successfully started
> s6-rc: info: service legacy-cont-init: starting
> s6-rc: info: service legacy-cont-init successfully started
> s6-rc: info: service init-appdaemon: starting
> s6-rc: info: service init-appdaemon successfully started
> s6-rc: info: service appdaemon: starting
> s6-rc: info: service appdaemon successfully started
> s6-rc: info: service legacy-services: starting
> [22:01:04] INFO: Starting AppDaemon...
> s6-rc: info: service legacy-services successfully started
> 2024-03-21 22:01:06.352959 INFO AppDaemon: AppDaemon Version 4.4.2 starting
> 2024-03-21 22:01:06.353091 INFO AppDaemon: Python version is 3.11.6
> 2024-03-21 22:01:06.353212 INFO AppDaemon: Configuration read from: /config/appdaemon.yaml
> 2024-03-21 22:01:06.353307 INFO AppDaemon: Added log: AppDaemon
> 2024-03-21 22:01:06.353445 INFO AppDaemon: Added log: Error
> 2024-03-21 22:01:06.353512 INFO AppDaemon: Added log: Access
> 2024-03-21 22:01:06.353579 INFO AppDaemon: Added log: Diag
> 2024-03-21 22:01:06.454704 INFO AppDaemon: Loading Plugin HASS using class HassPlugin from module hassplugin
> 2024-03-21 22:01:06.555258 INFO HASS: HASS Plugin Initializing
> 2024-03-21 22:01:06.555371 WARNING HASS: ha_url not found in HASS configuration - module not initialized
> 2024-03-21 22:01:06.555476 INFO HASS: HASS Plugin initialization complete
> 2024-03-21 22:01:06.555762 INFO AppDaemon: Initializing HTTP
> 2024-03-21 22:01:06.555973 INFO AppDaemon: Using 'ws' for event stream
> 2024-03-21 22:01:06.558043 INFO AppDaemon: Starting API
> 2024-03-21 22:01:06.559128 INFO AppDaemon: Starting Admin Interface
> 2024-03-21 22:01:06.559310 INFO AppDaemon: Starting Dashboards
> 2024-03-21 22:01:06.566250 INFO HASS: Connected to Home Assistant 2024.3.1
> 2024-03-21 22:01:06.573661 INFO AppDaemon: App 'hello_world' added
> 2024-03-21 22:01:06.574291 INFO AppDaemon: Found 1 active apps
> 2024-03-21 22:01:06.574436 INFO AppDaemon: Found 0 inactive apps
> 2024-03-21 22:01:06.574602 INFO AppDaemon: Found 0 global libraries
> 2024-03-21 22:01:06.574728 INFO AppDaemon: Starting Apps with 1 workers and 1 pins
> 2024-03-21 22:01:06.575167 INFO AppDaemon: Running on port 5050
> 2024-03-21 22:01:06.594968 INFO HASS: Evaluating startup conditions
> 2024-03-21 22:01:06.599740 INFO HASS: Startup condition met: hass state=RUNNING
> 2024-03-21 22:01:06.599942 INFO HASS: All startup conditions met
> 2024-03-21 22:01:06.620343 INFO AppDaemon: Got initial state from namespace default
> 2024-03-21 22:01:08.578570 INFO AppDaemon: Scheduler running in realtime
> 2024-03-21 22:01:08.580303 INFO AppDaemon: Adding /config/apps to module import path
> 2024-03-21 22:01:08.581528 INFO AppDaemon: Loading App Module: /config/apps/hello.py
> 2024-03-21 22:01:08.599920 INFO AppDaemon: Loading app hello_world using class HelloWorld from module hello
> 2024-03-21 22:01:08.601004 INFO AppDaemon: Calling initialize() for hello_world
> 2024-03-21 22:01:08.636933 INFO hello_world: Hello from AppDaemon
> 2024-03-21 22:01:08.637551 INFO hello_world: You are now ready to run Apps!
> 2024-03-21 22:01:08.638314 INFO AppDaemon: App initialization complete