Grosse fuite mémoire...

Forum dédié au plugin ZigBeeForDomoticZ : installation, paramétrage, utilisation, interfaces ...
lost
Messages : 1511
Inscription : 12 nov. 2016, 11:01

Grosse fuite mémoire...

Message par lost »

Hello,
Plusieurs pb depuis cette semaine, avec en 1er symptôme la SD qui ne réponds plus faute à trop d'IO:

Code : Tout sélectionner

INFO: task kworker/2:0:54347 blocked for more than 120 seconds.
(...)
Workqueue: events_freezable mmc_rescan
Ceci est du au fait que raspberry OS vous crée un fichier de swap (/var/swap) même si vous avez évité soigneusement de créer une partition de swap. Je l'ignorais. En conséquence quand le système manque de mémoire il swap et si c'est bien intensif/continu à un moment la SD cale...

Puis derrière, dans la demi-heure, l'oom-killer tue domoticz qui consomme en effet bcp de mémoire.
Les logs capteur de % mémoire du PI montent en effet au delà de 90% linéairement, alors que historiquement je restais dans les 50%. J'ai plusieurs cycles de telles montées avant reboot, qu'un script perso de surveillance sur un cron toutes les demi-heures déclenche alors car domoticz a tué par l'oom-killer et ne réponds plus.
MemUsage.png
MemUsage.png (127.95 Kio) Consulté 1135 fois
1er épisode, jeudi dernier/19 juin.

Après redémarrage la commande:

Code : Tout sélectionner

top -p <PID_Domoticz>
Confirme: Dixième de % après dixième de %, l'usage mémoire de domoticz monte de ~20% pour se rapprocher en 1 à 2h de 50%.

Je me suis alors rappelé que j'avais souvent le widget du plugin indiquant longuement busy ces derniers temps.
Bingo: Désactivation du plugin côté matériel dans la webUI domoticz et la commande ci dessus qui tournait en continu me remets instantanément à 20%.

A regarder les logs, j'ai énormément de ZIGBEE_DELIVERY_FAILED. Il y a donc sans doute un pb de fonctionnement voir matériel, mais bizarre que la mémoire utilisée monte alors ainsi.

Au besoin, je pourrais filer les logs complets du plugin en MP. Je suis sur la dernière version stable.

En tout cas, à regarder ces derniers jours, les hausses d'usage mémoire collent avec le plugin qui râle et ne s'arrête plus (même si des épisodes plus limités existent par ailleurs niveau ZIGBEE_DELIVERY_FAILED) jamais, exemple du début de l'épisode de ce matin, qui dure jusqu'à saturation mémoire, oom qui kill domoticz puis mon script/cron qui reboot quand il voit le souci... qui repars ensuite:

Code : Tout sélectionner

(...)
2025-06-21 08:02:03,529 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 08:02:28,035 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0;233160'
2025-06-21 08:02:41,398 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 08:02:43,895 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\x81\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 08:02:44,617 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 08:02:45,547 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\x81\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 08:02:47,209 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\x81\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"

(... début de la fin...)

2025-06-21 08:49:50,126 INFO    :b"Warning while submitting - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0x702 payload: b'\\x10-\\x00\\x00\\x03' AckIsDisable: True extended_timeo
ut: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 08:49:59,418 WARNING :Executing <Task pending name='Task-1' coro=<start_zigpy_task() running at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:162> wait
_for=<Future pending cb=[<TaskWakeupMethWrapper object at 0x7eeb7e2850>()] created at /usr/lib/python3.9/asyncio/base_events.py:424> cb=[_run_until_complete_cb() at /usr/lib/python3.9/asyncio/base_e
vents.py:184] created at /usr/lib/python3.9/asyncio/base_events.py:621> took 8.361 seconds
2025-06-21 08:49:59,534 WARNING :+ Connection to the radio was lost: <class 'bellows.ash.NcpFailure'> <NcpFailure(code=<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>)>
2025-06-21 08:49:59,536 ERROR   :NCP reset due to exceeded maximum ACK timeout count, plugin restart required
2025-06-21 08:49:59,611 ERROR   : [ ZigpyCom_47 1173] [           Plugin] Connection lost with coordinator, restarting plugin
2025-06-21 08:49:59,849 DEBUG   :Starting new HTTPS connection (1): z4d.pipiche.net:443
2025-06-21 08:50:02,626 DEBUG   :https://z4d.pipiche.net:443 "GET /matomo.php?idsite=9&rec=1&apiv=1&action_name=Plugin+Action&uid=686dcc3fbf0e02b45dd8ff5ac44d78e7070d2ec9b6294ce7cebfbbc03d9e8126&e_c
=Plugin&e_a=Restart&e_n=Plugin+Restart HTTP/1.1" 200 43
2025-06-21 08:50:03,114 WARNING :Executing <Handle ThreadsafeProxy.__getattr__.<locals>.func_wrapper.<locals>.check_result_wrapper() at /usr/local/lib/python3.9/dist-packages/bellows/thread.py:110 c
reated at /usr/local/lib/python3.9/dist-packages/bellows/thread.py:120> took 3.599 seconds
2025-06-21 08:50:03,382 WARNING :Executing <Task pending name='watchdog_loop' coro=<ControllerApplication._watchdog_loop() running at /usr/local/lib/python3.9/dist-packages/bellows/zigbee/applicatio
n.py:988> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/lib/python3.9/asyncio/futures.py:384, <TaskWakeupMethWrapper object at 0x7edf421820>()] created at /usr/lib
/python3.9/asyncio/base_events.py:424> created at /usr/lib/python3.9/asyncio/tasks.py:361> took 0.235 seconds
2025-06-21 08:50:03,418 WARNING :+ Connection to the radio was lost: <class 'bellows.ash.NcpFailure'> <NcpFailure(code=<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>)>
2025-06-21 08:50:03,419 WARNING :+ shutdown or restart in progress
2025-06-21 08:50:03,420 WARNING :+ Connection to the radio was lost: <class 'bellows.ash.NcpFailure'> <NcpFailure(code=<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>)>
2025-06-21 08:50:03,421 WARNING :+ shutdown or restart in progress

(...)

