Trafri plug pair process issue

[jalme]

Hi,

I'm able to pair with success two Tradfri plugs but there are two more than it is discovered but the plug itself doesn't get out of the pair process (led continues to blink slowly). Process followed: 1. Reset plug by pressing reset pin for 10 seconds, 2. call pair in zigate, 3. Can see the switch in HA but will not respond to commands and led in plug continues to blink.

Log:

019-02-04 18:20:45 DEBUG (SyncWorker_2) [zigate] REQUEST : 0x0049 FFFC1E00
2019-02-04 18:20:45 DEBUG (SyncWorker_2) [zigate] Msg to send b'0049000450fffc1e00'
2019-02-04 18:20:45 DEBUG (SyncWorker_2) [zigate] Encoded Msg to send b'010210490210021450fffc1e021003'
2019-02-04 18:20:45 DEBUG (SyncWorker_2) [zigate] Waiting for status message for command 0x0049
2019-02-04 18:20:45 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xf7\x02\x10;\x02\x10I\x02\x10\x03'
2019-02-04 18:20:45 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-04 18:20:45 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'003b0049'
2019-02-04 18:20:45 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:59, packet_type:73, error:b'', rssi:0
2019-02-04 18:20:45 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-04 18:20:45 DEBUG (SyncWorker_2) [zigate] STATUS code to command 0x0049:RESPONSE 0x8000 - Status response : status:0, sequence:59, packet_type:73, error:b'', rssi:0
2019-02-04 18:20:55 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x02\x10M\x02\x10\x02\x1cw\x87\xef\x02\x10\x02\x1do\xff\xfe\xc9$^\x8e\x02\x10\x03'
2019-02-04 18:20:56 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-04 18:20:56 DEBUG (ZiGate-Decode data) [zigate] Received response 0x004d: b'87ef000d6ffffec9245e8e'
2019-02-04 18:20:56 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x004D - Device announce : addr:87ef, ieee:000d6ffffec9245e, mac_capability:10001110, rssi:0
2019-02-04 18:20:56 DEBUG (ZiGate-Decode data) [zigate] Device Announce RESPONSE 0x004D - Device announce : addr:87ef, ieee:000d6ffffec9245e, mac_capability:10001110, rssi:0
2019-02-04 18:20:56 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_DEVICE_UPDATED
2019-02-04 18:20:56 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-04 18:20:59 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x02\x10M\x02\x10\x02\x1cw\x87\xef\x02\x10\x02\x1do\xff\xfe\xc9$^\x8e\x02\x10\x03'
2019-02-04 18:20:59 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x02\x10M\x02\x10\x02\x1c#\x87\xef\x02\x10\x02\x1do\xff\xfe\xc9$^\x8eT\x03\x01'
2019-02-04 18:20:59 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] Received response 0x004d: b'87ef000d6ffffec9245e8e'
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x004D - Device announce : addr:87ef, ieee:000d6ffffec9245e, mac_capability:10001110, rssi:0
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] Device Announce RESPONSE 0x004D - Device announce : addr:87ef, ieee:000d6ffffec9245e, mac_capability:10001110, rssi:0
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_DEVICE_UPDATED
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x004D - Device announce : addr:87ef, ieee:000d6ffffec9245e, mac_capability:10001110, rssi:84
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] Device Announce RESPONSE 0x004D - Device announce : addr:87ef, ieee:000d6ffffec9245e, mac_capability:10001110, rssi:84
2019-02-04 18:20:59 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x87\x02\x11\x02\x10\x02\x13\x85\x02\x10\x02\x10\x02\x10\x03'
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8701: b'0000'
2019-02-04 18:20:59 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8701 - Route Discovery Confirmation : status:0, network_status:0, rssi:0

[doudz]

You're the 2nd people with that problem. I suggest you to disconnect the successfully paired plug before trying to pair a new one

[jalme]

Hi,

Thanks. Tried that but same result. The "funny" part is that it seems that the plugs are communicating back to Zigate when I unplug and plug it again.

Log:

2019-02-04 21:03:08 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x02\x10M\x02\x10\x02\x1c\x8e\xf8\xdd\x02\x10\x02\x1do\xff\xfe\xc3\xa7\xff\x8e\x9c\x03'
2019-02-04 21:03:08 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-04 21:03:08 DEBUG (ZiGate-Decode data) [zigate] Received response 0x004d: b'f8dd000d6ffffec3a7ff8e'
2019-02-04 21:03:08 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x004D - Device announce : addr:f8dd, ieee:000d6ffffec3a7ff, mac_capability:10001110, rssi:156
2019-02-04 21:03:08 DEBUG (ZiGate-Decode data) [zigate] Device Announce RESPONSE 0x004D - Device announce : addr:f8dd, ieee:000d6ffffec3a7ff, mac_capability:10001110, rssi:156
2019-02-04 21:03:08 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_DEVICE_UPDATED
2019-02-04 21:03:08 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-04 21:03:08 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x87\x02\x11\x02\x10\x02\x13\x85\x02\x10\x02\x10\x02\x10\x03'
2019-02-04 21:03:08 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8701: b'0000'
2019-02-04 21:03:08 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8701 - Route Discovery Confirmation : status:0, network_status:0, rssi:0

At the end the plug still shows off in HA although the led is on (on the plug).

Tried also refresh device on the other non working plug:

2019-02-04 21:20:40 DEBUG (SyncWorker_1) [zigate] REQUEST : 0x0100 b'\x02\x87\xef\x01\x01\x00\x00\x00\x00\x00\x00\x01\x00\x05'
2019-02-04 21:20:40 DEBUG (SyncWorker_1) [zigate] Msg to send b'0100000e610287ef0101000000000000010005'
2019-02-04 21:20:40 DEBUG (SyncWorker_1) [zigate] Encoded Msg to send b'01021102100210021e61021287ef0211021102100210021002100210021002110210021503'
2019-02-04 21:20:40 DEBUG (SyncWorker_1) [zigate] Waiting for status message for command 0x0100
2019-02-04 21:20:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x155\x02\x10\xb1\x02\x11\x02\x10\x02\x10\x03'
2019-02-04 21:20:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x81\x02\x12\x02\x10#\xab\xb1\x87\xef\x02\x11\x02\x10\x02\x10\x02\x10\x02\x15\x02\x10B\x02\x10\x16TRADFRI control outlet\xa8\x03'
2019-02-04 21:20:40 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-04 21:20:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00b10100'
2019-02-04 21:20:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:177, packet_type:256, error:b'', rssi:0
2019-02-04 21:20:40 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-04 21:20:40 DEBUG (SyncWorker_1) [zigate] STATUS code to command 0x0100:RESPONSE 0x8000 - Status response : status:0, sequence:177, packet_type:256, error:b'', rssi:0
2019-02-04 21:20:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8102: b'b187ef0100000005004200165452414446524920636f6e74726f6c206f75746c6574'
2019-02-04 21:20:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8102 - Individual Attribute Report : sequence:177, addr:87ef, endpoint:1, cluster:0, attribute:5, status:0, data_type:66, size:22, data:TRADFRI control outlet, rssi:168
2019-02-04 21:20:40 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_ATTRIBUTE_UPDATED

It seems that the plug is returning correctly to Zigate

[jalme]

Ok found a workaround.

With the plug on the weird state I created an automation to turn the plug off (switch.turn_off) after running the automation the plug is responding to commands....

So in conclusion calling the switch.turn_off event will put the plug on the correct state from that point onward.

[doudz]

so the problem is the state reporting ? Try to call the service "discover_device" to see if it helps

[jalme]

Did that already and still the issue persisted. The only way to have this working was calling turn_off.

[doudz]

Could you call the discover_service and post here the debug log ?

[jalme]

Sure.

Just paired a new one with the same issue and this is the log from discovery_service:

