Zigbee instable (perte de connexion + restart impossible)

Plugins Protocole domotique
1

Bonjour,

depuis la MAJ d’hier mon zigbee est super instable. Il a planté cette nuit et j’ai eu tout le mal du monde à le relancer. Pour seul message j’ai FATAL ERROR:

[2021-10-28 09:41:14][ERROR] : Exception in callback ThreadsafeProxy.__getattr__.<locals>.func_wrapper.<locals>.check_result_wrapper() at /usr/local/lib/python3.7/dist-packages/bellows/thread.py:97
handle: <Handle ThreadsafeProxy.__getattr__.<locals>.func_wrapper.<locals>.check_result_wrapper() at /usr/local/lib/python3.7/dist-packages/bellows/thread.py:97>
Traceback (most recent call last):
File "/usr/lib/python3.7/asyncio/events.py", line 88, in _run
self._context.run(self._callback, *self._args)
File "/usr/local/lib/python3.7/dist-packages/bellows/thread.py", line 98, in check_result_wrapper
result = call()
File "/usr/local/lib/python3.7/dist-packages/bellows/ezsp/__init__.py", line 258, in frame_received
self._protocol(data)
TypeError: 'NoneType' object is not callable
[2021-10-28 09:41:20][ERROR] : Couldn't start application
[2021-10-28 09:41:20][ERROR] : [start_zigbee] Fatal error :

J’ai mis à jour les dépandances mais pas mieux.

Une infos ?

2

As tu mis à jour les dépendances ?

3

Bonjour,

oui… Et j’ai aussi downgradé et c’est pareil. Le daemon démarre pas ou mal :

[2021-10-30 09:33:47][DEBUG] : Application frame 170 (getValue) received: b'xxx'
[2021-10-30 09:33:47][INFO] : EZSP Radio manufacturer: Elelabs
[2021-10-30 09:33:47][INFO] : EZSP Radio board name: ELR023
[2021-10-30 09:33:47][INFO] : EmberZNet version: 6.9.1.0 build 214
[2021-10-30 09:33:47][DEBUG] : Send command networkInit: ()
[2021-10-30 09:33:47][DEBUG] : Sending: b'xxx'
[2021-10-30 09:33:47][DEBUG] : Data frame: b'xxx'
[2021-10-30 09:33:47][DEBUG] : Sending: b'xxxx'
[2021-10-30 09:33:47][DEBUG] : Application frame 23 (networkInit) received: b'00'
[2021-10-30 09:33:47][DEBUG] : Data frame: b'xxx'
[2021-10-30 09:33:47][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:33:47][DEBUG] : Send command getNetworkParameters: ()
[2021-10-30 09:33:47][DEBUG] : Application frame 25 (stackStatusHandler) received: b'90'
[2021-10-30 09:33:47][DEBUG] : Sending: b'xxx'
[2021-10-30 09:33:52][ERROR] : Couldn't start application
[2021-10-30 09:33:52][DEBUG] : executing functools.partial(<built-in method close of sqlite3.Connection object at 0xffff9644e3b0>)
[2021-10-30 09:33:52][DEBUG] : operation functools.partial(<built-in method close of sqlite3.Connection object at 0xffff9644e3b0>) completed
[2021-10-30 09:33:52][INFO] : Shutting down ControllerApplication
[2021-10-30 09:33:52][ERROR] : [start_zigbee] Fatal error : 
[2021-10-30 09:33:52][DEBUG] : Closed serial connection
[2021-10-30 09:33:52][INFO] : Traceback (most recent call last):
  File "/var/www/html/plugins/zigbee/resources/zigbeed/zigbeed.py", line 102, in start_zigbee
    start_radio=True,
  File "/usr/local/lib/python3.7/dist-packages/zigpy/application.py", line 69, in new
    await app.startup(auto_form)
  File "/usr/local/lib/python3.7/dist-packages/bellows/zigbee/application.py", line 151, in startup
    status, node_type, nwk_params = await ezsp.getNetworkParameters()
  File "/usr/lib/python3.7/asyncio/tasks.py", line 423, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError

[2021-10-30 09:33:52][INFO] : Shutdown
[2021-10-30 09:33:52][INFO] : Removing PID file /tmp/jeedom/zigbee/deamon_1.pid
[2021-10-30 09:33:52][INFO] : Exit 0
4

Il semble selon le log que tu aies un pb de port.
Es tu sur une VM ?

5

Non, Odroid.

6

Regarde donc du coté de la configuration de ton port USB

7

Me semble bon…

image
image1181×679 64 KB

8

C’est comme s’il y avait saturation…