2025-06-21 08:50:03,430 WARNING :+ Connection to the radio was lost: <class 'bellows.ash.NcpFailure'> <NcpFailure(code=<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>)>
2025-06-21 08:50:03,430 WARNING :+ shutdown or restart in progress
2025-06-21 08:50:03,431 WARNING :+ Connection to the radio was lost: <class 'bellows.ash.NcpFailure'> <NcpFailure(code=<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>)>
2025-06-21 08:50:03,431 WARNING :+ shutdown or restart in progress
2025-06-21 08:50:03,438 WARNING :Watchdog failure
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/dist-packages/zigpy/application.py", line 661, in _watchdog_loop
    await self.watchdog_feed()
  File "/usr/local/lib/python3.9/dist-packages/zigpy/application.py", line 647, in watchdog_feed
    await self._watchdog_feed()
  File "/usr/local/lib/python3.9/dist-packages/bellows/zigbee/application.py", line 1004, in _watchdog_feed
    current_counters = await self._ezsp.read_counters()
  File "/usr/local/lib/python3.9/dist-packages/bellows/ezsp/v4/__init__.py", line 191, in read_counters
    (res,) = await self.readCounters()
  File "/usr/local/lib/python3.9/dist-packages/bellows/ezsp/protocol.py", line 129, in command
    await self._gw.send_data(data)
  File "/usr/local/lib/python3.9/dist-packages/bellows/uart.py", line 31, in send_data
    await self._transport.send_data(data)
  File "/usr/local/lib/python3.9/dist-packages/bellows/ash.py", line 708, in send_data
    await asyncio.shield(
  File "/usr/local/lib/python3.9/dist-packages/bellows/ash.py", line 633, in _send_data_frame
    raise NcpFailure(
bellows.ash.NcpFailure: NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT
2025-06-21 08:50:03,538 WARNING :+ Connection to the radio was lost: <class 'bellows.ash.NcpFailure'> <NcpFailure(code=<NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT: 81>)>
2025-06-21 08:50:03,538 WARNING :+ shutdown or restart in progress
2025-06-21 08:50:03,539 WARNING :Executing <Task finished name='watchdog_loop' coro=<ControllerApplication._watchdog_loop() done, defined at /usr/local/lib/python3.9/dist-packages/bellows/zigbee/app
lication.py:985> result=None created at /usr/lib/python3.9/asyncio/tasks.py:361> took 0.103 seconds
2025-06-21 08:50:03,667 INFO    :b"Warning while submitting - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0x702 payload: b'\\x10.\\x00\\x00\\x03' AckIsDisable: True extended_timeo
ut: False Attempt: 1 Exception: 'NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT' (NcpFailure)"
2025-06-21 08:50:03,686 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0x702 payload: b'\\x08\\x82\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT' (NcpFailure)"
2025-06-21 08:50:03,708 INFO    :b"Warning while submitting - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0x702 payload: b'\\x10/\\x00\\x00\\x03' AckIsDisable: True extended_timeo
ut: False Attempt: 1 Exception: 'NcpResetCode.ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT' (NcpFailure)"

(... et ca continue jusqu'au redémarrage, mais derrière pas mieux hélas...)

2025-06-21 08:50:11,011 INFO    :b"Warning while submitting - rawaps_read_attribute_req a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0x702 payload: b'\\x10 \\x00\\x00\\x03' AckIsDisable: True extended_timeo
ut: False Attempt: 1 Exception: 'ApplicationController is not running' (ControllerError)"
2025-06-21 08:50:11,015 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0x702 payload: b'\\x08\\x82\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'ApplicationController is not running' (ControllerError)"
2025-06-21 08:50:31,221 INFO    :b'Cancelling 26046 outstanding tasks'
2025-06-21 08:50:33,615 WARNING :Executing <Task pending name='Task-1' coro=<start_zigpy_task() running at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:191> wait
_for=<_GatheringFuture pending cb=[<TaskWakeupMethWrapper object at 0x7edec0cd30>()] created at /usr/lib/python3.9/asyncio/tasks.py:704> cb=[_run_until_complete_cb() at /usr/lib/python3.9/asyncio/ba
se_events.py:184] created at /usr/lib/python3.9/asyncio/base_events.py:621> took 22.237 seconds
2025-06-21 08:50:35,713 WARNING :Executing <Task cancelled name='_unicast_command-rawaps_read_attribute_req-<Device model=None manuf=None nwk=0x3D46 ieee=a4:c1:38:57:6d:40:24:ff is_initialized=False
>-1794-0' coro=<measure_execution_time.<locals>.wrapper() done, defined at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:742> created at /usr/lib/python3.9/asynci
o/tasks.py:361> took 0.857 seconds
2025-06-21 08:50:37,324 WARNING :Executing <Task cancelled name='_unicast_command-zcl_raw_default_response-<Device model=None manuf=None nwk=0x3D46 ieee=a4:c1:38:57:6d:40:24:ff is_initialized=False>
-1794-130' coro=<measure_execution_time.<locals>.wrapper() done, defined at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:742> created at /usr/lib/python3.9/async
io/tasks.py:361> took 0.674 seconds
2025-06-21 08:50:37,959 WARNING :Executing <Task cancelled name='_unicast_command-zcl_raw_default_response-<Device model=None manuf=None nwk=0x3D46 ieee=a4:c1:38:57:6d:40:24:ff is_initialized=False>
-1794-130' coro=<measure_execution_time.<locals>.wrapper() done, defined at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:742> created at /usr/lib/python3.9/async
io/tasks.py:361> took 0.139 seconds
2025-06-21 08:50:39,199 WARNING :Executing <Task cancelled name='_unicast_command-zcl_raw_default_response-<Device model=None manuf=None nwk=0x3D46 ieee=a4:c1:38:57:6d:40:24:ff is_initialized=False>
-1794-130' coro=<measure_execution_time.<locals>.wrapper() done, defined at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:742> created at /usr/lib/python3.9/async
io/tasks.py:361> took 0.160 seconds
2025-06-21 08:50:41,149 WARNING :Executing <Task cancelled name='_unicast_command-zcl_raw_default_response-<Device model=None manuf=None nwk=0x3D46 ieee=a4:c1:38:57:6d:40:24:ff is_initialized=False>
-1794-130' coro=<measure_execution_time.<locals>.wrapper() done, defined at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:742> created at /usr/lib/python3.9/async
io/tasks.py:361> took 0.582 seconds
2025-06-21 08:50:43,513 WARNING :Executing <Task cancelled name='_unicast_command-rawaps_read_attribute_req-<Device model=None manuf=None nwk=0x3D46 ieee=a4:c1:38:57:6d:40:24:ff is_initialized=False
>-1794-0' coro=<measure_execution_time.<locals>.wrapper() done, defined at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:742> created at /usr/lib/python3.9/asynci
o/tasks.py:361> took 1.057 seconds
2025-06-21 09:03:11,039 INFO    :b'Z4D is starting with stable7-7.1.022'
2025-06-21 09:03:11,063 INFO    :b'Z4D Database found: DeviceList-47.txt'
2025-06-21 09:03:11,064 INFO    :b'Z4D Certified devices database /usr/local/lib/python3.9/dist-packages/z4d_certified_devices/'
2025-06-21 09:03:11,065 INFO    :b'Z4D loads ZCL Cluster definitions'
2025-06-21 09:03:11,174 INFO    :b'Z4D loaded 16 configuration from legacy database.'
2025-06-21 09:03:11,180 INFO    :b'++ Overwrite standard configuration model HK-SENSOR-4IN1-A with /home/domo/domoticz/plugins/Domoticz-Zigbee/Conf/Local-Devices/HK-SENSOR-4IN1-A.json'
2025-06-21 09:03:11,181 INFO    :b'Z4D loads 1 configuration from the local certified Db.'
2025-06-21 09:03:12,475 INFO    :b'Z4D loads 644 certified devices from repository version [6.465]'
2025-06-21 09:03:12,476 INFO    :b'Z4D loading plugin database'
2025-06-21 09:03:12,701 INFO    :b'Z4D loads 7 entries from /home/domo/domoticz/plugins/Domoticz-Zigbee/Data/DeviceList-47.txt'
2025-06-21 09:03:12,731 INFO    :b"Z4D is starting transport Mode: 'ZigpyEZSP' Serial: '/dev/ttyUSB11' IP: '0.0.0.0 'Port: '9999'"
2025-06-21 09:03:16,202 INFO    :b'Z4D starting EZSP'
2025-06-21 09:03:16,204 INFO    :b'zigpyThread starting with a random sleep'
2025-06-21 09:03:16,207 INFO    :b'Z4D starting WebUI on port 9440'
2025-06-21 09:03:16,257 INFO    :b'WebUI - server starting on 0.0.0.0 9440'
2025-06-21 09:03:16,258 INFO    :b'++ WebUI - create socket'
2025-06-21 09:03:16,265 INFO    :b'++ WebUI - SSL Certificate /home/domo/domoticz/plugins/Domoticz-Zigbee/certs/server.crt'
2025-06-21 09:03:16,267 INFO    :b'++ WebUI - SSL Private key /home/domo/domoticz/plugins/Domoticz-Zigbee/certs/server.key'
2025-06-21 09:03:16,267 INFO    :b"Certificate file '/home/domo/domoticz/plugins/Domoticz-Zigbee/certs/server.crt' does not exist."
2025-06-21 09:03:16,283 INFO    :b'++ WebUI - bin socket on 0.0.0.0:9440'
2025-06-21 09:03:16,286 INFO    :b'WebUI Server started on 0.0.0.0:9440'
2025-06-21 09:03:16,700 INFO    :b'Plugin looks to upgrade the Certified Device package'
2025-06-21 09:03:18,727 DEBUG   :Using selector: EpollSelector
2025-06-21 09:03:19,761 INFO    :b'++ Enables boost power mode and the alternate transmitter output.'
2025-06-21 09:03:19,762 INFO    :b'++ Started radio ezsp port: /dev/ttyUSB11'
2025-06-21 09:03:19,767 INFO    :b'++ Use of Zigpy Persistent Db'
2025-06-21 09:03:19,798 WARNING :Executing <Task pending name='Task-1' coro=<start_zigpy_task() running at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:153> wait
_for=<Future pending cb=[<TaskWakeupMethWrapper object at 0x7f58d506a0>()] created at /usr/lib/python3.9/asyncio/base_events.py:424> cb=[_run_until_complete_cb() at /usr/lib/python3.9/asyncio/base_e
vents.py:184] created at /usr/lib/python3.9/asyncio/base_events.py:621> took 1.038 seconds
2025-06-21 09:03:23,258 DEBUG   :Using selector: EpollSelector
2025-06-21 09:03:25,071 INFO    :b'++ EZSP Radio register default Ep'
2025-06-21 09:03:25,131 INFO    :b"AppGeneric:initialize auto_form: True force_form: False Class: <class 'Classes.ZigpyTransport.AppBellows.App_bellows'> Logger: <Logger Classes.ZigpyTransport.AppGe
neric (WARNING)>"
2025-06-21 09:03:27,519 INFO    :b"++ EZSP Configuration {'device': {'path': '/dev/ttyUSB11', 'baudrate': 115200, 'flow_control': None}, 'network': {'channel': 20, 'tc_link_key': 5a:69:67:42:65:65:4
1:6c:6c:69:61:6e:63:65:30:39, 'key': None, 'channels': <Channels.CHANNEL_25|CHANNEL_20|CHANNEL_15|CHANNEL_11: 34637824>, 'pan_id': None, 'update_id': 0, 'tc_address': None, 'key_sequence_number': 0,
 'extended_pan_id': None}, 'ezsp_config': {'CONFIG_TX_POWER_MODE': 3}, 'ota': {'enabled': False, 'broadcast_enabled': True, 'providers': [Ledvance(url='https://api.update.ledvance.com/v1/zigbee/firm
wares', manufacturer_ids=(4489, 4364)), Sonoff(url=None, manufacturer_ids=(4742,)), Inovelli(url=None, manufacturer_ids=(4655,)), ThirdReality(url=None, manufacturer_ids=(4659, 4877, 5127))], 'extra
_providers': [], 'broadcast_interval': 14040.0, 'disable_default_providers': [], 'broadcast_initial_delay': 14040.0}, 'handle_unknown_devices': True, 'source_routing': False, 'topology_scan_enabled'
: True, 'database_path': ':memory:', 'topology_scan_period': 720, 'backup_enabled': True, 'backup_period': 1, 'use_thread': True, 'bellows_config': {'manual_source_routing': False}, 'watchdog_enable
d': True, 'max_watchdog_failures': 4, 'max_retries': 2, 'max_concurrent_requests': 8, 'topology_scan_skip_coordinator': False, 'ezsp_policies': {}, 'validate_network_settings': False, 'additional_en
dpoints': []}"
2025-06-21 09:03:27,522 INFO    :b'Number of devices recently active in Coordinator = 0'
2025-06-21 09:03:27,628 INFO    :b'++ EZSP Board Information'
2025-06-21 09:03:27,631 INFO    :b'++   Radio manufacturer : Elelabs'
2025-06-21 09:03:27,637 INFO    :b'++   Radio board name   : ELU0142'
2025-06-21 09:03:27,638 INFO    :b'++   EmberZNet version  : 6.10.3.0 build 297'
2025-06-21 09:03:27,640 INFO    :b'++   Protocol Version   : 8'
2025-06-21 09:03:27,642 INFO    :b'++ Network settings'
2025-06-21 09:03:27,646 INFO    :b'++   Device IEEE        : 28:db:a7:ff:fe:86:37:f8'
2025-06-21 09:03:27,647 INFO    :b'++   Device NWK         : 0x0000'
2025-06-21 09:03:27,650 INFO    :b'++   Network Update Id  : 0x0002'
2025-06-21 09:03:27,653 INFO    :b'++   PAN ID             : 0x71F8'
2025-06-21 09:03:27,654 INFO    :b'++   Extended PAN ID    : 2c:c3:ad:bd:c1:e4:4b:13'
2025-06-21 09:03:27,656 INFO    :b'++   Channel            : 20'
2025-06-21 09:03:27,658 INFO    :b'Elelabs, ELU01x'
2025-06-21 09:03:27,660 INFO    :b'Installer Version Number: 6.10.3.0 build 297'
2025-06-21 09:03:27,664 INFO    :b'Branch Version: ==> Elelabs, ELU01x <=='
2025-06-21 09:03:27,671 INFO    :b'Zigbee Coordinator ieee: 28dba7fffe8637f8 , short addr: 0000'
2025-06-21 09:03:27,673 INFO    :b'Network state UP, PANID: 71f8 extPANID: 0x2cc3adbdc1e44b13 Channel: 20'
2025-06-21 09:03:29,026 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:235.0'
2025-06-21 09:03:29,042 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0.0;233160'
2025-06-21 09:03:29,107 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0;233160'
2025-06-21 09:03:29,480 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:29,662 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:30,106 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 09:03:30,125 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:30,215 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:30,666 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 09:03:30,684 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:30,781 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:31,098 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:232.0'
2025-06-21 09:03:31,109 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:31,208 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:31,755 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 09:03:31,773 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:31,868 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:32,317 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:32,418 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:32,753 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:32,849 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:33,299 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:33,395 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:33,748 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:33,834 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:03:34,177 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 09:03:34,204 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 09:03:40,315 INFO    :b'Certified Device package upgrade results'
2025-06-21 09:03:40,316 INFO    :b'Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple'
2025-06-21 09:03:40,317 INFO    :b'Requirement already satisfied: z4d-certified-devices in /usr/local/lib/python3.9/dist-packages (6.465)'
2025-06-21 09:03:40,317 INFO    :b'Collecting z4d-certified-devices'
2025-06-21 09:03:40,318 INFO    :b'  Using cached z4d_certified_devices-6.465-py3-none-any.whl (445 kB)'
2025-06-21 09:03:40,318 INFO    :b'  Using cached z4d_certified_devices-6.464-py3-none-any.whl (446 kB)'
2025-06-21 09:03:40,319 INFO    :b''
2025-06-21 09:03:40,319 INFO    :b'Z4D Widgets usage is at 9.4% (231 units free)'
2025-06-21 09:03:40,320 INFO    :b'Z4D started with Domoticz legacy Framework'
2025-06-21 09:03:49,085 INFO    :b'Z4D closed the Zigbee network'
2025-06-21 09:03:49,161 INFO    :b'++ opening zigbee network for 0 secondes on specific router None'
2025-06-21 09:03:54,101 INFO    :b'Switch Blue Led On'
2025-06-21 09:03:54,102 INFO    :b'Z4D coordinator set to Certification : 1/CE -> CE'
2025-06-21 09:03:54,104 INFO    :b'Z4D starts Configure Reporting handling'
2025-06-21 09:03:54,108 INFO    :b'Z4D starts Over-The-Air Management'
2025-06-21 09:03:55,762 INFO    :b'Z4D loads the firmware images'
2025-06-21 09:03:55,763 INFO    :b'Z4D with Zigpy, coordinator Elelabs, ELU01x, firmware 6.10.3.0 build 297 communication confirmed.'
2025-06-21 09:03:55,764 INFO    :b'Z4D sending analytics information. (if you need to disable, disable the MatomoOptIn parameter via the WebUI - Settings)'
2025-06-21 09:03:55,773 DEBUG   :Starting new HTTPS connection (1): z4d.pipiche.net:443
2025-06-21 09:03:56,228 DEBUG   :https://z4d.pipiche.net:443 "GET /matomo.php?idsite=9&rec=1&apiv=1&action_name=Plugin+Action&uid=686dcc3fbf0e02b45dd8ff5ac44d78e7070d2ec9b6294ce7cebfbbc03d9e8126&e_c
=Plugin&e_a=Started&e_n=Plugin+Started HTTP/1.1" 200 43
2025-06-21 09:03:56,419 DEBUG   :Starting new HTTPS connection (1): z4d.pipiche.net:443
2025-06-21 09:03:56,873 DEBUG   :https://z4d.pipiche.net:443 "GET /matomo.php?idsite=9&rec=1&apiv=1&action_name=Z4DPluginInfos&uid=686dcc3fbf0e02b45dd8ff5ac44d78e7070d2ec9b6294ce7cebfbbc03d9e8126&di
mension1=2025.1&dimension2=Elelabs+ELU01x&dimension3=7.1.022&dimension4=Ezsp+-+6.10.3.0+build+297&dimension5=Small&dimension6=6.465&dimension7=Debian+GNU+Linux+11&dimension8=python+3.9.2+arch+64bit+
machine+aarch64+processor&dimension9=1+day&dimension11=Raspberry+Pi+3+Model+B+Rev+1.2 HTTP/1.1" 200 43
2025-06-21 09:04:00,150 INFO    :b"is_zigate_firmware_available <class 'str'>, <class 'str'>, <class 'int'>, <class 'int'>"
2025-06-21 09:04:50,113 INFO    :b"Warning while submitting - rawaps_write_attribute_req a4:c1:38:72:60:14:1f:26/0x50d1 0x104 0x500 payload: b'\\x10\\x01\\x02\\x13\\x00 \\x03' AckIsDisable: False ex
tended_timeout: True Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:04:50,462 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.1'
2025-06-21 09:04:55,061 INFO    :b"Warning while submitting - rawaps_write_attribute_req a4:c1:38:ca:6d:29:0e:d6/0x944b 0x104 0x500 payload: b'\\x10\\x01\\x02\\x13\\x00 \\x03' AckIsDisable: False ex
tended_timeout: True Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:04:55,115 INFO    :b"Warning while submitting - rawaps_write_attribute_req a4:c1:38:45:2a:67:6c:6e/0x7d8b 0x104 0x500 payload: b'\\x10\\x01\\x02\\x13\\x00 \\x00' AckIsDisable: False ex
tended_timeout: True Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:04:55,878 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:236.0'
2025-06-21 09:05:08,483 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:7;42300'
2025-06-21 09:05:50,377 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:235.0'
2025-06-21 09:05:53,049 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\xed\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:05:53,576 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 09:05:54,691 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\xed\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:05:56,332 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\xed\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:05:57,988 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\xed\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:05:59,633 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\xed\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:06:01,273 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\xed\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:06:02,919 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\xed\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 09:06:04,720 WARNING :Executing <Task pending name='Task-1' coro=<start_zigpy_task() running at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:162> wait
_for=<Future pending cb=[<TaskWakeupMethWrapper object at 0x7f5841d1f0>()] created at /usr/lib/python3.9/asyncio/base_events.py:424> cb=[_run_until_complete_cb() at /usr/lib/python3.9/asyncio/base_e
vents.py:184] created at /usr/lib/python3.9/asyncio/base_events.py:621> took 0.249 seconds
2025-06-21 09:06:04,745 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:57:6d:40:24:ff/0x3d46 0x104 0xB04 payload: b'\\x08\\xed\\x0b\\n\\x00' AckIsDisable: True extended_time
out: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
EDIT: Après l'épisode, un autre en milieu d'a.m. après aussi une longue agonie... je décide de retenter après plus de 2h d'arrêt (cf ci dessous, extrait avec fin d'arrêt plugin à 15h10 et redémarrage à 17h31... A noter, c'est peut-être important, qu'il y a eu un débranchement/rebranchement du dongle zigbee dans l'intervale) et cela semble repartir mieux, même si 1 delivery failed tout de même.
Faire tilter qq capteurs de vibration et commandes prises zigbee et tout semble OK:

Code : Tout sélectionner

2025-06-21 15:09:43,123 INFO    :b'Coordinator backup is available: /home/domo/domoticz/plugins/Domoticz-Zigbee/Data/Coordinator-47.backup'
2025-06-21 15:09:43,144 WARNING :+ Connection to the radio was lost: <class 'NoneType'> None
2025-06-21 15:09:43,145 WARNING :+ shutdown or restart in progress
2025-06-21 15:09:54,118 INFO    :b'Cancelling 17696 outstanding tasks'
2025-06-21 15:09:54,550 WARNING :Executing <Task pending name='Task-1' coro=<start_zigpy_task() running at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:191> wait_for=<_GatheringFuture pending cb=[<TaskWakeupMethWrapper object at 0x7f04b7c100>()] created at /usr/lib/python3.9/asyncio/tasks.py:704> cb=[_run_until_complete_cb() at /usr/lib/python3.9/asyncio/base_events.py:184] created at /usr/lib/python3.9/asyncio/base_events.py:621> took 10.189 seconds
2025-06-21 15:10:04,441 WARNING :Executing <Handle gather.<locals>._done_callback(<Task cancell.../tasks.py:361>) at /usr/lib/python3.9/asyncio/tasks.py:764 created at /usr/lib/python3.9/asyncio/events.py:80> took 0.616 seconds
2025-06-21 15:10:06,912 WARNING :Executing <Task finished name='Task-1' coro=<start_zigpy_task() done, defined at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:137> result=None created at /usr/lib/python3.9/asyncio/base_events.py:621> took 1.466 seconds
2025-06-21 15:10:06,913 DEBUG   :Close <_UnixSelectorEventLoop running=False closed=False debug=True>
2025-06-21 15:10:06,916 INFO    :b'Event loop closed successfully in zigpy_thread.'
2025-06-21 15:10:12,512 INFO    :b'Closing all client connections...'
2025-06-21 15:10:12,513 INFO    :b'++ WebUI - server stopped'
2025-06-21 15:10:12,520 INFO    :b'WebUI shutdown completed'
2025-06-21 15:10:12,543 INFO    :b'Closing Logging Management'
2025-06-21 17:31:21,587 INFO    :b'Z4D is starting with stable7-7.1.022'
2025-06-21 17:31:21,610 INFO    :b'Z4D Database found: DeviceList-47.txt'
2025-06-21 17:31:21,611 INFO    :b'Z4D Certified devices database /usr/local/lib/python3.9/dist-packages/z4d_certified_devices/'
2025-06-21 17:31:21,612 INFO    :b'Z4D loads ZCL Cluster definitions'
2025-06-21 17:31:21,713 INFO    :b'Z4D loaded 16 configuration from legacy database.'
2025-06-21 17:31:21,718 INFO    :b'++ Overwrite standard configuration model HK-SENSOR-4IN1-A with /home/domo/domoticz/plugins/Domoticz-Zigbee/Conf/Local-Devices/HK-SENSOR-4IN1-A.json'
2025-06-21 17:31:21,719 INFO    :b'Z4D loads 1 configuration from the local certified Db.'
2025-06-21 17:31:22,697 INFO    :b'Z4D loads 644 certified devices from repository version [6.465]'
2025-06-21 17:31:22,698 INFO    :b'Z4D loading plugin database'
2025-06-21 17:31:22,868 INFO    :b'Z4D loads 7 entries from /home/domo/domoticz/plugins/Domoticz-Zigbee/Data/DeviceList-47.txt'
2025-06-21 17:31:22,895 INFO    :b"Z4D is starting transport Mode: 'ZigpyEZSP' Serial: '/dev/ttyUSB11' IP: '0.0.0.0 'Port: '9999'"
2025-06-21 17:31:25,772 INFO    :b'Z4D starting EZSP'
2025-06-21 17:31:25,773 INFO    :b'zigpyThread starting with a random sleep'
2025-06-21 17:31:25,776 INFO    :b'Z4D starting WebUI on port 9440'
2025-06-21 17:31:25,828 INFO    :b'WebUI - server starting on 0.0.0.0 9440'
2025-06-21 17:31:25,829 INFO    :b'++ WebUI - create socket'
2025-06-21 17:31:25,831 INFO    :b'++ WebUI - SSL Certificate /home/domo/domoticz/plugins/Domoticz-Zigbee/certs/server.crt'
2025-06-21 17:31:25,837 INFO    :b'++ WebUI - SSL Private key /home/domo/domoticz/plugins/Domoticz-Zigbee/certs/server.key'
2025-06-21 17:31:25,838 INFO    :b"Certificate file '/home/domo/domoticz/plugins/Domoticz-Zigbee/certs/server.crt' does not exist."
2025-06-21 17:31:25,840 INFO    :b'++ WebUI - bin socket on 0.0.0.0:9440'
2025-06-21 17:31:25,841 INFO    :b'WebUI Server started on 0.0.0.0:9440'
2025-06-21 17:31:26,270 INFO    :b'Plugin looks to upgrade the Certified Device package'
2025-06-21 17:31:28,237 DEBUG   :Using selector: EpollSelector
2025-06-21 17:31:29,228 INFO    :b'++ Enables boost power mode and the alternate transmitter output.'
2025-06-21 17:31:29,232 INFO    :b'++ Started radio ezsp port: /dev/ttyUSB11'
2025-06-21 17:31:29,234 INFO    :b'++ Use of Zigpy Persistent Db'
2025-06-21 17:31:29,262 WARNING :Executing <Task pending name='Task-25690' coro=<start_zigpy_task() running at /home/domo/domoticz/plugins/Domoticz-Zigbee/Classes/ZigpyTransport/zigpyThread.py:153> wait_for=<Future pending cb=[<TaskWakeupMethWrapper object at 0x7f0fea2970>()] created at /usr/lib/python3.9/asyncio/base_events.py:424> cb=[_run_until_complete_cb() at /usr/lib/python3.9/asyncio/base_events.py:184] created at /usr/lib/python3.9/asyncio/base_events.py:621> took 0.993 seconds
2025-06-21 17:31:32,645 DEBUG   :Using selector: EpollSelector
2025-06-21 17:31:34,451 INFO    :b'++ EZSP Radio register default Ep'
2025-06-21 17:31:34,497 INFO    :b"AppGeneric:initialize auto_form: True force_form: False Class: <class 'Classes.ZigpyTransport.AppBellows.App_bellows'> Logger: <Logger Classes.ZigpyTransport.AppGeneric (WARNING)>"
2025-06-21 17:31:36,894 INFO    :b"++ EZSP Configuration {'device': {'path': '/dev/ttyUSB11', 'baudrate': 115200, 'flow_control': None}, 'network': {'channel': 20, 'key_sequence_number': 0, 'key': None, 'tc_link_key': 5a:69:67:42:65:65:41:6c:6c:69:61:6e:63:65:30:39, 'update_id': 0, 'pan_id': None, 'tc_address': None, 'extended_pan_id': None, 'channels': <Channels.CHANNEL_25|CHANNEL_20|CHANNEL_15|CHANNEL_11: 34637824>}, 'ezsp_config': {'CONFIG_TX_POWER_MODE': 3}, 'ota': {'enabled': False, 'providers': [Ledvance(url='https://api.update.ledvance.com/v1/zigbee/firmwares', manufacturer_ids=(4489, 4364)), Sonoff(url=None, manufacturer_ids=(4742,)), Inovelli(url=None, manufacturer_ids=(4655,)), ThirdReality(url=None, manufacturer_ids=(4659, 4877, 5127))], 'broadcast_enabled': True, 'extra_providers': [], 'broadcast_interval': 14040.0, 'broadcast_initial_delay': 14040.0, 'disable_default_providers': []}, 'handle_unknown_devices': True, 'source_routing': False, 'topology_scan_enabled': True, 'database_path': ':memory:', 'topology_scan_period': 720, 'backup_enabled': True, 'backup_period': 1, 'max_watchdog_failures': 4, 'additional_endpoints': [], 'watchdog_enabled': True, 'max_concurrent_requests': 8, 'topology_scan_skip_coordinator': False, 'use_thread': True, 'validate_network_settings': False, 'bellows_config': {'manual_source_routing': False}, 'ezsp_policies': {}, 'max_retries': 2}"
2025-06-21 17:31:36,897 INFO    :b'Number of devices recently active in Coordinator = 0'
2025-06-21 17:31:36,990 INFO    :b'++ EZSP Board Information'
2025-06-21 17:31:36,997 INFO    :b'++   Radio manufacturer : Elelabs'
2025-06-21 17:31:36,998 INFO    :b'++   Radio board name   : ELU0142'
2025-06-21 17:31:37,005 INFO    :b'++   EmberZNet version  : 6.10.3.0 build 297'
2025-06-21 17:31:37,008 INFO    :b'++   Protocol Version   : 8'
2025-06-21 17:31:37,010 INFO    :b'++ Network settings'
2025-06-21 17:31:37,011 INFO    :b'++   Device IEEE        : 28:db:a7:ff:fe:86:37:f8'
2025-06-21 17:31:37,014 INFO    :b'++   Device NWK         : 0x0000'
2025-06-21 17:31:37,015 INFO    :b'++   Network Update Id  : 0x0002'
2025-06-21 17:31:37,019 INFO    :b'++   PAN ID             : 0x71F8'
2025-06-21 17:31:37,020 INFO    :b'++   Extended PAN ID    : 2c:c3:ad:bd:c1:e4:4b:13'
2025-06-21 17:31:37,025 INFO    :b'++   Channel            : 20'
2025-06-21 17:31:37,026 INFO    :b'Elelabs, ELU01x'
2025-06-21 17:31:37,027 INFO    :b'Installer Version Number: 6.10.3.0 build 297'
2025-06-21 17:31:37,029 INFO    :b'Branch Version: ==> Elelabs, ELU01x <=='
2025-06-21 17:31:37,033 INFO    :b'Zigbee Coordinator ieee: 28dba7fffe8637f8 , short addr: 0000'
2025-06-21 17:31:37,035 INFO    :b'Network state UP, PANID: 71f8 extPANID: 0x2cc3adbdc1e44b13 Channel: 20'
2025-06-21 17:31:37,546 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 17:31:37,569 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:37,649 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:38,095 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:232.0'
2025-06-21 17:31:38,114 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:38,207 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:38,635 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 17:31:38,654 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:38,747 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:39,180 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 17:31:39,206 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:39,293 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:39,726 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 17:31:39,746 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:39,844 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:40,269 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 17:31:40,286 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:40,375 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:40,709 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:235.0'
2025-06-21 17:31:40,729 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:40,823 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:41,071 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 17:31:41,086 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:41,253 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:41,687 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 17:31:41,707 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:41,798 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:42,226 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:31:42,325 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:31:49,216 INFO    :b'Certified Device package upgrade results'
2025-06-21 17:31:49,217 INFO    :b'Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple'
2025-06-21 17:31:49,218 INFO    :b'Requirement already satisfied: z4d-certified-devices in /usr/local/lib/python3.9/dist-packages (6.465)'
2025-06-21 17:31:49,218 INFO    :b'Collecting z4d-certified-devices'
2025-06-21 17:31:49,219 INFO    :b'  Using cached z4d_certified_devices-6.465-py3-none-any.whl (445 kB)'
2025-06-21 17:31:49,219 INFO    :b'  Using cached z4d_certified_devices-6.464-py3-none-any.whl (446 kB)'
2025-06-21 17:31:49,220 INFO    :b''
2025-06-21 17:31:49,221 INFO    :b'Z4D Widgets usage is at 9.4% (231 units free)'
2025-06-21 17:31:49,221 INFO    :b'Z4D started with Domoticz legacy Framework'
2025-06-21 17:31:58,086 INFO    :b'Z4D closed the Zigbee network'
2025-06-21 17:31:58,164 INFO    :b'++ opening zigbee network for 0 secondes on specific router None'
2025-06-21 17:32:01,160 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:234.0'
2025-06-21 17:32:01,192 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0.0;233160'
2025-06-21 17:32:01,282 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0;233160'
2025-06-21 17:32:03,103 INFO    :b'Switch Blue Led On'
2025-06-21 17:32:03,104 INFO    :b'Z4D coordinator set to Certification : 1/CE -> CE'
2025-06-21 17:32:03,107 INFO    :b'Z4D starts Configure Reporting handling'
2025-06-21 17:32:03,108 INFO    :b'Z4D starts Over-The-Air Management'
2025-06-21 17:32:04,653 INFO    :b'Z4D loads the firmware images'
2025-06-21 17:32:04,654 INFO    :b'Z4D with Zigpy, coordinator Elelabs, ELU01x, firmware 6.10.3.0 build 297 communication confirmed.'
2025-06-21 17:32:04,654 INFO    :b'Z4D sending analytics information. (if you need to disable, disable the MatomoOptIn parameter via the WebUI - Settings)'
2025-06-21 17:32:04,664 DEBUG   :Starting new HTTPS connection (1): z4d.pipiche.net:443
2025-06-21 17:32:05,129 DEBUG   :https://z4d.pipiche.net:443 "GET /matomo.php?idsite=9&rec=1&apiv=1&action_name=Plugin+Action&uid=686dcc3fbf0e02b45dd8ff5ac44d78e7070d2ec9b6294ce7cebfbbc03d9e8126&e_c=Plugin&e_a=Started&e_n=Plugin+Started HTTP/1.1" 200 43
2025-06-21 17:32:05,300 DEBUG   :Starting new HTTPS connection (1): z4d.pipiche.net:443
2025-06-21 17:32:05,754 DEBUG   :https://z4d.pipiche.net:443 "GET /matomo.php?idsite=9&rec=1&apiv=1&action_name=Z4DPluginInfos&uid=686dcc3fbf0e02b45dd8ff5ac44d78e7070d2ec9b6294ce7cebfbbc03d9e8126&dimension1=2025.1&dimension2=Elelabs+ELU01x&dimension3=7.1.022&dimension4=Ezsp+-+6.10.3.0+build+297&dimension5=Small&dimension6=6.465&dimension7=Debian+GNU+Linux+11&dimension8=python+3.9.2+arch+64bit+machine+aarch64+processor&dimension9=1+day&dimension11=Raspberry+Pi+3+Model+B+Rev+1.2 HTTP/1.1" 200 43
2025-06-21 17:32:05,992 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0.0;233160'
2025-06-21 17:32:09,139 INFO    :b"is_zigate_firmware_available <class 'str'>, <class 'str'>, <class 'int'>, <class 'int'>"
2025-06-21 17:32:30,991 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0;233160'
2025-06-21 17:32:58,567 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.1'
2025-06-21 17:32:59,062 INFO    :b"Warning while submitting - rawaps_write_attribute_req a4:c1:38:72:60:14:1f:26/0x50d1 0x104 0x500 payload: b'\\x10\\x01\\x02\\x13\\x00 \\x03' AckIsDisable: False extended_timeout: True Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 17:33:01,558 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.09'
2025-06-21 17:33:04,070 INFO    :b"Warning while submitting - rawaps_write_attribute_req a4:c1:38:ca:6d:29:0e:d6/0x944b 0x104 0x500 payload: b'\\x10\\x01\\x02\\x13\\x00 \\x03' AckIsDisable: False extended_timeout: True Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 17:33:04,105 INFO    :b"Warning while submitting - rawaps_write_attribute_req a4:c1:38:45:2a:67:6c:6e/0x7d8b 0x104 0x500 payload: b'\\x10\\x01\\x02\\x13\\x00 \\x00' AckIsDisable: False extended_timeout: True Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 17:33:09,127 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:7.0;42350'
2025-06-21 17:33:09,264 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:7;42360'
2025-06-21 17:33:13,565 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:33:18,558 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.1'
2025-06-21 17:33:23,564 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:7.0;42360'
2025-06-21 17:33:24,562 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.09'
2025-06-21 17:34:09,258 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:233.0'
2025-06-21 17:34:09,276 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0.0;233160'
2025-06-21 17:34:23,567 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.1'
2025-06-21 17:34:39,653 INFO    :b'UpdateDevice - (VbtFenetreCuisine) 1:On'
2025-06-21 17:35:10,574 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:7;42360'
2025-06-21 17:35:11,970 INFO    :b'UpdateDevice - ( VbtPorteEntree) 1:On'
2025-06-21 17:35:21,575 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.09'
2025-06-21 17:35:44,281 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:7.0;42360'
2025-06-21 17:35:47,369 INFO    :b'UpdateDevice - (VbtPorteCellierGge) 1:On'
2025-06-21 17:36:33,597 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 17:36:54,717 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:36:59,523 INFO    :b'UpdateDevice - (Prise Sect Garage) 0:Off'
2025-06-21 17:37:02,860 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:228.0'
2025-06-21 17:37:03,860 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:230.0'
2025-06-21 17:37:04,236 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.0'
2025-06-21 17:37:04,255 INFO    :b'UpdateDevice - (Prise Sect Garage W) 0:0.0'
2025-06-21 17:37:04,271 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:0.0;42360'
2025-06-21 17:37:20,055 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:232.0'
2025-06-21 17:37:20,190 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0;233160'
2025-06-21 17:38:08,178 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:231.0'
2025-06-21 17:38:08,284 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:0;42360'
2025-06-21 17:38:13,597 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:38:34,248 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 17:39:09,220 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:233.0'
2025-06-21 17:39:09,237 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0.0;233160'
2025-06-21 17:40:37,868 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:232.0'
2025-06-21 17:40:39,036 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:234.0'
2025-06-21 17:41:59,927 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:0.0;42360'
2025-06-21 17:42:04,222 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:231.0'
2025-06-21 17:42:06,639 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:42:08,869 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:42:08,989 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:42:28,582 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0;233160'
2025-06-21 17:43:13,634 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:43:28,890 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:230.0'
2025-06-21 17:43:33,345 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:0;42360'
2025-06-21 17:43:33,541 INFO    :b"Warning while submitting - zcl_raw_default_response a4:c1:38:64:2d:43:90:a1/0xa2d7 0x104 0xB04 payload: b'\\x08M\\x0b\\n\\x00' AckIsDisable: True extended_timeout: False Attempt: 1 Exception: 'Failed to deliver message: <sl_Status.ZIGBEE_DELIVERY_FAILED: 3074>' (DeliveryError)"
2025-06-21 17:43:39,268 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 17:43:47,064 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c1386ae7b358da-01) 0:0.03'
2025-06-21 17:43:48,063 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c1386ae7b358da-01) 0:0.04'
2025-06-21 17:43:52,058 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c1386ae7b358da-01) 0:0.05'
2025-06-21 17:43:53,062 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c1386ae7b358da-01) 0:0.04'
2025-06-21 17:43:55,070 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c1386ae7b358da-01) 0:0.03'
2025-06-21 17:44:04,051 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:232.0'
2025-06-21 17:44:04,614 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:232.0'
2025-06-21 17:44:13,072 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c1386ae7b358da-01) 0:0.0'
2025-06-21 17:44:14,211 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:233.0'
2025-06-21 17:44:14,238 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0.0;233160'
2025-06-21 17:45:05,049 INFO    :b'UpdateDevice - (Prise Seche Linge) 0:Off'
2025-06-21 17:45:09,245 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:232.0'
2025-06-21 17:45:20,624 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 17:45:24,058 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:234.0'
2025-06-21 17:45:33,766 INFO    :b'UpdateDevice - (Prise Seche Linge) 1:On'
2025-06-21 17:45:34,213 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:233.0'
2025-06-21 17:46:00,665 INFO    :b'UpdateDevice - (Prise Sect Garage) 1:On'
2025-06-21 17:46:04,176 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:229.0'
2025-06-21 17:46:04,192 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.11'
2025-06-21 17:46:04,212 INFO    :b'UpdateDevice - (Prise Sect Garage W) 0:6.0'
2025-06-21 17:46:04,246 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:6.0;42360'
2025-06-21 17:46:05,420 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.09'
2025-06-21 17:46:06,418 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:231.0'
2025-06-21 17:46:10,419 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.1'
2025-06-21 17:46:24,421 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.09'
2025-06-21 17:46:57,432 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.1'
2025-06-21 17:47:00,438 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.09'
2025-06-21 17:47:03,482 INFO    :b'UpdateDevice - (Prise Sect Garage W) 0:7.0'
2025-06-21 17:47:03,499 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:7.0;42360'
2025-06-21 17:47:03,618 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:7;42360'
2025-06-21 17:47:04,422 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.1'
2025-06-21 17:47:06,657 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:47:11,436 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Ampere-a4c138642d4390a1-01) 0:0.09'
2025-06-21 17:47:14,743 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:47:14,838 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0;2370'
2025-06-21 17:47:31,084 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0;233160'
2025-06-21 17:47:53,570 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:234.0'
2025-06-21 17:47:53,587 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0.0;233160'
2025-06-21 17:47:53,734 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0;233160'
2025-06-21 17:48:13,649 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138576d4024ff-01) 0:0.0;2370'
2025-06-21 17:48:39,234 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:233.0'
2025-06-21 17:48:50,093 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c1386ae7b358da-01) 0:232.0'
2025-06-21 17:48:53,635 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:232.0'
2025-06-21 17:48:58,460 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:229.0'
2025-06-21 17:50:08,459 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:231.0'
2025-06-21 17:50:09,673 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 17:50:11,641 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:232.0'
2025-06-21 17:50:12,439 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:229.0'
2025-06-21 17:50:16,657 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:234.0'
2025-06-21 17:50:17,452 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:231.0'
2025-06-21 17:50:20,655 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138576d4024ff-01) 0:232.0'
2025-06-21 17:50:27,467 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:229.0'
2025-06-21 17:50:34,298 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c1386ae7b358da-01) 0:0.0;233160'
2025-06-21 17:51:04,288 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Voltage-a4c138642d4390a1-01) 0:230.0'
2025-06-21 17:51:04,324 INFO    :b'UpdateDevice - (Prise Sect Garage W) 0:6.0'
2025-06-21 17:51:04,347 INFO    :b'UpdateDevice - (Zi-Stick - TS011F-plug_Meter-a4c138642d4390a1-01) 0:6.0;42360'
Dans les logs ou cela merde, on dirait que le plugin se débat avec ses défenses en cas de pépin, qui semblent échouer... Par contre, de là a se retrouver à compromettre toute la stabilité du système (qui tourne chez moi globalement comme un coucou suisse, avec souvent des mois d'uptime), j'aimerais avoir des pistes sur comment éviter cela.

A mon niveau, je ne vois que trouver un moyen de monitorer ceci:

Code : Tout sélectionner

top -p $(pidof domoticz)

Tasks:   1 total,   0 running,   1 sleeping,   0 stopped,   0 zombie
%Cpu(s):  0.0 us,  0.0 sy,  0.0 ni,100.0 id,  0.0 wa,  0.0 hi,  0.0 si,  0.0 st
MiB Mem :    959.5 total,     49.5 free,    422.2 used,    487.8 buff/cache
MiB Swap:      0.0 total,      0.0 free,      0.0 used.    471.9 avail Mem 

    PID USER      PR  NI    VIRT    RES    SHR S  %CPU  %MEM     TIME+ COMMAND                                            
    975 root      20   0 2431940 207088  23524 S   6.2  21.1  15:07.32 domoticz                                           
et si %MEM dépasse un seuil, genre 40% (ce qui serait déjà doubler ce qui est chez moi la norme), provoquer l'arrêt du plugin via l'API HTTP/JSON si c'est possible et m'envoyer une notif.

Niveau erreur, ca semblerait lié à des interférences ou pb de routage (parle de source routing à activer en parade?):
https://meshstack.de/post/zha-issue-zigbee-gateway/
lost
Messages : 1511
Inscription : 12 nov. 2016, 11:01

Re: Grosse fuite mémoire...

Message par lost »

Bon bin reparti ce matin après une nuit OK... idem.
pipiche
Messages : 4677
Inscription : 04 avr. 2018, 16:16
Contact :

Re: Grosse fuite mémoire...

Message par pipiche »

le problème de "fuite de mémoire" est lié à domoticz et le python framework.
En effet il est démontré que lors du restart d'un plugin depuis Domoticz (via l'API ou via le WebUI), toute la mémoire utilisée par le plugin n'est pas libérée. Du coup au fil de l'eau la mémoire consommée par Domoticz ne fait qu'augmenter. Seul un restart de Domoticz permettra de repartir correctement.

