Me semble bon…
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…
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
Que le plugin… Je test de passer la backup du 25.
Full restaure… Et pareil !!!
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
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 ?
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…
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.
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.
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
Tu t’en sors ? Moi j’ai essayé de réinclure plein de module mais c’est pareil !
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.
Tu as bien réimporté ton backup de Jeedom ?
Non, ce sera l’étape suivante. Mais pour tenter de cerner le pb, j’avais entre autres refait un rpi depuis l’image Jeedom du 1-10-21, version 4.1.25) + plugin Zigbee et cela merdait déjà. A noter que je n’avais pas fait d’apt update/upgrade. Au vu des nombreux posts sur ce pb ces mises à jour ne résolvaient pas le pb.
OK donc ta solution c’est une fresh install from scratch ? Un peu violent qd même…
Plutot que de faire régulièrement des apt-get …, je refais un disque avec une image jeedom + rechargement backup jeedom. C’est facile, ca marche tjrs. et de toute façon c’est la procédure la plus aisée en cas de crash → je m’entraîne 
Tu avances @cde55 ? De mon côté, je viens de télécharger l’image officielle de la smart pour la comparer à mon ARMbian (je suis en Odroid C2)… Mais rien de probant, là je commence à sécher…
J’ai installer un nouveau Jeedom sur une VM debian buster. J’ai importer une sauvegarde de mon Jeedom en « production » (sous odroid C4).
→ Le démon démarre bien.
Je vais réinstaller un Jeedom sur la odroid C4 pour voir si ça résous mon problème (d’ici quelques jour, quand j’aurais le temps).
Salut @llaumgui, je viens de remettre une image jeedom (celle établie le 01-11-21, pas celle établie début octobre) et recharger backup de hier soir. Tout fonctionne et le plugin Zigbee s’installe sans pb.
Cette nouvelle install tourne depuis 7h30 ce matin et tout va bien. Il a bien entendu fallu attendre que toutes les dépendances des plugin se réinstallent mais à 8h tout était OK. Reste maintenant à commencer l’inclusion des équipement Zigbee.