[2021-10-30 09:48:05][DEBUG] : Closed serial connection
[2021-10-30 09:48:09][INFO] : [DeviceHandler.prepare] Json arg : {'ieee': '5c:02:72:ff:fe:92:29:dc', 'cmd': [{'endpoint': 1, 'cluster': 'on_off', 'command': 'on', 'await': 1}], 'allowQueue': False}
[2021-10-30 09:48:09][ERROR] : [5c:02:72:ff:fe:92:29:dc][zdevices.command] Command failed retry in 1s : ApplicationController is not running
[2021-10-30 09:48:09][DEBUG] : Using selector: EpollSelector
[2021-10-30 09:48:09][DEBUG] : Resetting EZSP
[2021-10-30 09:48:09][DEBUG] : Resetting ASH
[2021-10-30 09:48:09][DEBUG] : Sending: b'1ac038bc7e'
[2021-10-30 09:48:10][INFO] : Traceback (most recent call last):
File "/var/www/html/plugins/zigbee/resources/zigbeed/zdevices.py", line 83, in command
await command()
File "/usr/local/lib/python3.7/dist-packages/zigpy/device.py", line 274, in request
use_ieee=use_ieee,
File "/usr/local/lib/python3.7/dist-packages/bellows/zigbee/application.py", line 501, in request
raise ControllerError("ApplicationController is not running")
bellows.exception.ControllerError: ApplicationController is not running
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/var/www/html/plugins/zigbee/resources/zigbeed/restServer.py", line 253, in put
await zdevices.command(self.json_args)
File "/var/www/html/plugins/zigbee/resources/zigbeed/zdevices.py", line 88, in command
await command()
File "/usr/local/lib/python3.7/dist-packages/zigpy/device.py", line 274, in request
use_ieee=use_ieee,
File "/usr/local/lib/python3.7/dist-packages/bellows/zigbee/application.py", line 501, in request
raise ControllerError("ApplicationController is not running")
bellows.exception.ControllerError: ApplicationController is not running
[2021-10-30 09:48:10][INFO] : 200 PUT /device/command (127.0.0.1) 1018.05ms
[2021-10-30 09:48:10][DEBUG] : RSTACK Version: 2 Reason: RESET_SOFTWARE frame: b'c1020b0a527e'
[2021-10-30 09:48:10][DEBUG] : Send command version: (4,)
[2021-10-30 09:48:10][DEBUG] : Sending: b'004221a850ed2c7e'
[2021-10-30 09:48:10][DEBUG] : Data frame: b'0142a1a85c2805dbd7ae7e'
[2021-10-30 09:48:10][DEBUG] : Sending: b'8160597e'
[2021-10-30 09:48:10][DEBUG] : Application frame 0 (version) received: b'08021069'
[2021-10-30 09:48:11][DEBUG] : Switching to EZSP protocol version 8
[2021-10-30 09:48:11][DEBUG] : Send command version: (8,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'7d314221a9542a1d8cdf7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'1242a1a9542a1db049fd70757e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'82503a7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 0 (version) received: b'08021069'
[2021-10-30 09:48:11][DEBUG] : EZSP Stack Type: 2, Stack Version: 6910, Protocol version: 8
[2021-10-30 09:48:11][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'224321a9fe2a1683467e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'2343a1a9fe2a15b3a081f77e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'83401b7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 170 (getValue) received: b'0001f9'
[2021-10-30 09:48:11][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'334021a9062a14a80d7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'3440a1a9062a15485927a17e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 82 (getConfigurationValue) received: b'00fa00'
[2021-10-30 09:48:11][DEBUG] : Free/configured buffers before any configurations: 249/250
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_APPLICATION_ZDO_FLAGS: 42>, <EmberZdoConfigurationFlags.APP_HANDLES_UNSUPPORTED_ZDO_REQUESTS|APP_RECEIVES_SUPPORTED_ZDO_REQUESTS: 3>)
[2021-10-30 09:48:11][DEBUG] : Sending: b'444121a9072a3fb159225f7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'4541a1a9072a15cd287e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_STACK_PROFILE: 12>, 2)
[2021-10-30 09:48:11][DEBUG] : Sending: b'554621a9072a19b0595acd7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'5646a1a9072a15ea907e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8610be7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_ADDRESS_TABLE_SIZE: 5>, 16)
[2021-10-30 09:48:11][DEBUG] : Sending: b'664721a9072a10a2593fd87e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'6747a1a9072a154edc7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'87009f7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SECURITY_LEVEL: 13>, 5)
[2021-10-30 09:48:11][DEBUG] : Sending: b'774421a9072a7d38b7597d3a577e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'7044a1a9072a15ae037e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8070787e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SUPPORTED_NETWORKS: 45>, 1)
[2021-10-30 09:48:11][DEBUG] : Sending: b'004521a9072a38b3590df67e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'0145a1a9072a15d7a37e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8160597e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE: 25>, 2)
[2021-10-30 09:48:11][DEBUG] : Sending: b'7d314a21a9072a0cb05920df7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'124aa1a9072a15fd597e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'82503a7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_PAN_ID_CONFLICT_REPORT_THRESHOLD: 34>, 2)
[2021-10-30 09:48:11][DEBUG] : Sending: b'224b21a9072a37b0598b1e7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'234ba1a9072a1559157e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'83401b7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_TC_REJOINS_USING_WELL_KNOWN_KEY_TIMEOUT_S: 56>, 90)
[2021-10-30 09:48:11][DEBUG] : Sending: b'334821a9072a2de859f8027e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'3448a1a9072a15b9ca7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SOURCE_ROUTE_TABLE_SIZE: 26>, 16)
[2021-10-30 09:48:11][DEBUG] : Sending: b'444921a9072a0fa259af007e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'4549a1a9072a15c06a7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_INDIRECT_TRANSMISSION_TIMEOUT: 18>, 7680)
[2021-10-30 09:48:11][DEBUG] : Sending: b'554e21a9072a07b24789e87e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'564ea1a9072a15e7d27e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8610be7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_END_DEVICE_POLL_TIMEOUT: 19>, 8)
[2021-10-30 09:48:11][DEBUG] : Sending: b'664f21a9072a06ba595a1b7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'674fa1a9072a15439e7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'87009f7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_MULTICAST_TABLE_SIZE: 6>, 16)
[2021-10-30 09:48:11][DEBUG] : Sending: b'774c21a9072a7d33a25908fa7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'704ca1a9072a15a3417e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8070787e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'004d21a9fe2a160df07e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'014da1a9fe2a15b3a07e7d7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8160597e'
[2021-10-30 09:48:11][DEBUG] : Application frame 170 (getValue) received: b'0001f9'
[2021-10-30 09:48:11][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'7d315221a9062a1437dc7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'1252a1a9062a15485968c77e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'82503a7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 82 (getConfigurationValue) received: b'00fa00'
[2021-10-30 09:48:11][DEBUG] : Free/configured buffers before all memory allocation: 249/250
[2021-10-30 09:48:11][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>, 255)
[2021-10-30 09:48:11][DEBUG] : Sending: b'225321a9072a144d59127b7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'2353a1a9072a154ed37e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'83401b7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'335021a9fe2a16d8387e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'3450a1a9fe2a15b3a5c6c67e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 170 (getValue) received: b'0001fc'
[2021-10-30 09:48:11][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'445121a9062a146a0c7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'4551a1a9062a154f5984a97e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 82 (getConfigurationValue) received: b'00fd00'
[2021-10-30 09:48:11][DEBUG] : Free/configured buffers after all memory allocation: 252/253
[2021-10-30 09:48:11][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_APS_UNICAST_MESSAGE_COUNT: 3>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'555621a9062a160d157e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'5656a1a9062a15b859b75d7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8610be7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 82 (getConfigurationValue) received: b'000a00'
[2021-10-30 09:48:11][DEBUG] : APS_UNICAST_MESSAGE_COUNT is set to 10
[2021-10-30 09:48:11][DEBUG] : Send command addEndpoint: (1, 260, 48879, 0, 0, 1, [], [1280])
[2021-10-30 09:48:11][DEBUG] : Sending: b'665721a9562a14b6587bf425aa54924c7c287e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'6757a1a9562a153da67e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'87009f7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 2 (addEndpoint) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Ezsp adding endpoint: [<EzspStatus.SUCCESS: 0>]
[2021-10-30 09:48:11][DEBUG] : getting MFG_STRING token
[2021-10-30 09:48:11][DEBUG] : Send command getMfgToken: (<EzspMfgTokenId.MFG_STRING: 1>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'775421a95f2a14685d7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'7054a1a95f2a05f735f12644c8266db663b1d854123198016d7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8070787e'
[2021-10-30 09:48:11][DEBUG] : Application frame 11 (getMfgToken) received: b'10456c656c616273ffffffffffffffffff'
[2021-10-30 09:48:11][DEBUG] : getting MFG_BOARD_NAME token
[2021-10-30 09:48:11][DEBUG] : Send command getMfgToken: (<EzspMfgTokenId.MFG_BOARD_NAME: 2>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'005521a95f2a1780bb7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'0155a1a95f2a05f715c67a1799aa6db663b1d85412319849217e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8160597e'
[2021-10-30 09:48:11][DEBUG] : Application frame 11 (getMfgToken) received: b'10454c52303233ffffffffffffffffffff'
[2021-10-30 09:48:11][DEBUG] : Send command getValue: (<EzspValueId.VALUE_VERSION_INFO: 17>,)
[2021-10-30 09:48:11][DEBUG] : Sending: b'7d315a21a9fe2a04625c7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'125aa1a9fe2a15b58f944c2cab5538a70f7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'82503a7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 170 (getValue) received: b'0007d60006090100aa'
[2021-10-30 09:48:11][INFO] : EZSP Radio manufacturer: Elelabs
[2021-10-30 09:48:11][INFO] : EZSP Radio board name: ELR023
[2021-10-30 09:48:11][INFO] : EmberZNet version: 6.9.1.0 build 214
[2021-10-30 09:48:11][DEBUG] : Send command networkInit: ()
[2021-10-30 09:48:11][DEBUG] : Sending: b'225b21a9432af6d57e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'235ba5a9432a150bfa7e'
[2021-10-30 09:48:11][DEBUG] : Sending: b'83401b7e'
[2021-10-30 09:48:11][DEBUG] : Data frame: b'335bb1a94d2a8529657e'
[2021-10-30 09:48:11][DEBUG] : Application frame 23 (networkInit) received: b'00'
[2021-10-30 09:48:11][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:48:11][DEBUG] : Application frame 25 (stackStatusHandler) received: b'90'
[2021-10-30 09:48:11][DEBUG] : Send command getNetworkParameters: ()
[2021-10-30 09:48:11][DEBUG] : Sending: b'345821a97c2a9ac97e'
[2021-10-30 09:48:16][DEBUG] : ControllerApplication reset unsuccessful:
[2021-10-30 09:48:17][DEBUG] : Data frame: b'4458a1a97c2a15b3e76a1a3ea984639615bb2fa4edce678bfd3e9c8e03d67e'
[2021-10-30 09:48:17][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:17][DEBUG] : Data frame: b'4c58a1a97c2a15b3e76a1a3ea984639615bb2fa4edce678bfd3e9c8e37577e'
[2021-10-30 09:48:17][DEBUG] : Application frame 40 (getNetworkParameters) received: b'0001befe501b03d1f1df89f5080f0000000000f8ff07'
[2021-10-30 09:48:17][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:17][DEBUG] : Error processing 26 response. getNetworkParameters command timed out?
[2021-10-30 09:48:17][DEBUG] : Data frame: b'4c58a1a97c2a15b3e76a1a3ea984639615bb2fa4edce678bfd3e9c8e37577e'
[2021-10-30 09:48:17][DEBUG] : Application frame 40 (getNetworkParameters) received: b'0001befe501b03d1f1df89f5080f0000000000f8ff07'
[2021-10-30 09:48:17][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:17][DEBUG] : Data frame: b'4c58a1a97c2a15b3e76a1a3ea984639615bb2fa4edce678bfd3e9c8e37577e'
[2021-10-30 09:48:17][DEBUG] : Application frame 40 (getNetworkParameters) received: b'0001befe501b03d1f1df89f5080f0000000000f8ff07'
[2021-10-30 09:48:17][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:17][DEBUG] : Error code: ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT, Version: 2, frame: b'c20251a8bd7e'
[2021-10-30 09:48:17][DEBUG] : Application frame 40 (getNetworkParameters) received: b'0001befe501b03d1f1df89f5080f0000000000f8ff07'
[2021-10-30 09:48:17][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-30 09:48:17][DEBUG] : Closed serial connection
[2021-10-30 09:48:21][DEBUG] : Using selector: EpollSelector
[2021-10-30 09:48:21][DEBUG] : Resetting EZSP
[2021-10-30 09:48:21][DEBUG] : Resetting ASH
[2021-10-30 09:48:21][DEBUG] : Sending: b'1ac038bc7e'
[2021-10-30 09:48:22][DEBUG] : RSTACK Version: 2 Reason: RESET_SOFTWARE frame: b'c1020b0a527e'
[2021-10-30 09:48:22][DEBUG] : Send command version: (4,)
[2021-10-30 09:48:22][DEBUG] : Sending: b'004221a850ed2c7e'
[2021-10-30 09:48:22][DEBUG] : Data frame: b'0142a1a85c2805dbd7ae7e'
[2021-10-30 09:48:22][DEBUG] : Sending: b'8160597e'
[2021-10-30 09:48:22][DEBUG] : Application frame 0 (version) received: b'08021069'
[2021-10-30 09:48:22][DEBUG] : Switching to EZSP protocol version 8
[2021-10-30 09:48:22][DEBUG] : Send command version: (8,)
[2021-10-30 09:48:22][DEBUG] : Sending: b'7d314221a9542a1d8cdf7e'
[2021-10-30 09:48:22][DEBUG] : Data frame: b'1242a1a9542a1db049fd70757e'
[2021-10-30 09:48:22][DEBUG] : Sending: b'82503a7e'
[2021-10-30 09:48:22][DEBUG] : Application frame 0 (version) received: b'08021069'
[2021-10-30 09:48:23][DEBUG] : EZSP Stack Type: 2, Stack Version: 6910, Protocol version: 8
[2021-10-30 09:48:23][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-30 09:48:23][DEBUG] : Sending: b'224321a9fe2a1683467e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'2343a1a9fe2a15b3a081f77e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'83401b7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 170 (getValue) received: b'0001f9'
[2021-10-30 09:48:23][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-30 09:48:23][DEBUG] : Sending: b'334021a9062a14a80d7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'3440a1a9062a15485927a17e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 82 (getConfigurationValue) received: b'00fa00'
[2021-10-30 09:48:23][DEBUG] : Free/configured buffers before any configurations: 249/250
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_APPLICATION_ZDO_FLAGS: 42>, <EmberZdoConfigurationFlags.APP_HANDLES_UNSUPPORTED_ZDO_REQUESTS|APP_RECEIVES_SUPPORTED_ZDO_REQUESTS: 3>)
[2021-10-30 09:48:23][DEBUG] : Sending: b'444121a9072a3fb159225f7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'4541a1a9072a15cd287e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_STACK_PROFILE: 12>, 2)
[2021-10-30 09:48:23][DEBUG] : Sending: b'554621a9072a19b0595acd7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'5646a1a9072a15ea907e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8610be7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_ADDRESS_TABLE_SIZE: 5>, 16)
[2021-10-30 09:48:23][DEBUG] : Sending: b'664721a9072a10a2593fd87e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'6747a1a9072a154edc7e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'87009f7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SECURITY_LEVEL: 13>, 5)
[2021-10-30 09:48:23][DEBUG] : Sending: b'774421a9072a7d38b7597d3a577e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'7044a1a9072a15ae037e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8070787e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SUPPORTED_NETWORKS: 45>, 1)
[2021-10-30 09:48:23][DEBUG] : Sending: b'004521a9072a38b3590df67e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'0145a1a9072a15d7a37e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8160597e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE: 25>, 2)
[2021-10-30 09:48:23][DEBUG] : Sending: b'7d314a21a9072a0cb05920df7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'124aa1a9072a15fd597e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'82503a7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_PAN_ID_CONFLICT_REPORT_THRESHOLD: 34>, 2)
[2021-10-30 09:48:23][DEBUG] : Sending: b'224b21a9072a37b0598b1e7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'234ba1a9072a1559157e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'83401b7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_TC_REJOINS_USING_WELL_KNOWN_KEY_TIMEOUT_S: 56>, 90)
[2021-10-30 09:48:23][DEBUG] : Sending: b'334821a9072a2de859f8027e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'3448a1a9072a15b9ca7e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SOURCE_ROUTE_TABLE_SIZE: 26>, 16)
[2021-10-30 09:48:23][DEBUG] : Sending: b'444921a9072a0fa259af007e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'4549a1a9072a15c06a7e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_INDIRECT_TRANSMISSION_TIMEOUT: 18>, 7680)
[2021-10-30 09:48:23][DEBUG] : Sending: b'554e21a9072a07b24789e87e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'564ea1a9072a15e7d27e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8610be7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_END_DEVICE_POLL_TIMEOUT: 19>, 8)
[2021-10-30 09:48:23][DEBUG] : Sending: b'664f21a9072a06ba595a1b7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'674fa1a9072a15439e7e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'87009f7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_MULTICAST_TABLE_SIZE: 6>, 16)
[2021-10-30 09:48:23][DEBUG] : Sending: b'774c21a9072a7d33a25908fa7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'704ca1a9072a15a3417e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8070787e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-30 09:48:23][DEBUG] : Sending: b'004d21a9fe2a160df07e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'014da1a9fe2a15b3a07e7d7e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8160597e'
[2021-10-30 09:48:23][DEBUG] : Application frame 170 (getValue) received: b'0001f9'
[2021-10-30 09:48:23][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-30 09:48:23][DEBUG] : Sending: b'7d315221a9062a1437dc7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'1252a1a9062a15485968c77e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'82503a7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 82 (getConfigurationValue) received: b'00fa00'
[2021-10-30 09:48:23][DEBUG] : Free/configured buffers before all memory allocation: 249/250
[2021-10-30 09:48:23][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>, 255)
[2021-10-30 09:48:23][DEBUG] : Sending: b'225321a9072a144d59127b7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'2353a1a9072a154ed37e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'83401b7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-30 09:48:23][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-30 09:48:23][DEBUG] : Sending: b'335021a9fe2a16d8387e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'3450a1a9fe2a15b3a5c6c67e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 170 (getValue) received: b'0001fc'
[2021-10-30 09:48:23][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-30 09:48:23][DEBUG] : Sending: b'445121a9062a146a0c7e'
[2021-10-30 09:48:23][DEBUG] : Data frame: b'4551a1a9062a154f5984a97e'
[2021-10-30 09:48:23][DEBUG] : Sending: b'8520dd7e'
[2021-10-30 09:48:23][DEBUG] : Application frame 82 (getConfigurationValue) received: b'00fd00'
[2021-10-30 09:48:23][DEBUG] : Free/configured buffers after all memory allocation: 252/253
[2021-10-30 09:48:23][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_APS_UNICAST_MESSAGE_COUNT: 3>,)
[...]
[2021-10-30 09:48:35][DEBUG] : Send command networkInit: ()
[2021-10-30 09:48:35][DEBUG] : Sending: b'225b21a9432af6d57e'
[2021-10-30 09:48:35][DEBUG] : Data frame: b'235ba5a9432a150bfa7e'
[2021-10-30 09:48:35][DEBUG] : Sending: b'83401b7e'
[2021-10-30 09:48:35][DEBUG] : Application frame 23 (networkInit) received: b'00'
[2021-10-30 09:48:35][DEBUG] : Data frame: b'335bb1a94d2a8529657e'
[2021-10-30 09:48:35][DEBUG] : Sending: b'8430fc7e'
[2021-10-30 09:48:35][DEBUG] : Send command getNetworkParameters: ()
[2021-10-30 09:48:35][DEBUG] : Application frame 25 (stackStatusHandler) received: b'90'
[2021-10-30 09:48:35][DEBUG] : Sending: b'345821a97c2a9ac97e'