Mais pour moi effectivement la "root cause", c'est la problématique de delivery du message. Probablement un soucis HW à la base. Donc un power Off du Pi, de la clef Zigbee . Assure-toi quelle est loin d'un disque SSD et d'un AP Wifi

Tu es bien avec la dernière version du plugin ? les librairies python sont bien à jour ?
Zigbee for Domoticz - Clef zzh-p (electrolama) 45 devices.

Si vous appréciez ce que je fais, vous pouvez contribuer par un don Paypal , ce qui me permettra notamment l'achat d’équipements et de les tester/valider pour le plugin.
Wiki ici
chat sur Keybase.io
lost
Messages : 1511
Inscription : 12 nov. 2016, 11:01

Re: Grosse fuite mémoire...

Message par lost »

Hello,
Niveau plugin, j'avais laissé l'info dans les logs restart ci dessus:

Code : Tout sélectionner

2025-06-21 17:31:21,587 INFO    :b'Z4D is starting with stable7-7.1.022'
Le plugin, actuellement coupé, ne m'avait pas indiqué de nouvelle version. Toutes les dépendances avaient dû être MAJ aussi car pas d'erreur vu à ce moment.
C'est assez ballot, ce comportement de domoticz... Je pense aussi qu'il doit y avoir un pb matériel, mais là je n'ai pas trop d'idée pour savoir ce qui cloche. Coordinateur? Assez souvent, à lire les logs, j'ai eu un capteur de vibration qui a tilté avant d'engager le pb mais j'ai au moins un exemple ou ce n'est pas le cas.
A remonter plusieurs jours en arrière, dans les logs encore dispo, j'avais des séquences comparables durant moins longtemps.
Le coordinateur est déplacé de l'environnement PI/Box via un cordon USB avec ferrite de 2m, sur un PI3B donc port USB2. Rien de changé à ce niveau depuis 1 an 1/2 quand j'ai démarré en zigbee.

