value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 2820, 1291, 8)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921720.11065, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921720.11065, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : Frame received: 80000009b800ba053001ba040100 [2022-06-22 18:15:21][DEBUG] : data received 0x8000 b'00ba053001ba0401' LQI:0 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 186, 1328, b'\x01\xba\x04\x01'] [2022-06-22 18:15:21][DEBUG] : Frame received: 8012000a2b00010102c0cfba040000 [2022-06-22 18:15:21][DEBUG] : data received 0x8012 b'00010102c0cfba0400' LQI:0 [2022-06-22 18:15:21][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:15:21][DEBUG] : Frame received: 801100082b00c0cf010006ba00 [2022-06-22 18:15:21][DEBUG] : data received 0x8011 b'00c0cf010006ba' LQI:0 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 0xc0cf, 1, 6, 186] [2022-06-22 18:15:21][DEBUG] : ACK Data received 186 0 [2022-06-22 18:15:21][DEBUG] : Frame received: 80020016e30001040006010102c0cf020000182701000000100055 [2022-06-22 18:15:21][DEBUG] : data received 0x8002 b'0001040006010102c0cf0200001827010000001000' LQI:85 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 260, 6, 1, 1,
,
, b"\x18'\x01\x00\x00\x00\x10\x00"] [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0006] Received ZCL frame: b"\x18'\x01\x00\x00\x00\x10\x00" [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=39, command_id=1, *is_reply=True) [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0006] Decoded ZCL frame: TuyaZBOnOffAttributeCluster:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0000, status=, value=TypeValue(type=Bool, value=))]) [2022-06-22 18:15:21][INFO] : [a4:c1:38:4e:c8:44:d6:1e][listener.attribute_updated] Received an attribute update 0=Bool.false on cluster 6 [2022-06-22 18:15:21][INFO] : [DeviceHandler.post] Attribute Value received : ({0: }, {}) [2022-06-22 18:15:21][INFO] : 200 POST /device/attributes (127.0.0.1) 106.61ms [2022-06-22 18:15:21][INFO] : Send to jeedom : {'devices': {'a4:c1:38:4e:c8:44:d6:1e': {'1': {'6': {'0': {'value': 'Bool.false', 'cluster_name': 'On/Off'}}}}}} [2022-06-22 18:15:21][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80 [2022-06-22 18:15:21][INFO] : [DeviceHandler.prepare] Json arg : {'ieee': 'a4:c1:38:4e:c8:44:d6:1e', 'endpoint': 1, 'cluster': 1794, 'cluster_type': 'in', 'attributes': [0], 'allowCache': 0} [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0702] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=40, command_id=, *is_reply=False) [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0702] Sending request: Read_Attributes(attribute_ids=[0]) [2022-06-22 18:15:21][DEBUG] : request (0xC0CF, 260, 1794, 1, 1, 40, b'\x00(\x00\x00\x00', True, False) [2022-06-22 18:15:21][DEBUG] : Send: 0x0530 b'02c0cf0101070201040000050028000000' [2022-06-22 18:15:21][DEBUG] : Frame to send: b'\x050\x00\x11\x04\x02\xc0\xcf\x01\x01\x07\x02\x01\x04\x00\x00\x05\x00(\x00\x00\x00' [2022-06-22 18:15:21][DEBUG] : Frame escaped: b'\x02\x150\x02\x10\x11\x02\x14\x02\x12\xc0\xcf\x02\x11\x02\x11\x02\x17\x02\x12\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10(\x02\x10\x02\x10\x02\x10' [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921720.126715, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921720.126715, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : http://127.0.0.1:80 "POST /plugins/zigbee/core/php/jeeZigbee.php?apikey=xAZJBeeVGyQ03Zpv1YxVD1OsbPvDn1udXnXGyrteM08NL1qPjl4qBLi3G5F4Xd7J HTTP/1.1" 200 0 [2022-06-22 18:15:21][DEBUG] : Frame received: 80000009b800bb053001bb040100 [2022-06-22 18:15:21][DEBUG] : data received 0x8000 b'00bb053001bb0401' LQI:0 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 187, 1328, b'\x01\xbb\x04\x01'] [2022-06-22 18:15:21][DEBUG] : Frame received: 8012000a2a00010102c0cfbb040000 [2022-06-22 18:15:21][DEBUG] : data received 0x8012 b'00010102c0cfbb0400' LQI:0 [2022-06-22 18:15:21][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:15:21][DEBUG] : Frame received: 801100082900c0cf010702bb00 [2022-06-22 18:15:21][DEBUG] : data received 0x8011 b'00c0cf010702bb' LQI:0 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 0xc0cf, 1, 1794, 187] [2022-06-22 18:15:21][DEBUG] : ACK Data received 187 0 [2022-06-22 18:15:21][DEBUG] : Frame received: 8002001bc70001040702010102c0cf0200001828010000002512010000000056 [2022-06-22 18:15:21][DEBUG] : data received 0x8002 b'0001040702010102c0cf02000018280100000025120100000000' LQI:86 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 260, 1794, 1, 1,
,
, b'\x18(\x01\x00\x00\x00%\x12\x01\x00\x00\x00\x00'] [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0702] Received ZCL frame: b'\x18(\x01\x00\x00\x00%\x12\x01\x00\x00\x00\x00' [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=40, command_id=1, *is_reply=True) [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0702] Decoded ZCL frame: TuyaZBMeteringCluster:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x0000, status=, value=TypeValue(type=uint48_t, value=274))]) [2022-06-22 18:15:21][INFO] : [a4:c1:38:4e:c8:44:d6:1e][listener.attribute_updated] Received an attribute update 0=274 on cluster 1794 [2022-06-22 18:15:21][INFO] : [DeviceHandler.post] Attribute Value received : ({0: 274}, {}) [2022-06-22 18:15:21][INFO] : 200 POST /device/attributes (127.0.0.1) 75.57ms [2022-06-22 18:15:21][INFO] : [DeviceHandler.prepare] Json arg : {'ieee': 'a4:c1:38:4e:c8:44:d6:1e', 'endpoint': 1, 'cluster': 2820, 'cluster_type': 'in', 'attributes': [1291], 'allowCache': 0} [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0b04] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=41, command_id=, *is_reply=False) [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0b04] Sending request: Read_Attributes(attribute_ids=[1291]) [2022-06-22 18:15:21][DEBUG] : request (0xC0CF, 260, 2820, 1, 1, 41, b'\x00)\x00\x0b\x05', True, False) [2022-06-22 18:15:21][DEBUG] : Send: 0x0530 b'02c0cf01010b0401040000050029000b05' [2022-06-22 18:15:21][DEBUG] : Frame to send: b'\x050\x00\x11\x01\x02\xc0\xcf\x01\x01\x0b\x04\x01\x04\x00\x00\x05\x00)\x00\x0b\x05' [2022-06-22 18:15:21][DEBUG] : Frame escaped: b'\x02\x150\x02\x10\x11\x02\x11\x02\x12\xc0\xcf\x02\x11\x02\x11\x02\x1b\x02\x14\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x02\x10)\x02\x10\x02\x1b\x02\x15' [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921720.130438, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921720.130438, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : Frame received: 80000009b800bc053001bc040100 [2022-06-22 18:15:21][DEBUG] : data received 0x8000 b'00bc053001bc0401' LQI:0 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 188, 1328, b'\x01\xbc\x04\x01'] [2022-06-22 18:15:21][DEBUG] : Frame received: 8012000a2d00010102c0cfbc040000 [2022-06-22 18:15:21][DEBUG] : data received 0x8012 b'00010102c0cfbc0400' LQI:0 [2022-06-22 18:15:21][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:15:21][DEBUG] : Frame received: 801100082400c0cf010b04bc00 [2022-06-22 18:15:21][DEBUG] : data received 0x8011 b'00c0cf010b04bc' LQI:0 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 0xc0cf, 1, 2820, 188] [2022-06-22 18:15:21][DEBUG] : ACK Data received 188 0 [2022-06-22 18:15:21][INFO] : Send to jeedom : {'devices': {'a4:c1:38:4e:c8:44:d6:1e': {'1': {'1794': {'0': {'value': '274', 'cluster_name': 'TuyaZBMeteringCluster'}}}}}} [2022-06-22 18:15:21][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80 [2022-06-22 18:15:21][DEBUG] : Frame received: 80020017d90001040b04010102c0cf0200001829010b050029080056 [2022-06-22 18:15:21][DEBUG] : data received 0x8002 b'0001040b04010102c0cf0200001829010b0500290800' LQI:86 [2022-06-22 18:15:21][DEBUG] : zigate_callback_handler [0, 260, 2820, 1, 1,
,
, b'\x18)\x01\x0b\x05\x00)\x08\x00'] [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0b04] Received ZCL frame: b'\x18)\x01\x0b\x05\x00)\x08\x00' [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=41, command_id=1, *is_reply=True) [2022-06-22 18:15:21][DEBUG] : [0xC0CF:1:0x0b04] Decoded ZCL frame: TuyaZBElectricalMeasurement:Read_Attributes_rsp(status_records=[ReadAttributeRecord(attrid=0x050B, status=, value=TypeValue(type=int16s, value=8))]) [2022-06-22 18:15:21][INFO] : [a4:c1:38:4e:c8:44:d6:1e][listener.attribute_updated] Received an attribute update 1291=8 on cluster 2820 [2022-06-22 18:15:21][INFO] : [DeviceHandler.post] Attribute Value received : ({1291: 8}, {}) [2022-06-22 18:15:21][INFO] : 200 POST /device/attributes (127.0.0.1) 81.31ms [2022-06-22 18:15:21][DEBUG] : http://127.0.0.1:80 "POST /plugins/zigbee/core/php/jeeZigbee.php?apikey=xAZJBeeVGyQ03Zpv1YxVD1OsbPvDn1udXnXGyrteM08NL1qPjl4qBLi3G5F4Xd7J HTTP/1.1" 200 0 [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 6, 0, )) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 6, 0, )) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][INFO] : Send to jeedom : {'devices': {'a4:c1:38:4e:c8:44:d6:1e': {'1': {'2820': {'1291': {'value': '8', 'cluster_name': 'Electrical Measurement'}}}}}} [2022-06-22 18:15:21][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80 [2022-06-22 18:15:21][DEBUG] : http://127.0.0.1:80 "POST /plugins/zigbee/core/php/jeeZigbee.php?apikey=xAZJBeeVGyQ03Zpv1YxVD1OsbPvDn1udXnXGyrteM08NL1qPjl4qBLi3G5F4Xd7J HTTP/1.1" 200 0 [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921720.136985, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921720.136985, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 6, 0, )) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 6, 0, )) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.199742, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.199742, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.247403, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.247403, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 6, 0, )) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 6, 0, )) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.311725, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.311725, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.343769, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.343769, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 1794, 0, 274)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 1794, 0, 274)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.39182, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.39182, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.423832, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921721.423832, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 2820, 1291, 8)) [2022-06-22 18:15:21][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 2820, 1291, 8)) completed [2022-06-22 18:15:21][DEBUG] : executing functools.partial() [2022-06-22 18:15:21][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:23][DEBUG] : Frame received: 800200167e0001040b04010102c0cf02000018890a0b0529000053 [2022-06-22 18:15:23][DEBUG] : data received 0x8002 b'0001040b04010102c0cf02000018890a0b05290000' LQI:83 [2022-06-22 18:15:23][DEBUG] : zigate_callback_handler [0, 260, 2820, 1, 1,
,
, b'\x18\x89 \x0b\x05)\x00\x00'] [2022-06-22 18:15:23][DEBUG] : [0xC0CF:1:0x0b04] Received ZCL frame: b'\x18\x89 \x0b\x05)\x00\x00' [2022-06-22 18:15:23][DEBUG] : [0xC0CF:1:0x0b04] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=137, command_id=10, *is_reply=True) [2022-06-22 18:15:23][DEBUG] : [0xC0CF:1:0x0b04] Decoded ZCL frame: TuyaZBElectricalMeasurement:Report_Attributes(attribute_reports=[Attribute(attrid=0x050B, value=TypeValue(type=int16s, value=0))]) [2022-06-22 18:15:23][DEBUG] : [0xC0CF:1:0x0b04] Received command 0x0A (TSN 137): Report_Attributes(attribute_reports=[Attribute(attrid=0x050B, value=TypeValue(type=int16s, value=0))]) [2022-06-22 18:15:23][INFO] : [a4:c1:38:4e:c8:44:d6:1e][listener.general_command] Cluster: cluster_id: 0x0b04 command_id: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=False, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=137, command_id=10, *is_reply=False) args: (Report_Attributes(attribute_reports=[Attribute(attrid=0x050B, value=TypeValue(type=int16s, value=0))]),) [2022-06-22 18:15:23][DEBUG] : [0xC0CF:1:0x0b04] Attribute report received: active_power=0 [2022-06-22 18:15:23][INFO] : [a4:c1:38:4e:c8:44:d6:1e][listener.attribute_updated] Received an attribute update 1291=0 on cluster 2820 [2022-06-22 18:15:23][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921723.151734, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:15:23][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921723.151734, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:15:23][DEBUG] : executing functools.partial() [2022-06-22 18:15:23][INFO] : Send to jeedom : {'devices': {'a4:c1:38:4e:c8:44:d6:1e': {'1': {'2820': {'1291': {'value': '0', 'cluster_name': 'Electrical Measurement'}}}}}} [2022-06-22 18:15:23][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80 [2022-06-22 18:15:23][DEBUG] : http://127.0.0.1:80 "POST /plugins/zigbee/core/php/jeeZigbee.php?apikey=xAZJBeeVGyQ03Zpv1YxVD1OsbPvDn1udXnXGyrteM08NL1qPjl4qBLi3G5F4Xd7J HTTP/1.1" 200 0 [2022-06-22 18:15:23][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:23][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 2820, 1291, 0)) [2022-06-22 18:15:23][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 2820, 1291, 0)) completed [2022-06-22 18:15:23][DEBUG] : executing functools.partial() [2022-06-22 18:15:23][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:24][DEBUG] : Frame received: 8701000597d000418500 [2022-06-22 18:15:24][DEBUG] : data received 0x8701 b'd0004185' LQI:0 [2022-06-22 18:15:24][DEBUG] : zigate_callback_handler [208, 0] [2022-06-22 18:15:35][DEBUG] : Frame received: 80080005312a4618c800 [2022-06-22 18:15:35][DEBUG] : data received 0x8008 b'2a4618c8' LQI:0 [2022-06-22 18:15:35][ERROR] : Received unhandled response 0x8008 [2022-06-22 18:15:40][INFO] : [DeviceHandler.prepare] Json arg : None [2022-06-22 18:15:40][INFO] : [70:b3:d5:2b:60:00:80:65][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:40][INFO] : [cc:86:ec:ff:fe:bd:38:15][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:40][INFO] : [00:15:8d:00:06:a3:ff:c1][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:40][INFO] : [84:2e:14:ff:fe:90:14:3d][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:40][INFO] : [a4:c1:38:50:d3:31:70:7b][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:40][INFO] : [cc:86:ec:ff:fe:bd:39:97][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:40][INFO] : [a4:c1:38:95:3c:74:e6:a7][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:40][INFO] : [cc:86:ec:ff:fe:d1:0c:7a][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:40][DEBUG] : [0x7029:2:0x0000] Sending request header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, is_reply=0, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=42, command_id=, *is_reply=False) [2022-06-22 18:15:40][DEBUG] : [0x7029:2:0x0000] Sending request: Read_Attributes(attribute_ids=[4, 5]) [2022-06-22 18:15:40][DEBUG] : [0x7029] Extending timeout for 0x2a request [2022-06-22 18:15:40][DEBUG] : request (0x7029, 260, 0, 1, 2, 42, b'\x00*\x00\x04\x00\x05\x00', True, False) [2022-06-22 18:15:40][DEBUG] : Send: 0x0530 b'027029010200000104000007002a0004000500' [2022-06-22 18:15:40][DEBUG] : Frame to send: b'\x050\x00\x13W\x02p)\x01\x02\x00\x00\x01\x04\x00\x00\x07\x00*\x00\x04\x00\x05\x00' [2022-06-22 18:15:40][DEBUG] : Frame escaped: b'\x02\x150\x02\x10\x13W\x02\x12p)\x02\x11\x02\x12\x02\x10\x02\x10\x02\x11\x02\x14\x02\x10\x02\x10\x02\x17\x02\x10*\x02\x10\x02\x14\x02\x10\x02\x15\x02\x10' [2022-06-22 18:15:40][DEBUG] : Frame received: 80000009bc00bd053001bd000100 [2022-06-22 18:15:40][DEBUG] : data received 0x8000 b'00bd053001bd0001' LQI:0 [2022-06-22 18:15:40][DEBUG] : zigate_callback_handler [0, 189, 1328, b'\x01\xbd\x00\x01'] [2022-06-22 18:15:40][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921740.1112, cc:86:ec:ff:fe:d1:0c:7a)) [2022-06-22 18:15:40][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921740.1112, cc:86:ec:ff:fe:d1:0c:7a)) completed [2022-06-22 18:15:40][DEBUG] : executing functools.partial() [2022-06-22 18:15:40][DEBUG] : Frame received: 8012000a7d000102027029bd000000 [2022-06-22 18:15:40][DEBUG] : data received 0x8012 b'000102027029bd0000' LQI:0 [2022-06-22 18:15:40][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:15:41][DEBUG] : operation functools.partial() completed [2022-06-22 18:15:42][INFO] : [a4:c1:38:4e:c8:44:d6:1e][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:42][INFO] : [a4:c1:38:f1:d6:f8:62:6b][zdevices.serialize] Serialize device with attributes : 1 [2022-06-22 18:15:42][INFO] : 200 GET /device/all (127.0.0.1) 2025.74ms [2022-06-22 18:15:46][DEBUG] : Frame received: 80110008dba77029010000bd00 [2022-06-22 18:15:46][DEBUG] : data received 0x8011 b'a77029010000bd' LQI:0 [2022-06-22 18:15:46][DEBUG] : zigate_callback_handler [167, 0x7029, 1, 0, 189] [2022-06-22 18:15:46][DEBUG] : ACK Data received 189 167 [2022-06-22 18:16:01][DEBUG] : Frame received: 8002001a720001040702010102c0cf020000088a0a0000251201000000005b [2022-06-22 18:16:01][DEBUG] : data received 0x8002 b'0001040702010102c0cf020000088a0a000025120100000000' LQI:91 [2022-06-22 18:16:01][DEBUG] : zigate_callback_handler [0, 260, 1794, 1, 1,
,
, b'\x08\x8a \x00\x00%\x12\x01\x00\x00\x00\x00'] [2022-06-22 18:16:01][DEBUG] : [0xC0CF:1:0x0702] Received ZCL frame: b'\x08\x8a \x00\x00%\x12\x01\x00\x00\x00\x00' [2022-06-22 18:16:01][DEBUG] : [0xC0CF:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=1, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=138, command_id=10, *is_reply=True) [2022-06-22 18:16:01][DEBUG] : [0xC0CF:1:0x0702] Decoded ZCL frame: TuyaZBMeteringCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint48_t, value=274))]) [2022-06-22 18:16:01][DEBUG] : [0xC0CF:1:0x0702] Received command 0x0A (TSN 138): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint48_t, value=274))]) [2022-06-22 18:16:01][INFO] : [a4:c1:38:4e:c8:44:d6:1e][listener.general_command] Cluster: cluster_id: 0x0702 command_id: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=False, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=138, command_id=10, *is_reply=False) args: (Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint48_t, value=274))]),) [2022-06-22 18:16:01][DEBUG] : [0xC0CF:1:0x0702] Attribute report received: current_summ_delivered=274 [2022-06-22 18:16:01][INFO] : [a4:c1:38:4e:c8:44:d6:1e][listener.attribute_updated] Received an attribute update 0=274 on cluster 1794 [2022-06-22 18:16:01][DEBUG] : [0xC0CF:1:0x0702] Sending reply header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=138, command_id=, *is_reply=True) [2022-06-22 18:16:01][DEBUG] : [0xC0CF:1:0x0702] Sending reply: Default_Response(command_id=10, status=) [2022-06-22 18:16:01][DEBUG] : request (0xC0CF, 260, 1794, 1, 1, 138, b'\x18\x8a\x0b \x00', False, False) [2022-06-22 18:16:01][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921761.567814, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:16:01][DEBUG] : Send: 0x0530 b'02c0cf010107020104000005188a0b0a00' [2022-06-22 18:16:01][DEBUG] : Frame to send: b'\x050\x00\x11\xbf\x02\xc0\xcf\x01\x01\x07\x02\x01\x04\x00\x00\x05\x18\x8a\x0b \x00' [2022-06-22 18:16:01][DEBUG] : Frame escaped: b'\x02\x150\x02\x10\x11\xbf\x02\x12\xc0\xcf\x02\x11\x02\x11\x02\x17\x02\x12\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x18\x8a\x02\x1b\x02\x1a\x02\x10' [2022-06-22 18:16:01][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921761.567814, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:16:01][DEBUG] : executing functools.partial() [2022-06-22 18:16:01][DEBUG] : Frame received: 8012000a2b00010102c0cfbe000000 [2022-06-22 18:16:01][DEBUG] : data received 0x8012 b'00010102c0cfbe0000' LQI:0 [2022-06-22 18:16:01][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:16:01][DEBUG] : Frame received: 801100082c00c0cf010702be00 [2022-06-22 18:16:01][DEBUG] : data received 0x8011 b'00c0cf010702be' LQI:0 [2022-06-22 18:16:01][DEBUG] : zigate_callback_handler [0, 0xc0cf, 1, 1794, 190] [2022-06-22 18:16:01][DEBUG] : ACK Data received 190 0 [2022-06-22 18:16:01][DEBUG] : Frame received: 8012000a2a00010102c0cfbf000000 [2022-06-22 18:16:01][DEBUG] : data received 0x8012 b'00010102c0cfbf0000' LQI:0 [2022-06-22 18:16:01][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:16:01][DEBUG] : Frame received: 80000009bf00c0053001c0000200 [2022-06-22 18:16:01][DEBUG] : data received 0x8000 b'00c0053001c00002' LQI:0 [2022-06-22 18:16:01][DEBUG] : zigate_callback_handler [0, 192, 1328, b'\x01\xc0\x00\x02'] [2022-06-22 18:16:01][DEBUG] : Frame received: 801100082d00c0cf010702bf00 [2022-06-22 18:16:01][DEBUG] : data received 0x8011 b'00c0cf010702bf' LQI:0 [2022-06-22 18:16:01][DEBUG] : zigate_callback_handler [0, 0xc0cf, 1, 1794, 191] [2022-06-22 18:16:01][DEBUG] : ACK Data received 191 0 [2022-06-22 18:16:01][DEBUG] : Frame received: 8012000a5500010102c0cfc0000000 [2022-06-22 18:16:01][DEBUG] : data received 0x8012 b'00010102c0cfc00000' LQI:0 [2022-06-22 18:16:01][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:16:01][DEBUG] : Frame received: 801100085200c0cf010702c000 [2022-06-22 18:16:01][DEBUG] : data received 0x8011 b'00c0cf010702c0' LQI:0 [2022-06-22 18:16:01][DEBUG] : zigate_callback_handler [0, 0xc0cf, 1, 1794, 192] [2022-06-22 18:16:01][DEBUG] : ACK Data received 192 0 [2022-06-22 18:16:01][INFO] : Send to jeedom : {'devices': {'a4:c1:38:4e:c8:44:d6:1e': {'1': {'1794': {'0': {'value': '274', 'cluster_name': 'TuyaZBMeteringCluster'}}}}}} [2022-06-22 18:16:01][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80 [2022-06-22 18:16:01][DEBUG] : http://127.0.0.1:80 "POST /plugins/zigbee/core/php/jeeZigbee.php?apikey=xAZJBeeVGyQ03Zpv1YxVD1OsbPvDn1udXnXGyrteM08NL1qPjl4qBLi3G5F4Xd7J HTTP/1.1" 200 0 [2022-06-22 18:16:01][DEBUG] : operation functools.partial() completed [2022-06-22 18:16:01][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 1794, 0, 274)) [2022-06-22 18:16:01][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:4e:c8:44:d6:1e, 1, 1794, 0, 274)) completed [2022-06-22 18:16:01][DEBUG] : executing functools.partial() [2022-06-22 18:16:01][DEBUG] : operation functools.partial() completed [2022-06-22 18:16:01][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921761.61114, a4:c1:38:4e:c8:44:d6:1e)) [2022-06-22 18:16:01][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921761.61114, a4:c1:38:4e:c8:44:d6:1e)) completed [2022-06-22 18:16:01][DEBUG] : executing functools.partial() [2022-06-22 18:16:01][DEBUG] : operation functools.partial() completed [2022-06-22 18:16:34][DEBUG] : Frame received: 80080005fc2a46190400 [2022-06-22 18:16:34][DEBUG] : data received 0x8008 b'2a461904' LQI:0 [2022-06-22 18:16:34][ERROR] : Received unhandled response 0x8008 [2022-06-22 18:16:35][DEBUG] : Frame received: 8002001ad5000104070201010265ec02000008950a00002536010000000041 [2022-06-22 18:16:35][DEBUG] : data received 0x8002 b'000104070201010265ec02000008950a000025360100000000' LQI:65 [2022-06-22 18:16:35][DEBUG] : zigate_callback_handler [0, 260, 1794, 1, 1,
,
, b'\x08\x95 \x00\x00%6\x01\x00\x00\x00\x00'] [2022-06-22 18:16:35][DEBUG] : [0x65EC:1:0x0702] Received ZCL frame: b'\x08\x95 \x00\x00%6\x01\x00\x00\x00\x00' [2022-06-22 18:16:35][DEBUG] : [0x65EC:1:0x0702] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=1, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=149, command_id=10, *is_reply=True) [2022-06-22 18:16:35][DEBUG] : [0x65EC:1:0x0702] Decoded ZCL frame: TuyaZBMeteringCluster:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint48_t, value=310))]) [2022-06-22 18:16:35][DEBUG] : [0x65EC:1:0x0702] Received command 0x0A (TSN 149): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint48_t, value=310))]) [2022-06-22 18:16:35][INFO] : [a4:c1:38:95:3c:74:e6:a7][listener.general_command] Cluster: cluster_id: 0x0702 command_id: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=False, disable_default_response=0, reserved=0, *is_cluster=False, *is_general=True), tsn=149, command_id=10, *is_reply=False) args: (Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=uint48_t, value=310))]),) [2022-06-22 18:16:35][DEBUG] : [0x65EC:1:0x0702] Attribute report received: current_summ_delivered=310 [2022-06-22 18:16:35][INFO] : [a4:c1:38:95:3c:74:e6:a7][listener.attribute_updated] Received an attribute update 0=310 on cluster 1794 [2022-06-22 18:16:35][DEBUG] : [0x65EC:1:0x0702] Sending reply header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=False, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=149, command_id=, *is_reply=True) [2022-06-22 18:16:35][DEBUG] : [0x65EC:1:0x0702] Sending reply: Default_Response(command_id=10, status=) [2022-06-22 18:16:35][DEBUG] : request (0x65EC, 260, 1794, 1, 1, 149, b'\x18\x95\x0b \x00', False, False) [2022-06-22 18:16:35][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921795.676073, a4:c1:38:95:3c:74:e6:a7)) [2022-06-22 18:16:35][DEBUG] : Send: 0x0530 b'0265ec01010702010400000518950b0a00' [2022-06-22 18:16:35][DEBUG] : Frame to send: b'\x050\x00\x11&\x02e\xec\x01\x01\x07\x02\x01\x04\x00\x00\x05\x18\x95\x0b \x00' [2022-06-22 18:16:35][DEBUG] : Frame escaped: b'\x02\x150\x02\x10\x11&\x02\x12e\xec\x02\x11\x02\x11\x02\x17\x02\x12\x02\x11\x02\x14\x02\x10\x02\x10\x02\x15\x18\x95\x02\x1b\x02\x1a\x02\x10' [2022-06-22 18:16:35][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921795.676073, a4:c1:38:95:3c:74:e6:a7)) completed [2022-06-22 18:16:35][DEBUG] : Frame received: 8012000ad20001010265ecc1000000 [2022-06-22 18:16:35][DEBUG] : data received 0x8012 b'0001010265ecc10000' LQI:0 [2022-06-22 18:16:35][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:16:35][DEBUG] : executing functools.partial() [2022-06-22 18:16:35][DEBUG] : Frame received: 80110008d50065ec010702c100 [2022-06-22 18:16:35][DEBUG] : data received 0x8011 b'0065ec010702c1' LQI:0 [2022-06-22 18:16:35][DEBUG] : zigate_callback_handler [0, 0x65ec, 1, 1794, 193] [2022-06-22 18:16:35][DEBUG] : ACK Data received 193 0 [2022-06-22 18:16:35][DEBUG] : Frame received: 8012000ad10001010265ecc2000000 [2022-06-22 18:16:35][DEBUG] : data received 0x8012 b'0001010265ecc20000' LQI:0 [2022-06-22 18:16:35][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:16:35][DEBUG] : Frame received: 80110008d60065ec010702c200 [2022-06-22 18:16:35][DEBUG] : data received 0x8011 b'0065ec010702c2' LQI:0 [2022-06-22 18:16:35][DEBUG] : zigate_callback_handler [0, 0x65ec, 1, 1794, 194] [2022-06-22 18:16:35][DEBUG] : ACK Data received 194 0 [2022-06-22 18:16:35][DEBUG] : Frame received: 80000009bc00c3053001c3000100 [2022-06-22 18:16:35][DEBUG] : data received 0x8000 b'00c3053001c30001' LQI:0 [2022-06-22 18:16:35][DEBUG] : zigate_callback_handler [0, 195, 1328, b'\x01\xc3\x00\x01'] [2022-06-22 18:16:35][DEBUG] : Frame received: 8012000ad00001010265ecc3000000 [2022-06-22 18:16:35][DEBUG] : data received 0x8012 b'0001010265ecc30000' LQI:0 [2022-06-22 18:16:35][ERROR] : Received unhandled response 0x8012 [2022-06-22 18:16:35][DEBUG] : Frame received: 80110008d70065ec010702c300 [2022-06-22 18:16:35][DEBUG] : data received 0x8011 b'0065ec010702c3' LQI:0 [2022-06-22 18:16:35][DEBUG] : zigate_callback_handler [0, 0x65ec, 1, 1794, 195] [2022-06-22 18:16:35][DEBUG] : ACK Data received 195 0 [2022-06-22 18:16:35][DEBUG] : operation functools.partial() completed [2022-06-22 18:16:35][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:95:3c:74:e6:a7, 1, 1794, 0, 310)) [2022-06-22 18:16:35][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (a4:c1:38:95:3c:74:e6:a7, 1, 1794, 0, 310)) completed [2022-06-22 18:16:35][DEBUG] : executing functools.partial() [2022-06-22 18:16:35][DEBUG] : operation functools.partial() completed [2022-06-22 18:16:35][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921795.720173, a4:c1:38:95:3c:74:e6:a7)) [2022-06-22 18:16:35][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921795.720173, a4:c1:38:95:3c:74:e6:a7)) completed [2022-06-22 18:16:35][DEBUG] : executing functools.partial() [2022-06-22 18:16:35][DEBUG] : operation functools.partial() completed [2022-06-22 18:16:35][INFO] : Send to jeedom : {'devices': {'a4:c1:38:95:3c:74:e6:a7': {'1': {'1794': {'0': {'value': '310', 'cluster_name': 'TuyaZBMeteringCluster'}}}}}} [2022-06-22 18:16:35][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80 [2022-06-22 18:16:35][DEBUG] : http://127.0.0.1:80 "POST /plugins/zigbee/core/php/jeeZigbee.php?apikey=xAZJBeeVGyQ03Zpv1YxVD1OsbPvDn1udXnXGyrteM08NL1qPjl4qBLi3G5F4Xd7J HTTP/1.1" 200 0 [2022-06-22 18:17:23][DEBUG] : Frame received: 800200156b0001040006010102fdd7020000189a0a000010004d [2022-06-22 18:17:23][DEBUG] : data received 0x8002 b'0001040006010102fdd7020000189a0a00001000' LQI:77 [2022-06-22 18:17:23][DEBUG] : zigate_callback_handler [0, 260, 6, 1, 1,
,
, b'\x18\x9a \x00\x00\x10\x00'] [2022-06-22 18:17:23][DEBUG] : [0xFDD7:1:0x0006] Received ZCL frame: b'\x18\x9a \x00\x00\x10\x00' [2022-06-22 18:17:23][DEBUG] : [0xFDD7:1:0x0006] Decoded ZCL frame header: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=1, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=154, command_id=10, *is_reply=True) [2022-06-22 18:17:23][DEBUG] : [0xFDD7:1:0x0006] Decoded ZCL frame: OnOff:Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=))]) [2022-06-22 18:17:23][DEBUG] : [0xFDD7:1:0x0006] Received command 0x0A (TSN 154): Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=))]) [2022-06-22 18:17:23][INFO] : [70:b3:d5:2b:60:00:80:65][listener.general_command] Cluster: cluster_id: 0x0006 command_id: ZCLHeader(frame_control=FrameControl(frame_type=, is_manufacturer_specific=0, is_reply=False, disable_default_response=1, reserved=0, *is_cluster=False, *is_general=True), tsn=154, command_id=10, *is_reply=False) args: (Report_Attributes(attribute_reports=[Attribute(attrid=0x0000, value=TypeValue(type=Bool, value=))]),) [2022-06-22 18:17:23][DEBUG] : [0xFDD7:1:0x0006] Attribute report received: on_off= [2022-06-22 18:17:23][INFO] : [70:b3:d5:2b:60:00:80:65][listener.attribute_updated] Received an attribute update 0=Bool.false on cluster 6 [2022-06-22 18:17:23][DEBUG] : executing functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921843.138631, 70:b3:d5:2b:60:00:80:65)) [2022-06-22 18:17:23][DEBUG] : operation functools.partial(, 'UPDATE devices_v9 SET last_seen=? WHERE ieee=?', (1655921843.138631, 70:b3:d5:2b:60:00:80:65)) completed [2022-06-22 18:17:23][DEBUG] : executing functools.partial() [2022-06-22 18:17:23][INFO] : Send to jeedom : {'devices': {'70:b3:d5:2b:60:00:80:65': {'1': {'6': {'0': {'value': 'Bool.false', 'cluster_name': 'On/Off'}}}}}} [2022-06-22 18:17:23][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80 [2022-06-22 18:17:23][DEBUG] : http://127.0.0.1:80 "POST /plugins/zigbee/core/php/jeeZigbee.php?apikey=xAZJBeeVGyQ03Zpv1YxVD1OsbPvDn1udXnXGyrteM08NL1qPjl4qBLi3G5F4Xd7J HTTP/1.1" 200 0 [2022-06-22 18:17:23][DEBUG] : operation functools.partial() completed [2022-06-22 18:17:23][DEBUG] : executing functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (70:b3:d5:2b:60:00:80:65, 1, 6, 0, )) [2022-06-22 18:17:23][DEBUG] : operation functools.partial(, 'INSERT INTO attributes_cache_v9 VALUES (?, ?, ?, ?, ?) ON CONFLICT (ieee, endpoint_id, cluster, attrid) DO UPDATE SET value=excluded.value', (70:b3:d5:2b:60:00:80:65, 1, 6, 0, )) completed [2022-06-22 18:17:23][DEBUG] : executing functools.partial() [2022-06-22 18:17:23][DEBUG] : operation functools.partial() completed [2022-06-22 18:17:34][DEBUG] : Frame received: 80080005b82a46194000 [2022-06-22 18:17:34][DEBUG] : data received 0x8008 b'2a461940' LQI:0 [2022-06-22 18:17:34][ERROR] : Received unhandled response 0x8008 Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom Error: importing module jeedom.jeedom