J’arrive à alumer ma lampe mais lorsque je demande l’état pour rafraichir le widget ça plante…

9

Ressaye quand même.
Comment as tu fait ton downgrade. Pour ma part je conseille de faire une sauvegarde Jeedom avant tout upgrade et de restaurer si l’upgrade ne marche pas.
La réinstallation, du plug in à une version antérieure n’étant pas un réel downgrade

10

Que le plugin… Je test de passer la backup du 25.

11

Full restaure… Et pareil !!!

12

Juste avec les infos :

[2021-10-30 10:30:52][INFO] : Start zigbeed
[2021-10-30 10:30:52][INFO] : Log level : info
[2021-10-30 10:30:52][INFO] : PID file : /tmp/jeedom/zigbee/deamon_1.pid
[2021-10-30 10:30:52][INFO] : Device : auto
[2021-10-30 10:30:52][INFO] : Apikey : xxxxx
[2021-10-30 10:30:52][INFO] : Callback : http://127.0.0.1:80/plugins/zigbee/core/php/jeeZigbee.php
[2021-10-30 10:30:52][INFO] : Cycle : 0.3
[2021-10-30 10:30:52][INFO] : Controller : ezsp
[2021-10-30 10:30:52][INFO] : Channel : 15
[2021-10-30 10:30:52][INFO] : Data folder : /var/www/html/plugins/zigbee/data/1
[2021-10-30 10:30:52][INFO] : Device folder : /var/www/html/plugins/zigbee/data/device
[2021-10-30 10:30:52][INFO] : Folder OTA : /var/www/html/plugins/zigbee/data/ota
[2021-10-30 10:30:52][INFO] : Zigpy advance configuration file : None
[2021-10-30 10:30:54][INFO] : Find device : /dev/ttyUSB2
[2021-10-30 10:30:54][INFO] : LOADER------Import de la configuration specifics.danfoss
[2021-10-30 10:30:54][INFO] : LOADER------Import de la configuration specifics.danfoss.details
[2021-10-30 10:30:54][INFO] : LOADER------Import de la configuration specifics.develco
[2021-10-30 10:30:54][INFO] : LOADER------Import de la configuration specifics.develco.details
[2021-10-30 10:30:54][INFO] : LOADER------Import de la configuration specifics.frient
[2021-10-30 10:30:54][INFO] : LOADER------Import de la configuration specifics.frient.details
[2021-10-30 10:30:54][INFO] : LOADER------Import de la configuration specifics.schneider
[2021-10-30 10:30:54][INFO] : LOADER------Import de la configuration specifics.schneider.details
[2021-10-30 10:30:54][INFO] : Writing PID 19035 to /tmp/jeedom/zigbee/deamon_1.pid
[2021-10-30 10:30:54][INFO] : Init request module v2.25.1
[2021-10-30 10:30:54][INFO] : [start_zigbee] Init zigbee network with config : {'database_path': '/var/www/html/plugins/zigbee/data/1/network_ezsp.db', 'device': {'path': '/dev/ttyUSB2', 'baudrate': 115200}, 'network': {'channel': 15}, 'ota': {'otau_directory': '/var/www/html/plugins/zigbee/data/ota', 'ikea_provider': True, 'ikea_update_url': 'http://fw.ota.homesmart.ikea.net/feed/version_info.json', 'ledvance_provider': True}, 'ezsp': {'CONFIG_APS_UNICAST_MESSAGE_COUNT': 12, 'CONFIG_SOURCE_ROUTE_TABLE_SIZE': 16, 'CONFIG_ADDRESS_TABLE_SIZE': 8}}
[2021-10-30 10:30:55][INFO] : Trådfri: OTA provider enabled
[2021-10-30 10:30:55][INFO] : Ledvance: OTA provider enabled
[2021-10-30 10:30:58][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-30 10:30:59][INFO] : EZSP Radio manufacturer: Elelabs
[2021-10-30 10:30:59][INFO] : EZSP Radio board name: ELR023
[2021-10-30 10:30:59][INFO] : EmberZNet version: 6.9.1.0 build 214
[2021-10-30 10:31:04][ERROR] : Couldn't start application
[2021-10-30 10:31:04][INFO] : Shutting down ControllerApplication
[2021-10-30 10:31:04][ERROR] : [start_zigbee] Fatal error :
[2021-10-30 10:31:04][INFO] : Traceback (most recent call last):
File "/var/www/html/plugins/zigbee/resources/zigbeed/zigbeed.py", line 102, in start_zigbee
start_radio=True,
File "/usr/local/lib/python3.7/dist-packages/zigpy/application.py", line 69, in new
await app.startup(auto_form)
File "/usr/local/lib/python3.7/dist-packages/bellows/zigbee/application.py", line 151, in startup
status, node_type, nwk_params = await ezsp.getNetworkParameters()
File "/usr/lib/python3.7/asyncio/tasks.py", line 423, in wait_for
raise futures.TimeoutError()
concurrent.futures._base.TimeoutError
[2021-10-30 10:31:04][INFO] : Shutdown
[2021-10-30 10:31:04][INFO] : Removing PID file /tmp/jeedom/zigbee/deamon_1.pid
[2021-10-30 10:31:04][INFO] : Exit 0

