[0x0000:zdo] ZDO request ZDOCmd.Mgmt_Permit_Joining_req: [60, <Bool.false: 0>]
[0x7ec6] Delivery error for seq # 0x94, on endpoint id 0 cluster 0x0034: message send failure
Sending 'zdo_leave_req' failed: [0x7ec6:0:0x0034]: Message send failure
[0xDA3E](TRADFRI bulb GU10 W 400lm): Attempting to checkin with device - missed checkins: 2
[0xda3e] Delivery error for seq # 0x98, on endpoint id 1 cluster 0x0000: message send failure
Device 0x938c (04:cf:8c:df:3c:75:b4:17) joined the network
[0x938c:zdo] ZDO request ZDOCmd.Device_annce: [0x938C, 04:cf:8c:df:3c:75:b4:17, 132]
[0x938c] Requesting 'Node Descriptor'
Tries remaining: 2
[0x938c] Extending timeout for 0x9a request
[0x938c] Node Descriptor: NodeDescriptor(byte1=2, byte2=64, mac_capability_flags=132, manufacturer_code=4447, maximum_buffer_size=127, maximum_incoming_transfer_size=100, server_mask=11264, maximum_outgoing_transfer_size=100, descriptor_capability_field=0)
[0x938c] Discovering endpoints
Tries remaining: 3
[0x938c] Extending timeout for 0x9c request
[0x938c] Discovered endpoints: [1, 2, 3, 4, 5, 6]
[0x938c:1] Discovering endpoint information
Tries remaining: 3
[0x938c] Extending timeout for 0x9e request
[0x938c:1] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=1, profile=260, device_type=261, device_version=1, input_clusters=[0, 3, 1], output_clusters=[3, 6, 8, 768])
[0x938c] Extending timeout for 0xa0 request
[0x938c:1:0x0000] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=160 command_id=Command.Read_Attributes_rsp>
[0x938c:1] Manufacturer: LUMI
[0x938c:1] Model: lumi.remote.b686opcn01
[0x938c:2] Discovering endpoint information
Tries remaining: 3
[0x938c] Extending timeout for 0xa2 request
[0x938c:2] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=2, profile=260, device_type=259, device_version=1, input_clusters=[3], output_clusters=[6, 3])
[0x938c:3] Discovering endpoint information
Tries remaining: 3
[0x938c] Extending timeout for 0xa4 request
[0x938c:3] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=3, profile=260, device_type=259, device_version=1, input_clusters=[18, 3], output_clusters=[6])
[0x938c:4] Discovering endpoint information
Tries remaining: 3
[0x938c] Extending timeout for 0xa6 request
[0x938c:4] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=4, profile=260, device_type=259, device_version=1, input_clusters=[18, 3], output_clusters=[6])
[0x938c:5] Discovering endpoint information
Tries remaining: 3
[0x938c] Extending timeout for 0xa8 request
[0x938c:5] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=5, profile=260, device_type=259, device_version=1, input_clusters=[18, 3], output_clusters=[6])
[0x938c:6] Discovering endpoint information
Tries remaining: 3
[0x938c] Extending timeout for 0xaa request
[0x938c:6] Discovered endpoint information: SizePrefixedSimpleDescriptor(endpoint=6, profile=260, device_type=259, device_version=1, input_clusters=[18, 3], output_clusters=[6])
Checking quirks for LUMI lumi.remote.b686opcn01 (04:cf:8c:df:3c:75:b4:17)
Considering <class 'zhaquirks.xiaomi.aqara.opple_remote.RemoteB686OPCN01V5'>
Fail because input cluster mismatch on at least one endpoint
Considering <class 'zhaquirks.xiaomi.aqara.opple_remote.RemoteB686OPCN01V4'>
Fail because input cluster mismatch on at least one endpoint
Considering <class 'zhaquirks.xiaomi.aqara.opple_remote.RemoteB686OPCN01V3'>
Found custom device replacement for 04:cf:8c:df:3c:75:b4:17: <class 'zhaquirks.xiaomi.aqara.opple_remote.RemoteB686OPCN01V3'>
device - 0x938C:04:cf:8c:df:3c:75:b4:17 entering async_device_initialized - is_new_join: True
device - 0x938C:04:cf:8c:df:3c:75:b4:17 has joined the ZHA zigbee network
[0x938C](lumi.remote.b686opcn01): started configuration
[0x938C:ZDO](lumi.remote.b686opcn01): 'async_configure' stage succeeded
[0x938c] Extending timeout for 0xac request
[0x938c] Extending timeout for 0xae request
[0x938c] Extending timeout for 0xb0 request
[0x938C:1:0x0001]: bound 'power' cluster: Status.SUCCESS
[0x938c] Extending timeout for 0xb2 request
[0x938c] Extending timeout for 0xb4 request
[0x938C:1:0x0000]: bound 'basic' cluster: Status.SUCCESS
[0x938C:1:0x0000]: finished channel configuration
[0x938c] Extending timeout for 0xb6 request
[0x938c:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=178 command_id=Command.Configure_Reporting_rsp>
[0x938C:1:0x0001]: reporting 'battery_voltage' attr on 'power' cluster: 3600/10800/1: Result: '[[ConfigureReportingResponseRecord(status=0)]]'
[0x938c] Extending timeout for 0xb8 request
[0x938c:1:0xfcc0] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=True is_reply=True disable_default_response=True> manufacturer=4447 tsn=180 command_id=Command.Write_Attributes_rsp>
[0x938C:1:0xfcc0]: bound 'opple_cluster' cluster: Status.SUCCESS
[0x938C:1:0xfcc0]: finished channel configuration
[0x938c] Extending timeout for 0xba request
[0x938C:1:0x0008]: bound 'level' cluster: Status.SUCCESS
[0x938C:1:0x0008]: finished channel configuration
[0x938c] Extending timeout for 0xbc request
[0x938c:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=184 command_id=Command.Configure_Reporting_rsp>
[0x938C:1:0x0001]: reporting 'battery_percentage_remaining' attr on 'power' cluster: 3600/10800/1: Result: '[[ConfigureReportingResponseRecord(status=134, direction=0, attrid=33)]]'
[0x938C:1:0x0001]: finished channel configuration
[0x938c] Extending timeout for 0xbe request
[0x938C:1:0x0006]: bound 'on_off' cluster: Status.SUCCESS
[0x938C:1:0x0006]: finished channel configuration
[0x938c] Extending timeout for 0xc0 request
[0x938C:1:0x0300]: bound 'light_color' cluster: Status.SUCCESS
[0x938C:1:0x0300]: finished channel configuration
[0x938c] Extending timeout for 0xc2 request
[0x938C:1:0x0001]: 'async_configure' stage succeeded
[0x938C:1:0xfcc0]: 'async_configure' stage succeeded
[0x938C:1:0x0000]: 'async_configure' stage succeeded
[0x938C:1:0x0008]: 'async_configure' stage succeeded
[0x938C:1:0x0006]: 'async_configure' stage succeeded
[0x938C:1:0x0300]: 'async_configure' stage succeeded
[0x938C:2:0x0006]: bound 'on_off' cluster: Status.SUCCESS
[0x938C:2:0x0006]: finished channel configuration
[0x938c] Extending timeout for 0xc4 request
[0x938C:2:0x0006]: 'async_configure' stage succeeded
[0x938C:3:0x0006]: bound 'on_off' cluster: Status.SUCCESS
[0x938C:3:0x0006]: finished channel configuration
[0x938c] Extending timeout for 0xc6 request
[0x938C:3:0x0006]: 'async_configure' stage succeeded
[0x938C:4:0x0006]: bound 'on_off' cluster: Status.TABLE_FULL
[0x938C:4:0x0006]: finished channel configuration
[0x938C:4:0x0006]: 'async_configure' stage succeeded
[0x938C:5:0x0006]: bound 'on_off' cluster: Status.TABLE_FULL
[0x938C:5:0x0006]: finished channel configuration
[0x938C:5:0x0006]: 'async_configure' stage succeeded
[0x938C:6:0x0006]: bound 'on_off' cluster: Status.TABLE_FULL
[0x938C:6:0x0006]: finished channel configuration
[0x938C:6:0x0006]: 'async_configure' stage succeeded
[0x938C](lumi.remote.b686opcn01): completed configuration
[0x938C](lumi.remote.b686opcn01): stored in registry: ZhaDeviceEntry(name='LUMI lumi.remote.b686opcn01', ieee='04:cf:8c:df:3c:75:b4:17', last_seen=1616952921.1147282)
[0x938c] Extending timeout for 0xc8 request
[0x938c:1:0x0003] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=200 command_id=Command.Default_Response>
[0x938C:1:0x0003]: executed 'trigger_effect' command with args: '(2, 0)' kwargs: '{}' result: [64, <Status.SUCCESS: 0>]
[0x938C](lumi.remote.b686opcn01): started initialization
[0x938C:ZDO](lumi.remote.b686opcn01): 'async_initialize' stage succeeded
[0x938C:1:0x0001]: initializing channel: from_cache: False
[0x938c] Extending timeout for 0xca request
[0x938C:1:0xfcc0]: initializing channel: from_cache: False
[0x938C:1:0xfcc0]: finished channel configuration
[0x938C:1:0x0000]: initializing channel: from_cache: False
[0x938C:1:0x0000]: finished channel configuration
[0x938C:1:0x0008]: initializing channel: from_cache: False
[0x938C:1:0x0008]: finished channel configuration
[0x938C:1:0x0006]: initializing channel: from_cache: False
[0x938C:1:0x0006]: finished channel configuration
[0x938C:1:0x0300]: initializing channel: from_cache: False
[0x938C:1:0x0300]: finished channel configuration
[0x938C:2:0x0006]: initializing channel: from_cache: False
[0x938C:2:0x0006]: finished channel configuration
[0x938C:3:0x0006]: initializing channel: from_cache: False
[0x938C:3:0x0006]: finished channel configuration
[0x938C:4:0x0006]: initializing channel: from_cache: False
[0x938C:4:0x0006]: finished channel configuration
[0x938C:5:0x0006]: initializing channel: from_cache: False
[0x938C:5:0x0006]: finished channel configuration
[0x938C:6:0x0006]: initializing channel: from_cache: False
[0x938C:6:0x0006]: finished channel configuration
[0x938C:2:0x0006]: 'async_initialize' stage succeeded
[0x938C:3:0x0006]: 'async_initialize' stage succeeded
[0x938C:4:0x0006]: 'async_initialize' stage succeeded
[0x938C:5:0x0006]: 'async_initialize' stage succeeded
[0x938C:6:0x0006]: 'async_initialize' stage succeeded
[0x938c:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=202 command_id=Command.Read_Attributes_rsp>
[0x938c] Extending timeout for 0xcc request
[0x938c:1:0x0001] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=204 command_id=Command.Read_Attributes_rsp>
[0x938C:1:0x0001]: finished channel configuration
[0x938C:1:0x0001]: 'async_initialize' stage succeeded
[0x938C:1:0xfcc0]: 'async_initialize' stage succeeded
[0x938C:1:0x0000]: 'async_initialize' stage succeeded
[0x938C:1:0x0008]: 'async_initialize' stage succeeded
[0x938C:1:0x0006]: 'async_initialize' stage succeeded
[0x938C:1:0x0300]: 'async_initialize' stage succeeded
[0x938C](lumi.remote.b686opcn01): power source: Battery or Unknown
[0x938C](lumi.remote.b686opcn01): completed initialization
[0xadfe:1:0x0000] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=250 command_id=Command.Report_Attributes>
[0xadfe:1:0x0000] ZCL request 0x000a: [[Attribute(attrid=65281, value=<TypeValue type=CharacterString, value=!� !�C!
>)]]
[0xadfe:1:0x0000] Attribute report received: 65281=!� !�C!
[0xadfe:1:0x0001] Voltage mV: [Min]:2820 < [RAW]:2955 < [Max]:3100, Battery Percent: 48.0