2019-02-05 19:48:38 WARNING (SyncWorker_3) [zigate] No template found for TRADFRI_control_outlet
2019-02-05 19:48:38 DEBUG (SyncWorker_3) [zigate] Start automagic bind and report process for device Device TRADFRI control outlet (a3f8) 000d6ffffeb1e842
2019-02-05 19:48:38 DEBUG (SyncWorker_3) [zigate] Bind and report endpoint 1 for device Device TRADFRI control outlet (a3f8) 000d6ffffeb1e842
2019-02-05 19:48:38 DEBUG (SyncWorker_3) [zigate] bind and report for cluster 0x0006
2019-02-05 19:48:38 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0030 b'\x00\ro\xff\xfe\xb1\xe8B\x01\x00\x06\x03\x00\x15\x8d\x00\x01\xed\xb7\x12\x01'
2019-02-05 19:48:38 DEBUG (SyncWorker_3) [zigate] Msg to send b'0030001589000d6ffffeb1e8420100060300158d0001edb71201'
2019-02-05 19:48:38 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'01021030021015890210021d6ffffeb1e84202110210021602130210158d02100211edb712021103'
2019-02-05 19:48:38 DEBUG (SyncWorker_3) [zigate] Waiting for status message for command 0x0030
2019-02-05 19:48:38 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xe8\x02\x10]\x02\x100\x02\x10\x03'
2019-02-05 19:48:38 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x800\x02\x10\x02\x13F]\x02\x10\xa8\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'005d0030'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:93, packet_type:48, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8030: b'5d00'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8030 - Bind response : sequence:93, status:0, rssi:168
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0030:RESPONSE 0x8000 - Status response : status:0, sequence:93, packet_type:48, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Waiting for message 0x8030
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Stop waiting, got message 0x8030
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0120 b'\x02\xa3\xf8\x01\x01\x00\x06\x00\x00\x00\x00\x01\x00\x10\x00\x00\x00\x01\x0e\x10\x00\x00\x00'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Msg to send b'012000176702a3f80101000600000000010010000000010e10000000'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'01021120021017670212a3f80211021102100216021002100210021002110210100210021002100211021e1002100210021003'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Waiting for status message for command 0x0120
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xf2\x02\x10V\x02\x11 \x02\x10\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00560120'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:86, packet_type:288, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0120:RESPONSE 0x8000 - Status response : status:0, sequence:86, packet_type:288, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Waiting for message 0x8120
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x81 \x02\x10\x02\x18\x02\x16V\xa3\xf8\x02\x11\x02\x10\x02\x16\x02\x10\xa5\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8120: b'56a3f801000600'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8120 - Configure Reporting response : sequence:86, addr:a3f8, endpoint:1, cluster:6, status:0, rssi:165
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Stop waiting, got message 0x8120
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] bind and report for cluster 0x0008
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0030 b'\x00\ro\xff\xfe\xb1\xe8B\x01\x00\x08\x03\x00\x15\x8d\x00\x01\xed\xb7\x12\x01'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Msg to send b'0030001587000d6ffffeb1e8420100080300158d0001edb71201'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'01021030021015870210021d6ffffeb1e84202110210021802130210158d02100211edb712021103'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Waiting for status message for command 0x0030
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xeb\x02\x10^\x02\x100\x02\x10\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'005e0030'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:94, packet_type:48, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0030:RESPONSE 0x8000 - Status response : status:0, sequence:94, packet_type:48, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x800\x02\x10\x02\x13E^\x02\x10\xa8\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8030: b'5e00'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8030 - Bind response : sequence:94, status:0, rssi:168
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0120 b'\x02\xa3\xf8\x01\x01\x00\x08\x00\x00\x00\x00\x01\x00 \x00\x00\x00\x01\x0e\x10\x00\x00\x00'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Msg to send b'012000175902a3f80101000800000000010020000000010e10000000'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'01021120021017590212a3f80211021102100218021002100210021002110210200210021002100211021e1002100210021003'
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xf3\x02\x10W\x02\x11 \x02\x10\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00570120'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:87, packet_type:288, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0120:RESPONSE 0x8000 - Status response : status:0, sequence:87, packet_type:288, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x81 \x02\x10\x02\x18\x02\x14W\xa3\xf8\x02\x11\x02\x10\x02\x18\x02\x10\xa8\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8120: b'57a3f801000800'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8120 - Configure Reporting response : sequence:87, addr:a3f8, endpoint:1, cluster:8, status:0, rssi:168
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Bind and report endpoint 242 for device Device TRADFRI control outlet (a3f8) 000d6ffffeb1e842
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000ee902a3f801010000000000000000ff'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021ee90212a3f80211021102100210021002100210021002100210ff03'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Waiting for status message for command 0x0140
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\x9c\x02\x10X\x02\x11@\x02\x10\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00580140'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:88, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:88, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\x01\x00\x03\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000eea02a3f801010003000000000000ff'
2019-02-05 19:48:39 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021eea0212a3f80211021102100213021002100210021002100210ff03'
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b"\x01\x81@\x02\x10\x02\x15@\x02\x11 \x02\x10\x02\x10\xa5\x03\x01\x81@\x02\x10\x02\x15A\x02\x11 \x02\x10\x02\x11\xa5\x03\x01\x81@\x02\x10\x02\x15B\x02\x11 \x02\x10\x02\x12\xa5\x03\x01\x81@\x02\x10\x02\x15C\x02\x11 \x02\x10\x02\x13\xa5\x03\x01\x81@\x02\x10\x02\x15&\x02\x11B\x02\x10\x02\x14\xa5\x03\x01\x81@\x02\x10\x02\x15'\x02\x11B\x02\x10\x02\x15\xa5\x03\x01\x81@\x02\x10\x02\x15$\x02\x11B\x02\x10\x02\x16\xa5\x03\x01\x81@\x02\x10\x02\x15W\x02\x110\x02\x10\x02\x17\xa5\x03\x01\x81@\x02\x10\x02\x15X\x02\x110\x02\x10\x02\x18\xa5\x03\x01\x81@\x02\x10\x02\x15Y\x02\x110\x02\x10\x02\x19\xa5\x03\x01\x81@\x02\x10\x02\x15+\x02\x11A\x02\x10\x02\x1a\xa5\x03\x01\x81@\x02\x10\x02\x15b\x02\x11B@\x02\x10\xa5\x03\x01\x81@\x02\x10\x02\x15C\x02\x11!\xff\xfd\xa5\x03"
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\x9d\x02\x10Y\x02\x11@\x02\x10\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01200000'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:32, attribute:0, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01200001'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:32, attribute:1, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01200002'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:32, attribute:2, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01200003'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:32, attribute:3, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x81@\x02\x10\x02\x15L\x02\x11!\x02\x10\x02\x10\xa8\x03\x01\x81@\x02\x10\x02\x15N\x02\x11!\xff\xfd\xa8\x03'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01420004'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:66, attribute:4, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01420005'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:66, attribute:5, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01420006'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:66, attribute:6, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01300007'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:48, attribute:7, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01300008'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:48, attribute:8, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01300009'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:48, attribute:9, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'0141000a'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:65, attribute:10, rssi:165
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01424000'
2019-02-05 19:48:39 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:66, attribute:16384, rssi:165
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'0121fffd'
2019-02-05 19:48:40 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:33, attribute:65533, rssi:165
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00590140'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:89, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01210000'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:89, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:33, attribute:0, rssi:168
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\x01\x00\x04\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000eed02a3f801010004000000000000ff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021eed0212a3f80211021102100214021002100210021002100210ff03'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Waiting for status message for command 0x0140
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:33, attribute:65533, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\x9e\x02\x10Z\x02\x11@\x02\x10\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'005a0140'
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x81@\x02\x10\x02\x15u\x02\x11\x18\x02\x10\x02\x10\xa8\x03\x01\x81@\x02\x10\x02\x15N\x02\x11!\xff\xfd\xa8\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:90, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:90, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\x01\x00\x05\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000eec02a3f801010005000000000000ff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021eec0212a3f80211021102100215021002100210021002100210ff03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01180000'
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\x9f\x02\x10[\x02\x11@\x02\x10\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:24, attribute:0, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'005b0140'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:91, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:91, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\x01\x00\x06\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000eef02a3f801010006000000000000ff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021eef0212a3f80211021102100216021002100210021002100210ff03'
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x81@\x02\x10\x02\x15M\x02\x11 \x02\x10\x02\x10\xa8\x03\x01\x81@\x02\x10\x02\x15L\x02\x11 \x02\x10\x02\x11\xa8\x03\x01\x81@\x02\x10\x02\x15N\x02\x11!\x02\x10\x02\x12\xa8\x03\x01\x81@\x02\x10\x02\x15~\x02\x11\x10\x02\x10\x02\x13\xa8\x03\x01\x81@\x02\x10\x02\x15q\x02\x11\x18\x02\x10\x02\x14\xa8\x03\x01\x81@\x02\x10\x02\x15N\x02\x11!\xff\xfd\xa8\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\x98\x02\x10\\\x02\x11@\x02\x10\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01200000'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:32, attribute:0, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01200001'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:32, attribute:1, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01210002'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:33, attribute:2, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x81@\x02\x10\x02\x15}\x02\x11\x10\x02\x10\x02\x10\xa8\x03\x01\x81@\x02\x10\x02\x15=\x02\x11\x10@\x02\x10\xa8\x03\x01\x81@\x02\x10\x02\x15\x02\x1d\x02\x11!@\x02\x11\xa8\x03\x01\x81@\x02\x10\x02\x15\x02\x1e\x02\x11!@\x02\x12\xa8\x03\x01\x81@\x02\x10\x02\x15\x1e\x02\x110@\x02\x13\xa8\x03\x01\x81@\x02\x10\x02\x15N\x02\x11!\xff\xfd\xa8\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01100003'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:16, attribute:3, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01180004'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:24, attribute:4, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'005c0140'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:92, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:92, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\x01\x00\x08\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000ee102a3f801010008000000000000ff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021ee10212a3f80211021102100218021002100210021002100210ff03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01100000'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:16, attribute:0, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01104000'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:16, attribute:16384, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01214001'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:33, attribute:16385, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01214002'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:33, attribute:16386, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01304003'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:48, attribute:16387, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\x99\x02\x10]\x02\x11@\x02\x10\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x81@\x02\x10\x02\x15M\x02\x11 \x02\x10\x02\x10\xa8\x03\x01\x81@\x02\x10\x02\x15M\x02\x11!\x02\x10\x02\x11\xa8\x03\x01\x81@\x02\x10\x02\x15z\x02\x11\x18\x02\x10\x02\x1f\xa8\x03\x01\x81@\x02\x10\x02\x15\\\x02\x11!\x02\x10\x10\xa8\x03\x01\x81@\x02\x10\x02\x15\\\x02\x11 \x02\x10\x11\xa8\x03\x01\x81@\x02\x10\x02\x15\x02\x1d\x02\x11 @\x02\x10\xa8\x03\x01\x81@\x02\x10\x02\x15N\x02\x11!\xff\xfd\xa8\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'005d0140'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:93, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:93, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\x01\x10\x00\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000ef902a3f801011000000000000000ff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021ef90212a3f802110211100210021002100210021002100210ff03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01210001'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:33, attribute:1, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'0118000f'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:24, attribute:15, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01210010'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:33, attribute:16, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01200011'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:32, attribute:17, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\x9a\x02\x10^\x02\x11@\x02\x10\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8140: b'01204000'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8140 - Attribute Discovery response : complete:1, data_type:32, attribute:16384, rssi:168
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'005e0140'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:94, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:94, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\x01\xfc|\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000e6902a3f80101fc7c000000000000ff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021e690212a3f802110211fc7c021002100210021002100210ff03'
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\x9b\x02\x10_\x02\x11@\x02\x10\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'005f0140'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:95, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:95, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0140 b'\x02\xa3\xf8\x01\xf2\x00!\x00\x00\x00\x00\x00\x00\xff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Msg to send b'0140000e3b02a3f801f20021000000000000ff'
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'010211400210021e3b0212a3f80211f2021021021002100210021002100210ff03'
2019-02-05 19:48:40 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xa4\x02\x10`\x02\x11@\x02\x10\x03'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00600140'
2019-02-05 19:48:40 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:96, packet_type:320, error:b'', rssi:0
2019-02-05 19:48:40 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0140:RESPONSE 0x8000 - Status response : status:0, sequence:96, packet_type:320, error:b'', rssi:0

[doudz]

it's really strange, everythings looks good. so the problem is :

• the plug is off
• you turn on from HA
• the plug is on
• after few seconds the HA switch goes back to off but the plug is still on
• to turn off you have to call the service switch.turn_off

is it right ?

[jalme]

Hi,

Not quite right.

Issue is:

1. Pair the plug
2. in HA pairing is ok and plug is configured. It shows as off
3. Plug keeps blinking
4. After a few minutes plug led stops blinking
5. Plug does not respond to on/off request from HA
6. Plug only respond to service calls (on and off)

Is it more clear?

João

[doudz]

When you try to turn from HA switch, do you see command 0x0092 in log ?

The thing I don't understand is why it works using switch.turn_on and not using HA UI, because in both case it calls the same method turn_on Are you sure you don't have a problem in your HA history database?

[jalme]

Hi,

When I try to turn it on the log shows the comand:

2019-02-10 19:53:10 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0092 b'\x02\xe0A\x01\x01\x01'
2019-02-10 19:53:10 DEBUG (SyncWorker_0) [zigate] Msg to send b'009200063602e041010101'
2019-02-10 19:53:10 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'0102109202100216360212e04102110211021103'
2019-02-10 19:53:10 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0092
2019-02-10 19:53:10 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xc7\x02\x10\xd0\x02\x10\x92\x02\x10\x03'
2019-02-10 19:53:10 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-10 19:53:10 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00d00092'
2019-02-10 19:53:10 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:208, packet_type:146, error:b'', rssi:0
2019-02-10 19:53:10 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-10 19:53:10 DEBUG (SyncWorker_0) [zigate] STATUS code to command 0x0092:RESPONSE 0x8000 - Status response : status:0, sequence:208, packet_type:146, error:b'', rssi:0

How can I see if there are any issues on the HA history DB?

Thanks

[doudz]

I looks fine, and don't you see APS Data fail message few seconds after ? because the command 0x0092 has been successfully sent so I don't understand the problem... This plug has level control, and I disabled it because people told me it just doesn't work, but maybe it's the problem ?

[jalme]

Hi,

No APS message. Can be. Can we test with level control enabled?

[doudz]

You could try to call the service raw_command with the following parameter: { "cmd":"0x0081", "data":"02abcd010101fe0000" } replace abcd by the device short address

[jalme]

Unfortunately no change...

[doudz]

I've updated the data (fe instead of ff), could you retry ?

[jalme]

Sure. I'll do it at end of day since I'm no longer near the device.

[doudz]

Probably the same problem ? https://github.com/doudz/homeassistant-zigate/issues/28

[jalme]

No change also after the command.

[jalme]

Also I have checked the logbook and event views and everything is working fine. Also no errors on the logs related to logbook or such.

[doudz]

Could try to catch the line of the command 0x0092 when you call the service switch.turn_on and when you try to turn on from HA UI, to see if there's something different example : 2019-02-10 19:53:10 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0092 b'\x02\xe0A\x01\x01\x01'

[jalme]

Hi,

Log for the switch.turn_on:

2019-02-16 14:01:47 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0092 b'\x02\xe0A\x01\x01\x01'
2019-02-16 14:01:47 DEBUG (SyncWorker_3) [zigate] Msg to send b'009200063602e041010101'
2019-02-16 14:01:47 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'0102109202100216360212e04102110211021103'
2019-02-16 14:01:47 DEBUG (SyncWorker_3) [zigate] Waiting for status message for command 0x0092
2019-02-16 14:01:47 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xf9\x02\x10\xee\x02\x10\x92\x02\x10\x03'
2019-02-16 14:01:47 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-16 14:01:48 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00ee0092'
2019-02-16 14:01:48 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:238, packet_type:146, error:b'', rssi:0
2019-02-16 14:01:48 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-16 14:01:48 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0092:RESPONSE 0x8000 - Status response : status:0, sequence:238, packet_type:146, error:b'', rssi:0

Log for the UI turn on:

2019-02-16 14:02:33 DEBUG (SyncWorker_3) [zigate] REQUEST : 0x0092 b'\x02\xe0A\x01\x01\x01'
2019-02-16 14:02:33 DEBUG (SyncWorker_3) [zigate] Msg to send b'009200063602e041010101'
2019-02-16 14:02:33 DEBUG (SyncWorker_3) [zigate] Encoded Msg to send b'0102109202100216360212e04102110211021103'
2019-02-16 14:02:33 DEBUG (SyncWorker_3) [zigate] Waiting for status message for command 0x0092
2019-02-16 14:02:33 DEBUG (ZiGate-Listen) [zigate] Raw packet received, b'\x01\x80\x02\x10\x02\x10\x02\x15\xf8\x02\x10\xef\x02\x10\x92\x02\x10\x03'
2019-02-16 14:02:33 DEBUG (ZiGate-Event Loop) [zigate] Dispatch ZIGATE_PACKET_RECEIVED
2019-02-16 14:02:33 DEBUG (ZiGate-Decode data) [zigate] Received response 0x8000: b'00ef0092'
2019-02-16 14:02:33 DEBUG (ZiGate-Decode data) [zigate] RESPONSE 0x8000 - Status response : status:0, sequence:239, packet_type:146, error:b'', rssi:0
2019-02-16 14:02:33 DEBUG (ZiGate-Decode data) [zigate] Dispatch ZIGATE_RESPONSE_RECEIVED
2019-02-16 14:02:33 DEBUG (SyncWorker_3) [zigate] STATUS code to command 0x0092:RESPONSE 0x8000 - Status response : status:0, sequence:239, packet_type:146, error:b'', rssi:0

Hope it helps.

[jalme]

Also it seems that HA is reporting the plug has missing. I've tried to re-pair it but it still is showing as missing.

See bellow the attributes where missing=true

[doudz]

I don't see any difference in the two commands so technically both should work. If definitely not I suggest you to open a issue on https://github.com/fairecasoimeme/ZiGate because it's probably something related to Ikea and ZiGate. Maybe because of the number of plug

[doudz]

Are you using lovelace ou states UI ? If states UI, try lovelace to see if the problem is still here

Maybe it could be a problem with the plug internal firmware too, but there no OTA update right now

[ISO-B]

If you feel adventurous you could try with test firmware from http://fw.test.ota.homesmart.ikea.net/feed/version_info.json

[jalme]

Are you using lovelace ou states UI ? If states UI, try lovelace to see if the problem is still here

Maybe it could be a problem with the plug internal firmware too, but there no OTA update right now

I'm using only lovelace. Just upgraded ZiGate to 3.0f so will run for a while to see if this is fixed or not before opening a case in Zigate (I'm having the same issue now on all re-paired plugs)

[cobch]

Hi Doudz, I am trying to pair the Ikea plug with my hassio using PiZigate. When I call the service zigate.permit_join and reset the plug but nothing is appearing in Home assistant. Any help will be nice!

[doudz]

Sometimes Ikea stuff are difficult to reset, my advice is try again...

[cobch]

Ok. I tried with Conbee and it arrives directly. You mean that I should call the services and reset the plug and redo this till I get the plug appearing in hassio? Should the PiZigate blink or stay still blue?

[doudz]

During permit join , the blue led should blink

[cobch]

I will have a look tonight but I do not think the led was blinking )-: I send you the log file to see what is happening after I call the service.

[cobch]

No blinking when I cal the service zigate.permit_join. My log return the following error: 2019-05-11 18:21:17 DEBUG (SyncWorker_15) [zigate] REQUEST : 0x0049 FFFC1E00 2019-05-11 18:21:17 DEBUG (SyncWorker_15) [zigate] Msg to send b'0049000450fffc1e00' 2019-05-11 18:21:17 DEBUG (SyncWorker_15) [zigate] Encoded Msg to send b'010210490210021450fffc1e021003' 2019-05-11 18:21:17 DEBUG (SyncWorker_15) [zigate] Waiting for status message for command 0x0049 2019-05-11 18:21:20 WARNING (SyncWorker_15) [zigate] No response after command 0x0049 (20)

It seem than no service is working. I tried for example to call the service Zigate.stop but the led light was still strong blue. Any idea why the service from hassio are not working the my PiZigate?

[max5962]

I always have issues when I try to pair Ikea plug ... Everytime the solution is to wait. It seems that the plug is flooding the network and the zigate seems to lag ...

[cobch]

What is strange is that my PiZigate is not blinking so I guess that it can be a config issue as well. I also tried to call other services but noting is happening (start, stop zygate for example)

[doudz]

@cobch I suggest you to put zigate log in debug mode (see Readme) and post here the log at starting. I suppose the port is not the right one No response after command 0x0049 (20) means the zigate is not responding to command and it's the 20th "no response" message so there's really a problem

[cobch]

Hi Doudz,

You helped me configuring the PiZigate already (https://github.com/doudz/homeassistant-zigate/issues/47)

My config.yawl is without a specified port because when I wrote "port: /dev/ttyAMA0" the blue light get never strong. Should I try to specify the port in my config anyway?

After I reboot hassio my log is the following: 2019-05-11 18:26:01 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for zigate which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you do experience issues with Home Assistant. te] Encoded Msg to send b'010210180210021118021103' 2019-05-12 09:20:27 DEBUG (SyncWorker_4) [zigate] Waiting for status message for command 0x0018

I send a picture of what I get in hassio:

[cobch]

2019-05-12 09:30:14 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for zigate which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you do experience issues with Home Assistant.
2019-05-12 09:30:42 DEBUG (SyncWorker_0) [zigate] Try loading persistent file
2019-05-12 09:30:42 DEBUG (SyncWorker_0) [zigate] Load success
2019-05-12 09:30:42 INFO (SyncWorker_0) [zigate] Searching ZiGate port
2019-05-12 09:30:43 INFO (SyncWorker_0) [zigate] ZiGate found at /dev/ttyAMA0
2019-05-12 09:30:43 ERROR (ZiGate-Listen) [zigate] OOPS connection lost, reconnect...
2019-05-12 09:30:43 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0010 
2019-05-12 09:30:43 DEBUG (SyncWorker_0) [zigate] Msg to send b'0010000010'
2019-05-12 09:30:43 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'01021010021002101003'
2019-05-12 09:30:43 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0010
2019-05-12 09:30:46 WARNING (SyncWorker_0) [zigate] No response after command 0x0010 (1)
2019-05-12 09:30:46 WARNING (SyncWorker_0) [zigate] Failed to retrieve zigate firmware version
2019-05-12 09:30:47 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0021 b'\x03\x18\xc8\x00'
2019-05-12 09:30:47 DEBUG (SyncWorker_0) [zigate] Msg to send b'00210004f60318c800'
2019-05-12 09:30:47 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'0102102102100214f6021318c8021003'
2019-05-12 09:30:47 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0021
2019-05-12 09:30:50 WARNING (SyncWorker_0) [zigate] No response after command 0x0021 (2)
2019-05-12 09:30:50 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0023 b'\x00'
2019-05-12 09:30:50 DEBUG (SyncWorker_0) [zigate] Msg to send b'002300012200'
2019-05-12 09:30:50 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'010210230210021122021003'
2019-05-12 09:30:50 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0023
2019-05-12 09:30:53 WARNING (SyncWorker_0) [zigate] No response after command 0x0023 (3)
2019-05-12 09:30:53 DEBUG (SyncWorker_0) [zigate] Check network state
2019-05-12 09:30:54 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0009 
2019-05-12 09:30:54 DEBUG (SyncWorker_0) [zigate] Msg to send b'0009000009'
2019-05-12 09:30:54 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'010210021902100210021903'
2019-05-12 09:30:54 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0009
2019-05-12 09:30:57 WARNING (SyncWorker_0) [zigate] No response after command 0x0009 (4)
2019-05-12 09:30:57 ERROR (SyncWorker_0) [zigate] Failed to get network state
2019-05-12 09:30:57 DEBUG (SyncWorker_0) [zigate] Network is down, start it
2019-05-12 09:30:57 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0024 
2019-05-12 09:30:57 DEBUG (SyncWorker_0) [zigate] Msg to send b'0024000024'
2019-05-12 09:30:57 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'01021024021002102403'
2019-05-12 09:30:57 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0024
2019-05-12 09:30:59 ERROR (SyncWorker_1) [homeassistant.components.yeelight] Unable to update bulb status: A socket error occurred when sending the command.
2019-05-12 09:31:00 WARNING (SyncWorker_0) [zigate] No response after command 0x0024 (5)
2019-05-12 09:31:00 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0015 
2019-05-12 09:31:00 DEBUG (SyncWorker_0) [zigate] Msg to send b'0015000015'
2019-05-12 09:31:00 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'01021015021002101503'
2019-05-12 09:31:00 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0015
2019-05-12 09:31:03 WARNING (SyncWorker_0) [zigate] No response after command 0x0015 (6)
2019-05-12 09:31:03 DEBUG (SyncWorker_0) [zigate] Auto saving /config/zigate.json
2019-05-12 09:31:03 DEBUG (SyncWorker_0) [zigate] Saving persistent file
2019-05-12 09:31:03 DEBUG (SyncWorker_0) [zigate] File already existing, make a backup before
2019-05-12 09:31:03 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0018 b'\x01'
2019-05-12 09:31:03 DEBUG (SyncWorker_0) [zigate] Msg to send b'001800011801'
2019-05-12 09:31:03 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'010210180210021118021103'
2019-05-12 09:31:03 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0018
2019-05-12 09:31:04 ERROR (MainThread) [frontend.js.es5.201904240] http://hassio.local:8123/frontend_es5/chunk.1f7fc64bdbcaf1df8d01.js:2:314939 TypeError: e is undefined
2019-05-12 09:31:06 WARNING (SyncWorker_0) [zigate] No response after command 0x0018 (7)
2019-05-12 09:31:06 DEBUG (SyncWorker_0) [zigate] REQUEST : 0x0010 
2019-05-12 09:31:06 DEBUG (SyncWorker_0) [zigate] Msg to send b'0010000010'
2019-05-12 09:31:06 DEBUG (SyncWorker_0) [zigate] Encoded Msg to send b'01021010021002101003'
2019-05-12 09:31:06 DEBUG (SyncWorker_0) [zigate] Waiting for status message for command 0x0010
2019-05-12 09:31:09 WARNING (SyncWorker_0) [zigate] No response after command 0x0010 (8)
2019-05-12 09:31:09 WARNING (SyncWorker_0) [zigate] Failed to retrieve zigate firmware version
2019-05-12 09:31:09 ERROR (MainThread) [homeassistant.core] Error doing job: Future exception was never retrieved
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/concurrent/futures/thread.py", line 57, in run
    result = self.fn(*self.args, **self.kwargs)
  File "/config/custom_components/zigate/__init__.py", line 344, in start_zigate
    version = myzigate.get_version_text()
  File "/config/deps/lib/python3.7/site-packages/zigate/core.py", line 782, in get_version_text
    v = self.get_version(refresh)['version']
TypeError: 'NoneType' object is not subscriptable
2019-05-12 09:31:26 ERROR (SyncWorker_12) [homeassistant.components.yeelight] Unable to update bulb status: Bulb closed the connection.
2019-05-12 09:32:28 ERROR (SyncWorker_9) [homeassistant.components.yeelight] Unable to update bulb status: Bulb closed the connection.
2019-05-12 09:33:30 ERROR (SyncWorker_5) [homeassistant.components.yeelight] Unable to update bulb status: Bulb closed the connection.
2019-05-12 09:34:28 ERROR (SyncWorker_17) [homeassistant.components.yeelight] Unable to update bulb status: Bulb closed the connection.
2019-05-12 09:36:03 DEBUG (Thread-3) [zigate] Auto saving /config/zigate.json
2019-05-12 09:36:03 DEBUG (Thread-3) [zigate] Saving persistent file
2019-05-12 09:36:03 DEBUG (Thread-3) [zigate] File already existing, make a backup before
2019-05-12 09:36:31 ERROR (SyncWorker_3) [homeassistant.components.yeelight] Unable to update bulb status: A socket error occurred when sending the command.

[cobch]

Any Idea? I will try to change the port on my config.yawl tonight and post the log file!

[doudz]

Probably port /dev/ttyAMA0 is not the right one or maybe you have to do some additionnal change, for example on raspbian I have to disable linux serial console since it use /dev/ttyAMA0

(and it's config.yaml, not config.yawl :smile: )

[doudz]

using the ssh addon you could try the following command too curl -d ‘{“devices”: [“ttyAMA0”]}’ http://hassio/homeassistant/options

[cobch]

Hi Doudz, I have tried to add the following in my config.yaml (-:

zigate:
  gpio: true
  port: /dev/ttyAMA0

_The state of PiZiGate is now in strong blue light and seems connected to Hassio. Here is my log just after the start:

2019-05-13 20:42:57 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for zigate which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you do experience issues with Home Assistant. 2019-05-13 20:43:02 ERROR (MainThread) [.] Error connecting to deCONZ gateway at 172.30.32.1 2019-05-13 20:43:19 DEBUG (SyncWorker_7) [zigate] Try loading persistent file 2019-05-13 20:43:19 DEBUG (SyncWorker_7) [zigate] Load success 2019-05-13 20:43:19 ERROR (ZiGate-Listen) [zigate] OOPS connection lost, reconnect... 2019-05-13 20:43:19 DEBUG (SyncWorker_7) [zigate] REQUEST : 0x0010 2019-05-13 20:43:19 DEBUG (SyncWorker_7) [zigate] Msg to send b'0010000010' 2019-05-13 20:43:19 DEBUG (SyncWorker_7) [zigate] Encoded Msg to send b'01021010021002101003' 2019-05-13 20:43:19 DEBUG (SyncWorker_7) [zigate] Waiting for status message for command 0x0010 2019-05-13 20:43:19 ERROR (ZiGate-Listen) [zigate] OOPS connection lost, reconnect... 2019-05-13 20:43:20 ERROR (MainThread) [.] Error connecting to deCONZ gateway at 172.30.32.1 2019-05-13 20:43:22 WARNING (SyncWorker_7) [zigate] No response after command 0x0010 (1) 2019-05-13 20:43:22 WARNING (SyncWorker_7) [zigate] Failed to retrieve zigate firmware version 2019-05-13 20:43:22 DEBUG (SyncWorker_7) [zigate] REQUEST : 0x0021 b'\x03\x18\xc8\x00' 2019-05-13 20:43:22 DEBUG (SyncWorker_7) [zigate] Msg to send b'00210004f60318c800' 2019-05-13 20:43:22 DEBUG (SyncWorker_7) [zigate] Encoded Msg to send b'0102102102100214f6021318c8021003' 2019-05-13 20:43:22 DEBUG (SyncWorker_7) [zigate] Waiting for status message for command 0x0021 2019-05-13 20:43:25 WARNING (SyncWorker_7) [zigate] No response after command 0x0021 (2) 2019-05-13 20:43:25 DEBUG (SyncWorker_7) [zigate] REQUEST : 0x0023 b'\x00' 2019-05-13 20:43:25 DEBUG (SyncWorker_7) [zigate] Msg to send b'002300012200' 2019-05-13 20:43:25 DEBUG (SyncWorker_7) [zigate] Encoded Msg to send b'010210230210021122021003' 2019-05-13 20:43:25 DEBUG (SyncWorker_7) [zigate] Waiting for status message for command 0x0023 2019-05-13 20:43:28 WARNING (SyncWorker_7) [zigate] No response after command 0x0023 (3) 2019-05-13 20:43:28 DEBUG (SyncWorker_7) [zigate] Check network state 2019-05-13 20:43:28 DEBUG (SyncWorker_7) [zigate] REQUEST : 0x0009 2019-05-13 20:43:28 DEBUG (SyncWorker_7) [zigate] Msg to send b'0009000009' 2019-05-13 20:43:28 DEBUG (SyncWorker_7) [zigate] Encoded Msg to send b'010210021902100210021903' 2019-05-13 20:43:28 DEBUG (SyncWorker_7) [zigate] Waiting for status message for command 0x0009 2019-05-13 20:43:31 ERROR (MainThread) [.] Error connecting to deCONZ gateway at 172.30.32.1 2019-05-13 20:43:31 WARNING (SyncWorker_7) [zigate] No response after command 0x0009 (4) 2019-05-13 20:43:31 ERROR (SyncWorker_7) [zigate] Failed to get network state 2019-05-13 20:43:31 DEBUG (SyncWorker_7) [zigate] Network is down, start it 2019-05-13 20:43:31 DEBUG (SyncWorker_7) [zigate] REQUEST : 0x0024 2019-05-13 20:43:31 DEBUG (SyncWorker_7) [zigate] Msg to send b'0024000024' 2019-05-13 20:43:31 DEBUG (SyncWorker_7) [zigate] Encoded Msg to send b'01021024021002102403' 2019-05-13 20:43:31 DEBUG (SyncWorker_7) [zigate] Waiting for status message for command 0x0024 2019-05-13 20:43:34 WARNING (SyncWorker_7) [zigate] No response after command 0x0024 (5) 2019-05-13 20:43:35 DEBUG (SyncWorker_7) [zigate] REQUEST : 0x0015 2019-05-13 20:43:35 DEBUG (SyncWorker_7) [zigate] Msg to send b'0015000015' 2019-05-13 20:43:35 DEBUG (SyncWorker_7) [zigate] Encoded Msg to send b'01021015021002101503' 2019-05-13 20:43:35 DEBUG (SyncWorker_7) [zigate] Waiting for status message for command 0x0015 2019-05-13 20:43:36 ERROR (MainThread) [frontend.js.es5.201904240] http://hassio.local:8123/frontend_es5/chunk.1f7fc64bdbcaf1df8d01.js:2:314939 TypeError: e is undefined 2019-05-13 20:43:38 WARNING (SyncWorker_7) [zigate] No response after command 0x0015 (6) 2019-05-13 20:43:38 DEBUG (SyncWorker_7) [zigate] Auto saving /config/zigate.json 2019-05-13 20:43:38 DEBUG (SyncWorker_7) [zigate] Saving persistent file 2019-05-13 20:43:38 DEBUG (SyncWorker_7) [zigate] File already existing, make a backup before 2019-05-13 20:43:38 DEBUG (SyncWorker_7) [zigate] REQUEST : 0x0018 b'\x01' 2019-05-13 20:43:38 DEBUG (SyncWorker_7) [zigate] Msg to send b'001800011801' 2019-05-13 20:43:38 DEBUG (SyncWorker_7) [zigate] Encoded Msg to send b'010210180210021118021103' 2019-05-13 20:43:38 DEBUG (SyncWorker_7) [zigate] Waiting for status message for command 0x0018 2019-05-13 20:43:41 WARNING (SyncWorker_7) [zigate] No response after command 0x0018 (7) 2019-05-13 20:43:41 DEBUG (SyncWorker_7) [zigate] REQUEST : 0x0010 2019-05-13 20:43:41 DEBUG (SyncWorker_7) [zigate] Msg to send b'0010000010' 2019-05-13 20:43:41 DEBUG (SyncWorker_7) [zigate] Encoded Msg to send b'01021010021002101003' 2019-05-13 20:43:41 DEBUG (SyncWorker_7) [zigate] Waiting for status message for command 0x0010 2019-05-13 20:43:44 WARNING (SyncWorker_7) [zigate] No response after command 0x0010 (8) 2019-05-13 20:43:44 WARNING (SyncWorker_7) [zigate] Failed to retrieve zigate firmware version 2019-05-13 20:43:44 ERROR (MainThread) [homeassistant.core] Error doing job: Future exception was never retrieved Traceback (most recent call last): File "/usr/local/lib/python3.7/concurrent/futures/thread.py", line 57, in run result = self.fn(*self.args, **self.kwargs) File "/config/custom_components/zigate/init.py", line 344, in start_zigate version = myzigate.get_version_text() File "/config/deps/lib/python3.7/site-packages/zigate/core.py", line 782, in get_version_text v = self.getversion(refresh)['version'] TypeError: 'NoneType' object is not subscriptable

When I call the service "zigate.permit_join" the LED is not blinking and the log is: _2019-05-13 20:49:13 DEBUG (SyncWorker_5) [zigate] REQUEST : 0x0049 FFFC1E00 2019-05-13 20:49:13 DEBUG (SyncWorker_5) [zigate] Msg to send b'0049000450fffc1e00' 2019-05-13 20:49:13 DEBUG (SyncWorker_5) [zigate] Encoded Msg to send b'010210490210021450fffc1e021003' 2019-05-13 20:49:13 DEBUG (SyncWorker_5) [zigate] Waiting for status message for command 0x0049 2019-05-13 20:49:16 WARNING (SyncWorker5) [zigate] No response after command 0x0049 (9)

Should I try to use the curl command you wrote above or the problem is something else? Thanks a lot for your advices.

[doudz]

Yes please , try the curl command

[cobch]

Ok. The following command curl -d ‘{“devices”: [“ttyAMA0”]}’ http://hassio/homeassistant/options returned zsh: no matches found [“ttyAMA0"]}’

[cobch]

What should I try next? Is there some hope that I can make the PiZigate worked with Hassio?

Is there some clues on this discussion we could possibly try? https://community.home-assistant.io/t/deconz-for-hass-io/41165/15

[doudz]

@cobch Please continue discussion here https://github.com/doudz/homeassistant-zigate/issues/49 Because it's not about pairing Trafri

[jalme]

Hi,

Sorry for the very long delay but was not able to dedicate any time to this until yesterday.

Ok this is what worked and it seems fixed. Upgraded to the latest firmware and repaired all plugs. In some cases had to force the pairing process several times but it worked consistently.

I would say the issue is solved in zigate firmware version 3.1a

Regards.