EDIT: Je n'ai pas de traces de redémarrage plugin, sauf quand je l'ai moi même initié directement ou via redémarrage domotics complet voir PI. Pas certain du tout qu'il s'agisse ici du pb visiblement connu. Au besoin j'ai tous les logs de la semaine passée mais les MP du forum refusent bien des formats...
lost
Messages : 1511
Inscription : 12 nov. 2016, 11:01

Re: Grosse fuite mémoire...

Message par lost »

Bon, c'est toujours pareil. Si cela ne coince pas direct cela ne tiens rarement 12h et entraîne tout domoticz dans sa chute, donc exit le script crado pour juguler un truc rare, ce serait une perte de temps...

Je ne trouve aucun élément avec une panne franche, qui en tous cas ne devrait pas avoir ces conséquences mais pourrait sans doute aider à améliorer la robustesse si je suis tombé sur un pb peu fréquent.

Heureusement, je n'ai en zigbee que mes derniers ajouts dont je peut me passer au moins temporairement en désactivant le plugin. Mais là, je ne sais pas trop quoi faire pour progresser.

Les messages d'erreur sont dans la dépendance bellows du plugin, mais je ne trouve pas trace de là ou le pb est vu (dans ce que je suppose être des fonctions: zcl_raw_XXXX, visible dans les logs) exactement avec pour conséquence de bouffer la mémoire disponible sans autre limite que l'OOM-Killer qui sonne la fin de la récré, mais pour tout domoticz et dans le meilleur des cas (j'ai eu un plantage complet, peut-être que l'OOM-Killer a tué un peu large, avec une carte SD que le boot-loader du PI ne savait alors pas décoincer: Un simple montage des partitions de la SD sur une machine Linux permet les rejeu de journal Ext4 que le boot-loader ne semble pas gérer correctement, avec un driver Ext sans doute moins bon/complet niveau features).