J’ai même changé le port USB au cas où…

Le jour où j’ai constaté l’instabilité j’ai aussi fait un apt upgrade :

Start-Date: 2021-10-25  10:05:29
Commandline: apt upgrade
Install: zip:arm64 (3.0-11+b1, automatic)
Upgrade: debconf:arm64 (1.5.71, 1.5.71+deb10u1), linux-image-current-meson64:arm64 (21.05.4, 21.08.1), libkrb5-3:arm64 (1.17-3+deb10u1, 1.17-3+deb10u3), libavformat58:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), libgssapi-krb5-2:arm64 (1.17-3+deb10u1, 1.17-3+deb10u3), libavfilter7:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), ffmpeg:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), linux-libc-dev:arm64 (4.19.194-2, 21.08.2), openssl:arm64 (1.1.1d-0+deb10u6, 1.1.1d-0+deb10u7), libswresample3:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), ntfs-3g:arm64 (1:2017.3.23AR.3-3, 1:2017.3.23AR.3-3+deb10u1), libsystemd0:arm64 (241-7~deb10u7, 241-7~deb10u8), debconf-utils:arm64 (1.5.71, 1.5.71+deb10u1), mariadb-common:arm64 (1:10.3.29-0+deb10u1, 1:10.3.31-0+deb10u1), mariadb-server-core-10.3:arm64 (1:10.3.29-0+deb10u1, 1:10.3.31-0+deb10u1), libk5crypto3:arm64 (1.17-3+deb10u1, 1.17-3+deb10u3), linux-dtb-current-meson64:arm64 (21.05.4, 21.08.1), udev:arm64 (241-7~deb10u7, 241-7~deb10u8), libntfs-3g883:arm64 (1:2017.3.23AR.3-3, 1:2017.3.23AR.3-3+deb10u1), apache2-data:arm64 (2.4.38-3+deb10u5, 2.4.38-3+deb10u6), libpostproc55:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), libudev1:arm64 (241-7~deb10u7, 241-7~deb10u8), mariadb-server-10.3:arm64 (1:10.3.29-0+deb10u1, 1:10.3.31-0+deb10u1), telegraf:arm64 (1.19.1-1, 1.20.2-1), armbian-firmware:arm64 (21.05.6, 21.08.3), libudev-dev:arm64 (241-7~deb10u7, 241-7~deb10u8), psmisc:arm64 (23.2-1, 23.2-1+deb10u1), libkrb5support0:arm64 (1.17-3+deb10u1, 1.17-3+deb10u3), libnss-myhostname:arm64 (241-7~deb10u7, 241-7~deb10u8), systemd-sysv:arm64 (241-7~deb10u7, 241-7~deb10u8), libavcodec58:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), libpam-systemd:arm64 (241-7~deb10u7, 241-7~deb10u8), libavutil56:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), distro-info-data:arm64 (0.41+deb10u3, 0.41+deb10u4), libsndfile1:arm64 (1.0.28-6, 1.0.28-6+deb10u1), armbian-config:arm64 (21.02.4, 21.08.3), systemd:arm64 (241-7~deb10u7, 241-7~deb10u8), libavdevice58:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), linux-u-boot-odroidc2-current:arm64 (21.05.4, 21.08.1), libswscale5:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), mariadb-client-10.3:arm64 (1:10.3.29-0+deb10u1, 1:10.3.31-0+deb10u1), mariadb-server:arm64 (1:10.3.29-0+deb10u1, 1:10.3.31-0+deb10u1), mariadb-client-core-10.3:arm64 (1:10.3.29-0+deb10u1, 1:10.3.31-0+deb10u1), mariadb-client:arm64 (1:10.3.29-0+deb10u1, 1:10.3.31-0+deb10u1), apache2-bin:arm64 (2.4.38-3+deb10u5, 2.4.38-3+deb10u6), apache2:arm64 (2.4.38-3+deb10u5, 2.4.38-3+deb10u6), apache2-utils:arm64 (2.4.38-3+deb10u5, 2.4.38-3+deb10u6), libavresample4:arm64 (7:4.1.6-1~deb10u1, 7:4.1.8-0+deb10u1), base-files:arm64 (10.3+deb10u10, 10.3+deb10u11), tzdata:arm64 (2021a-0+deb10u1, 2021a-0+deb10u2)
End-Date: 2021-10-25  10:12:01
13

