Bonjour,
J’ai un RPI 3B+ sous Raspbian GNU/Linux 10 (buster) avec jeedom d’installé dessus en version 4.4.10 avec les plugins zwave et zigbee officiel de Jeedom.
Tout en « stable ».
Je l’ai installé depuis plus de 3 ans et je n’avais aucun soucis.
IP : 10.1.200.10
Note : Mon problème existait en 4.4.9, ce n’est donc pas la mise à jour en 4.4.10 la cause.
Problème : J’ai mon RPI qui a rebooté (le 07/08) et depuis j’ai un souci de remontées des infos de mes équipements dans jeedom que ce soit ceux via zigbee que ceux via zwave.
Cependant, le plugin semble bien récupérer les infos d’après les traces.
C’est « la remontée » dans jeedom qui ne semble pas fonctionner… et je n’arrive pas à trouver ce qui « bloque » côté jeedom …
Par exemple côté zigbee j’ai 2 prises « NOUS » qui mesurent la consommation électrique de ma machine à bière et l’autre de mon robot tondeuse.
Ces 2 appareils fonctionnant je n’ai aucun doute sur la consommation d’électricité.
Via le plugin zigbee (stable - officiel jeedom), j’ai donc une commande permettant de rafraichir les infos. Quand je lance cette « commande » (bouton Tester dans l’interface de l’équipement) j’ai bien des traces dans le fichier de logs du plugin (zigbeed_1) que les valeurs de consommation et de puissance courante sont correctement récupérées et envoyées dans Jeedom :
[2024-08-16 22:10:29][INFO] : Send to jeedom : {'devices': {'a4:c1:38:d3:ce:1f:ac:87': {'1': {'6': {'0': {'value': 'Bool.true', 'cluster_name': 'On/Off'}}, '1794': {'0': {'value': '18088', 'cluster_name': 'TuyaZBMeteringCluster'}}, '2820': {'1291': {'value': '64', 'cluster_name': 'Electrical Measurement'}}}}}}
-
Consommation = 180088 (‹ 1794 ›: {‹ 0 ›: {‹ value ›: ‹ 18088 ›, ‹ cluster_name ›: ‹ TuyaZBMeteringCluster ›}})
-
Puissance courante = 64 (‹ 2820 ›: {‹ 1291 ›: {‹ value ›: ‹ 64 ›, ‹ cluster_name ›: ‹ Electrical Measurement ›}})
Voici la trace complète en mode debug quand je lance la commande via le bouton « Tester »
[2024-08-16 22:10:29][INFO] : [DeviceHandler.prepare] Json arg : {'ieee': 'a4:c1:38:d3:ee:1f:ac:87', 'endpoint': 1, 'cluster': 6, 'cluster_type': 'in', 'attributes': [0], 'allowCache': 0}
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0006] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True, *is_reply=False), tsn=116, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>, *is_reply=False)
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0006] Sending request: Read_Attributes(attribute_ids=[0])
[2024-08-16 22:10:29][DEBUG] : Sending Zigbee request with tsn 116 under 117 request id, data: b'0074000000'
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_request (20, 117, <DeconzSendDataFlags.NONE: 0>, <DeconzAddressEndpoint address_mode=2 address=0x734B endpoint=1>, 260, 6, 1, b'\x00t\x00\x00\x00', <DeconzTransmitOptions.USE_NWK_KEY_SECURITY: 2>, 0)
[2024-08-16 22:10:29][DEBUG] : Send: 0x12c7001b0014007500024b73010401060001050000740000000200
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x12c700090002002275
[2024-08-16 22:10:29][DEBUG] : APS data request response: [2, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, 117]
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x0ec8000700a600
[2024-08-16 22:10:29][DEBUG] : Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_CONFIRM|2: 166>, 0]
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_confirm (0,)
[2024-08-16 22:10:29][DEBUG] : Send: 0x04c80007000000
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x0ec9000700ae00
[2024-08-16 22:10:29][DEBUG] : Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_INDICATION|APSDE_DATA_CONFIRM|2: 174>, 0]
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x04c80013000c002a75024b7301010000000000
[2024-08-16 22:10:29][DEBUG] : APS data confirm response for request with id 117: 00
[2024-08-16 22:10:29][DEBUG] : Request id: 0x75 'aps_data_confirm' for <DeconzAddressEndpoint address_mode=ADDRESS_MODE.NWK address=0x734b endpoint=1>, status: 0x00
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_indication (1, 1)
[2024-08-16 22:10:29][DEBUG] : Send: 0x17c9000800010001
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.658321, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0})
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.658321, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0}) completed
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x17c90026001f002202000001024b7301040106000800187401000000100100afffa7468200d2
[2024-08-16 22:10:29][DEBUG] : APS data indication response: [31, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x0000>, 1, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x734b>, 1, 260, 6, b'\x18t\x01\x00\x00\x00\x10\x01', 0, 175, 255, 167, 70, 130, 0, -46]
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0006] Received ZCL frame: b'\x18t\x01\x00\x00\x00\x10\x01'
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True, *is_reply=True), tsn=116, command_id=1, *direction=<Direction.Client_to_Server: 1>, *is_reply=True)
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0006] Decoded ZCL frame: TuyaZBOnOffAttributeCluster:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0000, status=<Status.SUCCESS: 0>, value=TypeValue(type=Bool, value=<Bool.true: 1>))])
[2024-08-16 22:10:29][DEBUG] : 'aps_data_indication' response from <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x734b>, ep: 1, profile: 0x0104, cluster_id: 0x0006, data: b'1874010000001001'
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][INFO] : [a4:c1:38:d3:ee:1f:ac:87][listener.attribute_updated] Received an attribute update 0=Bool.true on cluster 6
[2024-08-16 22:10:29][INFO] : [DeviceHandler.post] Attribute Value received : ({0: <Bool.true: 1>}, {})
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][INFO] : 200 POST /device/attributes (127.0.0.1) 69.77ms
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.666564, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0})
[2024-08-16 22:10:29][INFO] : [DeviceHandler.prepare] Json arg : {'ieee': 'a4:c1:38:d3:ee:1f:ac:87', 'endpoint': 1, 'cluster': 1794, 'cluster_type': 'in', 'attributes': [0], 'allowCache': 0}
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True, *is_reply=False), tsn=118, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>, *is_reply=False)
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.666564, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0}) completed
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0702] Sending request: Read_Attributes(attribute_ids=[0])
[2024-08-16 22:10:29][DEBUG] : Sending Zigbee request with tsn 118 under 119 request id, data: b'0076000000'
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_request (20, 119, <DeconzSendDataFlags.NONE: 0>, <DeconzAddressEndpoint address_mode=2 address=0x734B endpoint=1>, 260, 1794, 1, b'\x00v\x00\x00\x00', <DeconzTransmitOptions.USE_NWK_KEY_SECURITY: 2>, 0)
[2024-08-16 22:10:29][DEBUG] : Send: 0x12ca001b0014007700024b73010401020701050000760000000200
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'INSERT INTO attributes_cache_v10 VALUES (?, ?, ?, ?, ?)\n ON CONFLICT (ieee, endpoint_id, cluster, attrid)\n DO UPDATE SET\n value=excluded.value WHERE value != excluded.value', (a4:c1:38:d3:ee:1f:ac:87, 1, 6, 0, <Bool.true: 1>))
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'INSERT INTO attributes_cache_v10 VALUES (?, ?, ?, ?, ?)\n ON CONFLICT (ieee, endpoint_id, cluster, attrid)\n DO UPDATE SET\n value=excluded.value WHERE value != excluded.value', (a4:c1:38:d3:ee:1f:ac:87, 1, 6, 0, <Bool.true: 1>)) completed
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x12ca00090002002277
[2024-08-16 22:10:29][DEBUG] : APS data request response: [2, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, 119]
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x0ecb000700a600
[2024-08-16 22:10:29][DEBUG] : Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_CONFIRM|2: 166>, 0]
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_confirm (0,)
[2024-08-16 22:10:29][DEBUG] : Send: 0x04cb0007000000
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x04cb0013000c002277024b7301010000000000
[2024-08-16 22:10:29][DEBUG] : APS data confirm response for request with id 119: 00
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x0ecc000700aa00
[2024-08-16 22:10:29][DEBUG] : Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_INDICATION|2: 170>, 0]
[2024-08-16 22:10:29][DEBUG] : Request id: 0x77 'aps_data_confirm' for <DeconzAddressEndpoint address_mode=ADDRESS_MODE.NWK address=0x734b endpoint=1>, status: 0x00
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_indication (1, 1)
[2024-08-16 22:10:29][DEBUG] : Send: 0x17cc000800010001
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.728519, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0})
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.728519, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0}) completed
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x17cc002b0024002202000001024b7301040102070d0018760100000025a8460000000000afffa7468200d2
[2024-08-16 22:10:29][DEBUG] : APS data indication response: [36, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x0000>, 1, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x734b>, 1, 260, 1794, b'\x18v\x01\x00\x00\x00%\xa8F\x00\x00\x00\x00', 0, 175, 255, 167, 70, 130, 0, -46]
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0702] Received ZCL frame: b'\x18v\x01\x00\x00\x00%\xa8F\x00\x00\x00\x00'
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True, *is_reply=True), tsn=118, command_id=1, *direction=<Direction.Client_to_Server: 1>, *is_reply=True)
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0702] Decoded ZCL frame: TuyaZBMeteringCluster:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0000, status=<Status.SUCCESS: 0>, value=TypeValue(type=uint48_t, value=18088))])
[2024-08-16 22:10:29][DEBUG] : 'aps_data_indication' response from <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x734b>, ep: 1, profile: 0x0104, cluster_id: 0x0702, data: b'18760100000025a84600000000'
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][INFO] : [a4:c1:38:d3:ee:1f:ac:87][listener.attribute_updated] Received an attribute update 0=18088 on cluster 1794
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][INFO] : [DeviceHandler.post] Attribute Value received : ({0: 18088}, {})
[2024-08-16 22:10:29][INFO] : 200 POST /device/attributes (127.0.0.1) 67.11ms
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.737222, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0})
[2024-08-16 22:10:29][INFO] : [DeviceHandler.prepare] Json arg : {'ieee': 'a4:c1:38:d3:ee:1f:ac:87', 'endpoint': 1, 'cluster': 2820, 'cluster_type': 'in', 'attributes': [1291], 'allowCache': 0}
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=False, direction=<Direction.Server_to_Client: 0>, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True, *is_reply=False), tsn=120, command_id=<GeneralCommand.Read_Attributes: 0>, *direction=<Direction.Server_to_Client: 0>, *is_reply=False)
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.737222, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0}) completed
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1291])
[2024-08-16 22:10:29][DEBUG] : Sending Zigbee request with tsn 120 under 121 request id, data: b'0078000b05'
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_request (20, 121, <DeconzSendDataFlags.NONE: 0>, <DeconzAddressEndpoint address_mode=2 address=0x734B endpoint=1>, 260, 2820, 1, b'\x00x\x00\x0b\x05', <DeconzTransmitOptions.USE_NWK_KEY_SECURITY: 2>, 0)
[2024-08-16 22:10:29][DEBUG] : Send: 0x12cd001b0014007900024b73010401040b0105000078000b050200
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'INSERT INTO attributes_cache_v10 VALUES (?, ?, ?, ?, ?)\n ON CONFLICT (ieee, endpoint_id, cluster, attrid)\n DO UPDATE SET\n value=excluded.value WHERE value != excluded.value', (a4:c1:38:d3:ee:1f:ac:87, 1, 1794, 0, 18088))
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'INSERT INTO attributes_cache_v10 VALUES (?, ?, ?, ?, ?)\n ON CONFLICT (ieee, endpoint_id, cluster, attrid)\n DO UPDATE SET\n value=excluded.value WHERE value != excluded.value', (a4:c1:38:d3:ee:1f:ac:87, 1, 1794, 0, 18088)) completed
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x12cd00090002002279
[2024-08-16 22:10:29][DEBUG] : APS data request response: [2, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, 121]
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x0ece000700a600
[2024-08-16 22:10:29][DEBUG] : Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_CONFIRM|2: 166>, 0]
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_confirm (0,)
[2024-08-16 22:10:29][DEBUG] : Send: 0x04ce0007000000
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x0ecf000700ae00
[2024-08-16 22:10:29][DEBUG] : Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_INDICATION|APSDE_DATA_CONFIRM|2: 174>, 0]
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x04ce0013000c002a79024b7301010000000000
[2024-08-16 22:10:29][DEBUG] : APS data confirm response for request with id 121: 00
[2024-08-16 22:10:29][DEBUG] : Request id: 0x79 'aps_data_confirm' for <DeconzAddressEndpoint address_mode=ADDRESS_MODE.NWK address=0x734b endpoint=1>, status: 0x00
[2024-08-16 22:10:29][DEBUG] : Command Command.aps_data_indication (1, 1)
[2024-08-16 22:10:29][DEBUG] : Send: 0x17cf000800010001
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.801935, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0})
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.801935, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0}) completed
[2024-08-16 22:10:29][DEBUG] : Frame received: 0x17cf00270020002202000001024b73010401040b09001878010b050029400000afffa7468200d2
[2024-08-16 22:10:29][DEBUG] : APS data indication response: [32, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x0000>, 1, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x734b>, 1, 260, 2820, b'\x18x\x01\x0b\x05\x00)@\x00', 0, 175, 255, 167, 70, 130, 0, -46]
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0b04] Received ZCL frame: b'\x18x\x01\x0b\x05\x00)@\x00'
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=<FrameType.GLOBAL_COMMAND: 0>, is_manufacturer_specific=0, direction=<Direction.Client_to_Server: 1>, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True, *is_reply=True), tsn=120, command_id=1, *direction=<Direction.Client_to_Server: 1>, *is_reply=True)
[2024-08-16 22:10:29][DEBUG] : [0x734B:1:0x0b04] Decoded ZCL frame: TuyaZBElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x050B, status=<Status.SUCCESS: 0>, value=TypeValue(type=int16s, value=64))])
[2024-08-16 22:10:29][DEBUG] : 'aps_data_indication' response from <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x734b>, ep: 1, profile: 0x0104, cluster_id: 0x0b04, data: b'1878010b0500294000'
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][INFO] : [a4:c1:38:d3:ee:1f:ac:87][listener.attribute_updated] Received an attribute update 1291=64 on cluster 2820
[2024-08-16 22:10:29][INFO] : [DeviceHandler.post] Attribute Value received : ({1291: 64}, {})
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][INFO] : 200 POST /device/attributes (127.0.0.1) 78.68ms
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.814013, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0})
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'UPDATE devices_v10\n SET last_seen=:ts\n WHERE ieee=:ieee AND :ts - last_seen > :min_last_seen_delta', {'ts': 1723839029.814013, 'ieee': a4:c1:38:d3:ee:1f:ac:87, 'min_last_seen_delta': 30.0}) completed
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'INSERT INTO attributes_cache_v10 VALUES (?, ?, ?, ?, ?)\n ON CONFLICT (ieee, endpoint_id, cluster, attrid)\n DO UPDATE SET\n value=excluded.value WHERE value != excluded.value', (a4:c1:38:d3:ee:1f:ac:87, 1, 2820, 1291, 64))
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method execute of sqlite3.Connection object at 0x737e0720>, 'INSERT INTO attributes_cache_v10 VALUES (?, ?, ?, ?, ?)\n ON CONFLICT (ieee, endpoint_id, cluster, attrid)\n DO UPDATE SET\n value=excluded.value WHERE value != excluded.value', (a4:c1:38:d3:ee:1f:ac:87, 1, 2820, 1291, 64)) completed
[2024-08-16 22:10:29][DEBUG] : executing functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>)
[2024-08-16 22:10:29][DEBUG] : operation functools.partial(<built-in method commit of sqlite3.Connection object at 0x737e0720>) completed
[2024-08-16 22:10:29][INFO] : Send to jeedom : {'devices': {'a4:c1:38:d3:ee:1f:ac:87': {'1': {'6': {'0': {'value': 'Bool.true', 'cluster_name': 'On/Off'}}, '1794': {'0': {'value': '18088', 'cluster_name': 'TuyaZBMeteringCluster'}}, '2820': {'1291': {'value': '64', 'cluster_name': 'Electrical Measurement'}}}}}}
[2024-08-16 22:10:29][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80
[2024-08-16 22:10:29][DEBUG] : http://127.0.0.1:80 "POST /plugins/zigbee/core/php/jeeZigbee.php?apikey=iceJbFb3phTFVPl1awx6Fjtjil6Z1X4i HTTP/1.1" 301 316
[2024-08-16 22:10:29][DEBUG] : Starting new HTTPS connection (1): jeedom.monreseau.ici:443
/usr/local/lib/python3.7/dist-packages/urllib3/connectionpool.py:1107: InsecureRequestWarning: Unverified HTTPS request is being made to host 'jeedom.monreseau.ici'. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#tls-warnings
InsecureRequestWarning,
[2024-08-16 22:10:30][DEBUG] : https://jeedom.monreseau.ici:443 "GET /plugins/zigbee/core/php/jeeZigbee.php?apikey=iceJbFb3phTFVPl1awx6Fjtjil6Z1X4i HTTP/1.1" 200 0
On voit bien la connexion à mon jeedom à la fin mais je n’ai pas de retour si cela a été enregistré ou non (mais c’ets peut-etre normal, je ne connais pas le fonctionnement exact du plugin)
Côté event, en mode debug, je n’ai que des [INFO] :
...
[2024-08-16 22:38:04][INFO] : Evènement sur la commande [Exterieur - Local Technique][Compteur 0 - Electricité][Consommation total] valeur : 3588959Wh
[2024-08-16 22:39:21][INFO] : Exécution de la commande [Exterieur - Abris][Prise Machine Biere][Rafraichir] avec les paramètres {"user_login":"XXXXXXXXXXX","user_id":"2"}
J’ai passé les log apache en debug mais je n’ai rien de particulier dans access.log
Pour error.log: j’ai des logs lors du lancement de la commande de rafraichissement mais rien ne me semble problématique en soit
J’ai peut-être oublié des infos qui vous seraient, n’hésitez pas à me le dire
Au delà de résoudre mon problème, afin d’avancer mes investigations, j’aurais besoin de savori comment se passe la remontée dans jeedom quand un plugin « envoie » les infos ? et est-ce tracable quelques part en mode debug ?
Merci d’avance