Au besoin, je peux faire un rapport de bug sur le repo github qui va bien avec mes logs, mais lequel? :?:
pipiche
Messages : 4677
Inscription : 04 avr. 2018, 16:16
Contact :

Re: Grosse fuite mémoire...

Message par pipiche »

peux-tu passer sur la branche rc-7.1.023 ?

restart de domoticz après l'update du plugin et des modules python3

- laisses tourner, si plantage envoies moi les logs, et un export.json des devices

- actives alors les debug
- ZigpyEZSP si tu es en mode EZSP ou ZigpyZNP si tu es en mode TI ZNP
- TransportZigpy

Attention, ca va etre verbeux

EN cas de plantage envoies moi alors les logs
Zigbee for Domoticz - Clef zzh-p (electrolama) 45 devices.

Si vous appréciez ce que je fais, vous pouvez contribuer par un don Paypal , ce qui me permettra notamment l'achat d’équipements et de les tester/valider pour le plugin.
Wiki ici
chat sur Keybase.io
lost
Messages : 1511
Inscription : 12 nov. 2016, 11:01

Re: Grosse fuite mémoire...

Message par lost »

Hello,

Tenté:

Code : Tout sélectionner

sudo git pull
sudo git checkout rc-7.1.023
Ce qui semble OK:

Code : Tout sélectionner

Branch 'rc-7.1.023' set up to track remote branch 'rc-7.1.023' from 'origin'.
Switched to a new branch 'rc-7.1.023'
Puis:

Code : Tout sélectionner

udo git pull
hint: Pulling without specifying how to reconcile divergent branches is
hint: discouraged. You can squelch this message by running one of the following
hint: commands sometime before your next pull:
hint: 
hint:   git config pull.rebase false  # merge (the default strategy)
hint:   git config pull.rebase true   # rebase
hint:   git config pull.ff only       # fast-forward only
hint: 
hint: You can replace "git config" with "git config --global" to set a default
hint: preference for all repositories. You can also pass --rebase, --no-rebase,
hint: or --ff-only on the command line to override the configured default per
hint: invocation.
Already up to date.
Already up to date. ???

Code : Tout sélectionner

sudo git status
On branch rc-7.1.023
Your branch is up to date with 'origin/rc-7.1.023'.

Untracked files:
  (use "git add <file>..." to include in what will be committed)
	.gitconfig
	Conf/Local-Devices/HK-SENSOR-4IN1-A.json
	PluginZigbee_47.log
	ReportsTransport-stats.json

nothing added to commit but untracked files present (use "git add" to track)
Je ne sais pas si les reste de vieux essais sur ce foutu 4in1 qui n'avait pu faire le job pour lequel il était vendu posent pb?
pipiche
Messages : 4677
Inscription : 04 avr. 2018, 16:16
Contact :