Si je le fais j’ai ça :

dmesg | grep -i Voltage
[    1.154673] reg-fixed-voltage regulator-vcc1v8: Failed to register regulator: -517

C’est grave ?

14

Après une nuit à fonctionner… Le daemon est up mais ne fait pas grand chose…

2021-10-31 08:56:19][INFO] : [DeviceHandler.prepare] Json arg : None
[2021-10-31 08:56:19][INFO] : [cc:cc:cc:ff:fe:a5:f0:ae][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [NetworkHandler.prepare] Json arg : None
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 10 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 6 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 11 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 5 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 11 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 6 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 12 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 5 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:19][INFO] : 200 GET /network/map (127.0.0.1) 62.05ms
[2021-10-31 08:56:19][INFO] : [5c:02:72:ff:fe:92:29:dc][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [ApplicationHandler.prepare] Json arg : None
[2021-10-31 08:56:19][INFO] : [5c:02:72:ff:fe:97:fb:af][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:e4:59:71][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:f5:0f:0f][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:e4:2f:26][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:f5:0b:84][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [5c:02:72:ff:fe:87:46:40][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:e4:6f:94][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [5c:02:72:ff:fe:97:0a:50][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:d3:a1:9e][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:0b:2d:4a][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:03:12:ec:e9][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:b9:21:6d][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:e4:2f:38][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [5c:02:72:ff:fe:88:c9:a4][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:02:23:67:b1][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:02:25:08:8e][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:04:9f:c2:aa][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:0e:d5:96][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:03:8d:bd][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:f5:34:70][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:de:65:e1][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:03:21:78:75][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:02:23:47:87][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:f5:0b:5d][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:05:6e:5b:f8][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:0a:e4:21][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [5c:02:72:ff:fe:c9:bf:c1][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:06:50:1b:0a][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [60:a4:23:ff:fe:0f:4f:15][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:06:51:84:d0][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [84:2e:14:ff:fe:65:50:25][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [3c:6a:2c:ff:fe:d0:ce:c3][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:01:da:cf:02][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : [00:15:8d:00:03:13:c8:ba][zdevices.serialize] Serialize device with attributes : 1
[2021-10-31 08:56:19][INFO] : 200 GET /device/all (127.0.0.1) 230.54ms
[2021-10-31 08:56:24][INFO] : Traceback (most recent call last):
File "/var/www/html/plugins/zigbee/resources/zigbeed/restServer.py", line 55, in get
info = await utils.serialize_application()
File "/var/www/html/plugins/zigbee/resources/zigbeed/utils.py", line 49, in serialize_application
status, node_type, network_params = await shared.ZIGPY._ezsp.getNetworkParameters()
File "/usr/lib/python3.7/asyncio/tasks.py", line 423, in wait_for
raise futures.TimeoutError()
concurrent.futures._base.TimeoutError
[2021-10-31 08:56:24][INFO] : 200 GET /application/info (127.0.0.1) 5076.01ms
[2021-10-31 08:56:25][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:25][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:25][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:27][INFO] : EZSP Radio manufacturer: Elelabs
[2021-10-31 08:56:27][INFO] : EZSP Radio board name: ELR023
[2021-10-31 08:56:27][INFO] : EmberZNet version: 6.9.1.0 build 214
[2021-10-31 08:56:27][INFO] : [NetworkHandler.prepare] Json arg : None
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 10 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 6 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 11 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 5 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 11 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 6 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 12 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 5 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : [map.scan] Done scanning. Total 0 neighbours
[2021-10-31 08:56:27][INFO] : 200 GET /network/map (127.0.0.1) 71.19ms
[2021-10-31 08:56:33][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:33][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:33][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:33][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:39][INFO] : EZSP Radio manufacturer: Elelabs
[2021-10-31 08:56:39][INFO] : EZSP Radio board name: ELR023
[2021-10-31 08:56:39][INFO] : EmberZNet version: 6.9.1.0 build 214
[2021-10-31 08:56:45][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:45][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:45][ERROR] : NCP entered failed state. Requesting APP controller restart
[2021-10-31 08:56:45][ERROR] : NCP entered failed state. Requesting APP controller restart

J’en vens à me demander si le problème n’est pas hardware et si jen e dois pas racheter un popp…

15

Bonjour, je pense avoir le même soucis. J’avais une zigate, et j’essai de passer sur une ELELABS POPP reçu il y a quelques jours. Le démon commence à démarrer et s’arrête, j’ai l’impression à l’appel de getNetworkParameters. Voici un extrait du log du démon :

[2021-10-31 21:14:46][DEBUG] : Resetting EZSP
[2021-10-31 21:14:46][DEBUG] : Resetting ASH
[2021-10-31 21:14:46][DEBUG] : Sending: b'1ac038bc7e'
[2021-10-31 21:14:48][DEBUG] : RSTACK Version: 2 Reason: RESET_SOFTWARE frame: b'c1020b0a527e'
[2021-10-31 21:14:48][DEBUG] : Send command version: (4,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'004221a850ed2c7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'0142a1a8522825d2e23b7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8160597e'
[2021-10-31 21:14:48][DEBUG] : Application frame 0 (version) received: b'06023060'
[2021-10-31 21:14:48][DEBUG] : Switching to EZSP protocol version 6
[2021-10-31 21:14:48][DEBUG] : Send command version: (6,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'7d31422157542a7d3350067e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'1242a157542a13b069f458f07e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'82503a7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 0 (version) received: b'06023060'
[2021-10-31 21:14:48][DEBUG] : EZSP Stack Type: 2, Stack Version: 6030, Protocol version: 6
[2021-10-31 21:14:48][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'2243215754801636b97e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'2343a157548015b36f565c7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'83401b7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 170 (getValue) received: b'000136'
[2021-10-31 21:14:48][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'33402157547814cd697e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'3440a157547815f2590e9a7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8430fc7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 82 (getConfigurationValue) received: b'004000'
[2021-10-31 21:14:48][DEBUG] : Free/configured buffers before any configurations: 54/64
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_STACK_PROFILE: 12>, 2)
[2021-10-31 21:14:48][DEBUG] : Sending: b'44412157547919b05921107e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'4541a157547915ac4d7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8520dd7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_ADDRESS_TABLE_SIZE: 5>, 16)
[2021-10-31 21:14:48][DEBUG] : Sending: b'55462157547910a259a5557e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'5646a1575479158bf57e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8610be7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_MAX_END_DEVICE_CHILDREN: 17>, 32)
[2021-10-31 21:14:48][DEBUG] : Sending: b'664721575479049259a1f67e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'6747a1575479152fb97e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'87009f7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_KEY_TABLE_SIZE: 30>, 4)
[2021-10-31 21:14:48][DEBUG] : Sending: b'7744215754790bb659374d7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'7044a157547915cf667e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8070787e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_END_DEVICE_POLL_TIMEOUT: 19>, 60)
[2021-10-31 21:14:48][DEBUG] : Sending: b'004521575479068e59a4837e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'0145a157547915b6c67e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8160597e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SUPPORTED_NETWORKS: 45>, 1)
[2021-10-31 21:14:48][DEBUG] : Sending: b'7d314a2157547938b35968f17e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'124aa1575479159c3c7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'82503a7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SOURCE_ROUTE_TABLE_SIZE: 26>, 16)
[2021-10-31 21:14:48][DEBUG] : Sending: b'224b215754790fa259867d337e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'234ba15754791538707e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'83401b7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE: 25>, 2)
[2021-10-31 21:14:48][DEBUG] : Sending: b'3348215754790cb059cafa7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'3448a157547915d8af7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8430fc7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT: 27>, 8)
[2021-10-31 21:14:48][DEBUG] : Sending: b'4449215754790eba5916f27e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'4549a157547915a10f7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8520dd7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_APPLICATION_ZDO_FLAGS: 42>, <EmberZdoConfigurationFlags.APP_HANDLES_UNSUPPORTED_ZDO_REQUESTS|APP_RECEIVES_SUPPORTED_ZDO_REQUESTS: 3>)
[2021-10-31 21:14:48][DEBUG] : Sending: b'554e215754793fb15947587e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'564ea15754791586b77e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8610be7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_INDIRECT_TRANSMISSION_TIMEOUT: 18>, 7680)
[2021-10-31 21:14:48][DEBUG] : Sending: b'664f2157547907b2477d33657e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'674fa15754791522fb7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'87009f7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_PAN_ID_CONFLICT_REPORT_THRESHOLD: 34>, 2)
[2021-10-31 21:14:48][DEBUG] : Sending: b'774c2157547937b05933f57e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'704ca157547915c2247e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8070787e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_SECURITY_LEVEL: 13>, 5)
[2021-10-31 21:14:48][DEBUG] : Sending: b'004d215754797d38b7595d367e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'014da157547915bb847e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8160597e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_MULTICAST_TABLE_SIZE: 6>, 16)
[2021-10-31 21:14:48][DEBUG] : Sending: b'7d3152215754797d33a2590dea7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'1252a157547920ed0c7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'82503a7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'35'
[2021-10-31 21:14:48][WARNING] : Couldn't set EzspConfigId.CONFIG_MULTICAST_TABLE_SIZE=16 configuration value: EzspStatus.ERROR_OUT_OF_MEMORY
[2021-10-31 21:14:48][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'225321575480162c3d7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'2353a157548015b36f6be87e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'83401b7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 170 (getValue) received: b'000136'
[2021-10-31 21:14:48][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'33502157547814d7ed7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'3450a157547815f259332e7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8430fc7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 82 (getConfigurationValue) received: b'004000'
[2021-10-31 21:14:48][DEBUG] : Free/configured buffers before all memory allocation: 54/64
[2021-10-31 21:14:48][DEBUG] : Send command setConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>, 255)
[2021-10-31 21:14:48][DEBUG] : Sending: b'445121575479144d593b687e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'4551a157547915b6c97e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8520dd7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 83 (setConfigurationValue) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Send command getValue: (<EzspValueId.VALUE_FREE_BUFFERS: 3>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'55562157548016f2197e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'5656a157548015b36fff417e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8610be7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 170 (getValue) received: b'000136'
[2021-10-31 21:14:48][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'665721575478148c9c7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'6757a157547815f259d5557e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'87009f7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 82 (getConfigurationValue) received: b'004000'
[2021-10-31 21:14:48][DEBUG] : Free/configured buffers after all memory allocation: 54/64
[2021-10-31 21:14:48][DEBUG] : Send command getConfigurationValue: (<EzspConfigId.CONFIG_APS_UNICAST_MESSAGE_COUNT: 3>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'77542157547816ed247e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'7054a157547815b8591d727e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8070787e'
[2021-10-31 21:14:48][DEBUG] : Application frame 82 (getConfigurationValue) received: b'000a00'
[2021-10-31 21:14:48][DEBUG] : APS_UNICAST_MESSAGE_COUNT is set to 10
[2021-10-31 21:14:48][DEBUG] : Send command addEndpoint: (1, 260, 48879, 0, 0, 1, [], [1280])
[2021-10-31 21:14:48][DEBUG] : Sending: b'00552157542814b6587bf425aa54924ccdb27e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'0155a15754281591cc7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8160597e'
[2021-10-31 21:14:48][DEBUG] : Application frame 2 (addEndpoint) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Ezsp adding endpoint: [<EzspStatus.SUCCESS: 0>]
[2021-10-31 21:14:48][DEBUG] : getting MFG_STRING token
[2021-10-31 21:14:48][DEBUG] : Send command getMfgToken: (<EzspMfgTokenId.MFG_STRING: 1>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'7d315a2157542114ebdd7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'125aa157542105f735f12644c8266db663b1d854123198314e7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'82503a7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 11 (getMfgToken) received: b'10456c656c616273ffffffffffffffffff'
[2021-10-31 21:14:48][DEBUG] : getting MFG_BOARD_NAME token
[2021-10-31 21:14:48][DEBUG] : Send command getMfgToken: (<EzspMfgTokenId.MFG_BOARD_NAME: 2>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'225b21575421171f7d317e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'235ba157542105f715c67a1799aa6db663b1d854123198b8da7e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'83401b7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 11 (getMfgToken) received: b'10454c52303233ffffffffffffffffffff'
[2021-10-31 21:14:48][DEBUG] : Send command getValue: (<EzspValueId.VALUE_VERSION_INFO: 17>,)
[2021-10-31 21:14:48][DEBUG] : Sending: b'3358215754800452f67e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'3458a157548015b519954c25a95538a9307e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8430fc7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 170 (getValue) received: b'0007400106000300aa'
[2021-10-31 21:14:48][INFO] : EZSP Radio manufacturer: Elelabs
[2021-10-31 21:14:48][INFO] : EZSP Radio board name: ELR023
[2021-10-31 21:14:48][INFO] : EmberZNet version: 6.0.3.0 build 320
[2021-10-31 21:14:48][DEBUG] : Send command networkInit: ()
[2021-10-31 21:14:48][DEBUG] : Sending: b'44592157543d60ce7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'4559a557543d15f3857e'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8520dd7e'
[2021-10-31 21:14:48][DEBUG] : Data frame: b'5559b157543385e9147e'
[2021-10-31 21:14:48][DEBUG] : Application frame 23 (networkInit) received: b'00'
[2021-10-31 21:14:48][DEBUG] : Sending: b'8610be7e'
[2021-10-31 21:14:48][DEBUG] : Application frame 25 (stackStatusHandler) received: b'90'
[2021-10-31 21:14:48][DEBUG] : Send command getNetworkParameters: ()
[2021-10-31 21:14:48][DEBUG] : Sending: b'565e2157540251627e'
[2021-10-31 21:14:53][ERROR] : Couldn't start application
[2021-10-31 21:14:53][DEBUG] : executing functools.partial(<built-in method close of sqlite3.Connection object at 0xffff7e7f5e30>)
[2021-10-31 21:14:53][DEBUG] : operation functools.partial(<built-in method close of sqlite3.Connection object at 0xffff7e7f5e30>) completed
[2021-10-31 21:14:53][INFO] : Shutting down ControllerApplication
[2021-10-31 21:14:53][ERROR] : [start_zigbee] Fatal error : 
[2021-10-31 21:14:53][DEBUG] : Closed serial connection
[2021-10-31 21:14:53][INFO] : Traceback (most recent call last):
  File "/var/www/html/plugins/zigbee/resources/zigbeed/zigbeed.py", line 102, in start_zigbee
    start_radio=True,
  File "/usr/local/lib/python3.7/dist-packages/zigpy/application.py", line 69, in new
    await app.startup(auto_form)
  File "/usr/local/lib/python3.7/dist-packages/bellows/zigbee/application.py", line 151, in startup
    status, node_type, nwk_params = await ezsp.getNetworkParameters()
  File "/usr/lib/python3.7/asyncio/tasks.py", line 423, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError

[2021-10-31 21:14:53][INFO] : Shutdown
[2021-10-31 21:14:53][INFO] : Removing PID file /tmp/jeedom/zigbee/deamon_1.pid
[2021-10-31 21:14:53][INFO] : Exit 0

Si besoin de plus d’infos, je peux fournir.

16

Effectivement ça y ressemble… Je suis en train de monter un VM sur Debian 10 pour tester… Je me demande si le problème ne vient pas de zigpy du coup maintenant.

17

On n’est pas les seuls : Erreur: NCP entered failed state. Requesting APP controller restart

Apparemment certain trifouille leur db SQLite: zigpy couldn't start after update to core-2021.7.0 - githubmemory

18

Tu t’en sors ? Moi j’ai essayé de réinclure plein de module mais c’est pareil !

19

Bonsoir,
J’avais le même pb avec ma nouvelle cle POPP.
Je viens de refaire une machine avec la nouvelle image du 1-11-21, install plugin Zigbee …
et cela fonctionne. le demon ne s’arrête plus et pas d’erreur dans les logs. Espérons que cela tienne.

20

Tu as bien réimporté ton backup de Jeedom ?