Re: Grosse fuite mémoire...

Message par pipiche »

Pour le Sunricher/HK-SENSOR-4IN1-A.json il y a en un dans la base des objets certifié. TU peux vérifier si il y a une différence avec celui-ci https://github.com/zigbeefordomoticz/z4 ... IN1-A.json
si pas de différence, alors supprimes Conf/Local-Devices/HK-SENSOR-4IN1-A.json

a priori c'est bien basculé
Zigbee for Domoticz - Clef zzh-p (electrolama) 45 devices.

Si vous appréciez ce que je fais, vous pouvez contribuer par un don Paypal , ce qui me permettra notamment l'achat d’équipements et de les tester/valider pour le plugin.
Wiki ici
chat sur Keybase.io
lost
Messages : 1511
Inscription : 12 nov. 2016, 11:01

Re: Grosse fuite mémoire...

Message par lost »

Hello,

Il me semblait bien qu'il n'avait rien tiré et c'est le cas vu cette tentative de redémarrage du plugin:

Code : Tout sélectionner

 2025-06-25 07:01:40.310 Status: Zi-Stick: ControllerInRawMode set to True
2025-06-25 07:01:40.774 Status: Zi-Stick: Z4D is checking the python modules requirements
2025-06-25 07:01:40.775 Status: Zi-Stick: Checking Python modules /home/domo/domoticz/plugins/Domoticz-Zigbee/constraints.txt
2025-06-25 07:01:40.794 Status: Zi-Stick: - zigpy==0.80.0 version required 0.80.0 installed 0.80.0
2025-06-25 07:01:40.812 Status: Zi-Stick: - zigpy_znp==0.14.0 version required 0.14.0 installed 0.14.0
2025-06-25 07:01:40.827 Status: Zi-Stick: - zigpy_deconz==0.25.0 version required 0.25.0 installed 0.25.0
2025-06-25 07:01:40.839 Status: Zi-Stick: - bellows==0.45.0 version required 0.45.0 installed 0.45.0
2025-06-25 07:01:40.850 Status: Zi-Stick: - dnspython==2.7.0 version required 2.7.0 installed 2.7.0
2025-06-25 07:01:40.860 Status: Zi-Stick: - pyserial>=3.5 version required 3.5 installed 3.5
2025-06-25 07:01:40.873 Status: Zi-Stick: - charset-normalizer==2.0.11 version required 2.0.11 installed 2.0.11
2025-06-25 07:01:40.890 Status: Zi-Stick: - jsonschema==4.17.3 version required 4.17.3 installed 4.17.3
2025-06-25 07:01:40.903 Status: Zi-Stick: - cryptography<=40.0.2 version required 40.0.2 installed 3.3.2
2025-06-25 07:01:40.903 Status: Zi-Stick: Z4D is installing the WebUI in the domoticz custom menu
2025-06-25 07:01:40.909 Status: Zi-Stick: Z4D Please watch plugin logs into /home/domo/domoticz/plugins/Domoticz-Zigbee/Logs/PluginZigbee_47.log
2025-06-25 07:01:40.916 Status: Zi-Stick: Z4D is initializing a connection to Domoticz Api/Json
2025-06-25 07:01:40.957 Status: Zi-Stick: Z4D is starting with stable7-7.1.022
2025-06-25 07:01:40.959 Status: Zi-Stick: Z4D loads ZCL Cluster definitions
2025-06-25 07:01:41.057 Status: Zi-Stick: Z4D loaded 16 configuration from legacy database.
2025-06-25 07:01:41.062 Status: Zi-Stick: ++ Overwrite standard configuration model HK-SENSOR-4IN1-A with /home/domo/domoticz/plugins/Domoticz-Zigbee/Conf/Local-Devices/HK-SENSOR-4IN1-A.json
Toujours Z4D is starting with stable7-7.1.022

Le git pull ne fait rien malgré le changement de branche mais averti de branche divergente:

Code : Tout sélectionner

sudo git pull
hint: Pulling without specifying how to reconcile divergent branches is
hint: discouraged. You can squelch this message by running one of the following
hint: commands sometime before your next pull:
hint: 
hint:   git config pull.rebase false  # merge (the default strategy)
hint:   git config pull.rebase true   # rebase
hint:   git config pull.ff only       # fast-forward only
hint: 
hint: You can replace "git config" with "git config --global" to set a default
hint: preference for all repositories. You can also pass --rebase, --no-rebase,
hint: or --ff-only on the command line to override the configured default per
hint: invocation.
Already up to date.
Pourtant j'ai bien changé de branche (avec la branche sunricher du debug d'il y a presque 1 an toujours visible elle aussi):

Code : Tout sélectionner

sudo git branch 
* rc-7.1.023
  stable7
  sunricher-4in1-specifics
pipiche
Messages : 4677
Inscription : 04 avr. 2018, 16:16
Contact :

Re: Grosse fuite mémoire...

Message par pipiche »

C’est normal qu’il affiche 7.1.022

Je ne gère pas les version sur les branches de dev
Zigbee for Domoticz - Clef zzh-p (electrolama) 45 devices.

Si vous appréciez ce que je fais, vous pouvez contribuer par un don Paypal , ce qui me permettra notamment l'achat d’équipements et de les tester/valider pour le plugin.
Wiki ici
chat sur Keybase.io
Répondre