Handle new id in join by AndreasBomholtz · Pull Request #65 · zigpy/bellows

AndreasBomholtz · 2017-10-17T07:29:10Z

If a device changes ID during join we will try to talk to the new ID instead.
I'm trying to handle the issue #44

coveralls · 2017-10-17T07:31:16Z

Coverage decreased (-0.1%) to 99.864% when pulling 1502632 on Seluxit:handle-new-id-in-join into d42d6eb on rcloran:master.

coveralls · 2017-10-17T07:35:02Z

Coverage remained the same at 100.0% when pulling d16abfa on Seluxit:handle-new-id-in-join into d42d6eb on rcloran:master.

coveralls · 2017-10-17T07:36:49Z

Coverage remained the same at 100.0% when pulling d16abfa on Seluxit:handle-new-id-in-join into d42d6eb on rcloran:master.

coveralls · 2017-11-08T13:57:29Z

Coverage remained the same at 100.0% when pulling ea0e3d7 on Seluxit:handle-new-id-in-join into d42d6eb on rcloran:master.

andyzickler · 2017-11-10T01:41:44Z

@AndreasBomholtz Thanks for making the pr! I tested this with an ikea light, I'm now able to get the light to join. However sending commands time out. Tried about 5 times with the same results. I'm not sure if being unable to send a command is out of scope for the issue. Here's a sample output of adding the light, output from devices and trying to turn the light off.

(venv) pi@raspberrypi:~/bellows-dev/bellows $ bellows -v DEBUG permit -D ./app.db
debug: Using selector: EpollSelector
debug: Loading application state from ./app.db
debug: Sending: b'1ac038bc7e'
debug: RSTACK Version: 2 Reason: RESET_SOFTWARE frame: b'c1020b0a527e'
debug: Send command version
debug: Sending: b'004221a850ed2c7e'
debug: Data frame: b'0142a1a8502805e67f627e'
debug: Sending: b'8160597e'
debug: Application frame 0 (version) received
debug: Send command setConfigurationValue
debug: Sending: b'7d314321fb582815c3277e'
debug: Data frame: b'1243a1fb54fb737e'
debug: Sending: b'82503a7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'224021fb592f15226f7e'
debug: Data frame: b'2340a1fb54c6107e'
debug: Sending: b'83401b7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'334121fb792b15a2d77e'
debug: Data frame: b'3441a1fb54d32a7e'
debug: Sending: b'8430fc7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'444621fb7d5e291514417e'
debug: Data frame: b'4546a1fb5435d07e'
debug: Sending: b'8520dd7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'554721fb4d2815713f7e'
debug: Data frame: b'5647a1fb54a9ec7e'
debug: Sending: b'8610be7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'664421fb55d515b18f7e'
debug: Data frame: b'6744a1fb54948f7e'
debug: Sending: b'87009f7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'774521fb4a2b1524a97e'
debug: Data frame: b'7045a1fb5481b57e'
debug: Sending: b'8070787e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'004a21fb629e15b2107e'
debug: Data frame: b'014aa1fb63a4387e'
debug: Sending: b'8160597e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command networkInit
debug: Sending: b'7d314b21bf676c7e'
debug: Data frame: b'124ba5bf5463787e'
debug: Sending: b'82503a7e'
debug: Application frame 23 (networkInit) received
debug: Data frame: b'224bb1b1c450837e'
debug: Sending: b'83401b7e'
debug: Application frame 25 (stackStatusHandler) received
debug: Send command getNetworkParameters
debug: Sending: b'2348218038017e'
debug: Data frame: b'3348a180542ba49b4fd23f94a204afce944127abedce677302c1b4ab7e'
debug: Sending: b'8430fc7e'
debug: Application frame 40 (getNetworkParameters) received
debug: Send command setPolicy
debug: Sending: b'344921fd517a9c837e'
debug: Data frame: b'4449a1fd54e1c97e'
debug: Sending: b'8520dd7e'
debug: Application frame 85 (setPolicy) received
debug: Send command setPolicy
debug: Sending: b'454e21fd524b884a7e'
debug: Data frame: b'554ea1fd541eef7e'
debug: Sending: b'8610be7e'
debug: Application frame 85 (setPolicy) received
debug: Send command setPolicy
debug: Sending: b'564f21fd542b307f7e'
debug: Data frame: b'664fa1fd548a677e'
debug: Sending: b'87009f7e'
debug: Application frame 85 (setPolicy) received
debug: Send command getNodeId
debug: Sending: b'674c218fb1437e'
debug: Data frame: b'774ca18f542ad5747e'
debug: Sending: b'8070787e'
debug: Application frame 39 (getNodeId) received
debug: Send command getEui64
debug: Sending: b'704d218edcd87e'
debug: Data frame: b'004da18ed72b06b959fb47253fe17e'
debug: Sending: b'8160597e'
debug: Application frame 38 (getEui64) received
debug: Send command permitJoining
debug: Sending: b'0152218a4a8f257e'
debug: Data frame: b'1152a18a5443da7e'
debug: Sending: b'82503a7e'
debug: Application frame 34 (permitJoining) received
Joins are permitted for the next 30s...
debug: Data frame: b'2152b18ca2dabc2d7b6ab572a15593499c4e96117e'
debug: Sending: b'83401b7e'
debug: Application frame 36 (trustCenterJoinHandler) received
Device 0xf0f6 (00:0b:57:ff:fe:22:9f:a9) joined the network
[0xf0f6] Discovering endpoints
debug: Send command sendUnicast
debug: Sending: b'7d3353219c54dce5b259914a25aa1593499c4f26a8ec38976d337e'
debug: Data frame: b'3253a19c54c85a997e'
debug: Sending: b'8430fc7e'
debug: Application frame 52 (sendUnicast) received
debug: Data frame: b'4253b19754dce5b259914a25aa1593499cac26cded6cab7e'
debug: Sending: b'8520dd7e'
debug: Application frame 63 (messageSentHandler) received
debug: Data frame: b'5253b18c17babc2d7b6ab572a15593499c4e87047e'
debug: Sending: b'8610be7e'
debug: Application frame 36 (trustCenterJoinHandler) received
Device 0x9043 (00:0b:57:ff:fe:22:9f:a9) joined the network
debug: Device 00:0b:57:ff:fe:22:9f:a9 changed id (0xf0f6 => 0x9043)
debug: Canceling old initialize call
[0x9043] Discovering endpoints
debug: Send command sendUnicast
debug: Sending: b'2650219c546985b259914a25aa1593499c4c25a8ef8df73a547e'
debug: Data frame: b'6253b5cafdb5374ca6c34125c90b7e'
debug: Sending: b'87009f7e'
debug: Application frame 98 (incomingSenderEui64Handler) received
debug: Data frame: b'7253b1ed502a15a159944a2dae5592c763f0643b12316b0abe56ca16de80c0f0e0cd50d1ed7e'
debug: Sending: b'8070787e'
debug: Application frame 69 (incomingMessageHandler) received
debug: [0x9043:zdo] ZDO request 0x0013: [36931, 00:0b:57:ff:fe:22:9f:a9, 142]
debug: Data frame: b'0350a19c54cebea17e'
debug: Sending: b'8160597e'
debug: Application frame 52 (sendUnicast) received
debug: Data frame: b'1350b1f117babc2d7b6ab572a1556df49ccf567e'
debug: Sending: b'82503a7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'2350b1f117babc2d7b6ab572a1556df79cb8067e'
debug: Sending: b'83401b7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'3350b1ed542a15b7d9944a65aa5592c663f0643b12316189fd85f388fd711f7e'
debug: Sending: b'8430fc7e'
debug: Application frame 69 (incomingMessageHandler) received
debug: Data frame: b'4350b197546985b259914a25aa1592499caa25abed72287e'
debug: Sending: b'8520dd7e'
debug: Application frame 63 (messageSentHandler) received
[0x9043] Discovered endpoints: [1]
[0x9043:1] Discovering endpoint information
debug: Send command sendUnicast
debug: Sending: b'3551219c546985b259904a25aa1593499c4d24afee8df78acddb7e'
debug: Data frame: b'5451a19c54cfbc047e'
debug: Sending: b'8610be7e'
debug: Application frame 52 (sendUnicast) received
debug: Data frame: b'6451b1f117babc2d7b6ab572a1556df79c1a887e'
debug: Sending: b'87009f7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'7451b1f117babc2d7b6ab572a1556df79c04897e'
debug: Sending: b'8070787e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'0451b1ed542a15b6d9944a65ab5592d963f3643b12314088fd85f3abfd20ff87e9cfd76f8ffcc7dfd5d7698a462ba9ec753eaeea65864498552633b1e060c0d57e'
debug: Sending: b'8160597e'
debug: Application frame 69 (incomingMessageHandler) received
debug: Data frame: b'1451b197546985b259904a25aa1593499cab24abed21307e'
debug: Sending: b'82503a7e'
debug: Application frame 63 (messageSentHandler) received
[0x9043:1] Discovered endpoint information: <SimpleDescriptor endpoint=1 profile=49246 device_type=544 device_version=2 input_clusters=[0, 3, 4, 5, 6, 8, 768, 2821, 4096] output_clusters=[5, 25, 32, 4096]>
debug: Send command sendUnicast
debug: Sending: b'4256219c546985b259914a25aa1593499c4a23a8e938971c067e'
debug: Data frame: b'2556a19c54cceb8f7e'
debug: Sending: b'83401b7e'
debug: Application frame 52 (sendUnicast) received
debug: Data frame: b'3556b1f117babc2d7b6ab572a1556df79c04f07e'
debug: Sending: b'8430fc7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'4556b1f117babc2d7b6ab572a1556df79c5ef77e'
debug: Sending: b'8520dd7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'5556b1ed542a15b7d9944a65ab5592d863f3643b1231628f7c3093892b297e'
debug: Sending: b'8610be7e'
debug: Application frame 69 (incomingMessageHandler) received
debug: Data frame: b'6556b197546985b259914a25aa1593499ca823abedf9e67e'
debug: Sending: b'87009f7e'
debug: Application frame 63 (messageSentHandler) received
warning: [0x9043] Failed ZDO request during device initialization: ('Endpoint request failed: %s', [129, 61686, []])
Done



(venv) pi@raspberrypi:~/bellows-dev/bellows $ bellows devices -D ./app.db
Device:
  NWK: 0x9043
  IEEE: 00:0b:57:ff:fe:22:9f:a9
  Endpoints:
    1: profile=0xc05e, device_type=DeviceType.COLOR_TEMPERATURE_LIGHT
      Input Clusters:
        Basic (0)
        Identify (3)
        Groups (4)
        Scenes (5)
        On/Off (6)
        Level control (8)
        Color Control (768)
        Diagnostic (2821)
        LightLink (4096)
      Output Clusters:
        Scenes (5)
        Ota (25)
        Poll Control (32)
        LightLink (4096)



(venv) pi@raspberrypi:~/bellows-dev/bellows $ bellows -v DEBUG zcl -D app.db 00:0b:57:ff:fe:22:9f:a9 1 6 command off
debug: Using selector: EpollSelector
debug: Loading application state from app.db
debug: Sending: b'1ac038bc7e'
debug: RSTACK Version: 2 Reason: RESET_SOFTWARE frame: b'c1020b0a527e'
debug: Send command version
debug: Sending: b'004221a850ed2c7e'
debug: Data frame: b'0142a1a8502805e67f627e'
debug: Sending: b'8160597e'
debug: Application frame 0 (version) received
debug: Send command setConfigurationValue
debug: Sending: b'7d314321fb582815c3277e'
debug: Data frame: b'1243a1fb54fb737e'
debug: Sending: b'82503a7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'224021fb592f15226f7e'
debug: Data frame: b'2340a1fb54c6107e'
debug: Sending: b'83401b7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'334121fb792b15a2d77e'
debug: Data frame: b'3441a1fb54d32a7e'
debug: Sending: b'8430fc7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'444621fb7d5e291514417e'
debug: Data frame: b'4546a1fb5435d07e'
debug: Sending: b'8520dd7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'554721fb4d2815713f7e'
debug: Data frame: b'5647a1fb54a9ec7e'
debug: Sending: b'8610be7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'664421fb55d515b18f7e'
debug: Data frame: b'6744a1fb54948f7e'
debug: Sending: b'87009f7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'774521fb4a2b1524a97e'
debug: Data frame: b'7045a1fb5481b57e'
debug: Sending: b'8070787e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'004a21fb629e15b2107e'
debug: Data frame: b'014aa1fb63a4387e'
debug: Sending: b'8160597e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command networkInit
debug: Sending: b'7d314b21bf676c7e'
debug: Data frame: b'124ba5bf5463787e'
debug: Sending: b'82503a7e'
debug: Application frame 23 (networkInit) received
debug: Data frame: b'224bb1b1c450837e'
debug: Sending: b'83401b7e'
debug: Application frame 25 (stackStatusHandler) received
debug: Send command getNetworkParameters
debug: Sending: b'2348218038017e'
debug: Data frame: b'3348a180542ba49b4fd23f94a204afce944127abedce677302c1b4ab7e'
debug: Sending: b'8430fc7e'
debug: Application frame 40 (getNetworkParameters) received
debug: Send command setPolicy
debug: Sending: b'344921fd517a9c837e'
debug: Data frame: b'4449a1fd54e1c97e'
debug: Sending: b'8520dd7e'
debug: Application frame 85 (setPolicy) received
debug: Send command setPolicy
debug: Sending: b'454e21fd524b884a7e'
debug: Data frame: b'554ea1fd541eef7e'
debug: Sending: b'8610be7e'
debug: Application frame 85 (setPolicy) received
debug: Send command setPolicy
debug: Sending: b'564f21fd542b307f7e'
debug: Data frame: b'664fa1fd548a677e'
debug: Sending: b'87009f7e'
debug: Application frame 85 (setPolicy) received
debug: Send command getNodeId
debug: Sending: b'674c218fb1437e'
debug: Data frame: b'774ca18f542ad5747e'
debug: Sending: b'8070787e'
debug: Application frame 39 (getNodeId) received
debug: Send command getEui64
debug: Sending: b'704d218edcd87e'
debug: Data frame: b'004da18ed72b06b959fb47253fe17e'
debug: Sending: b'8160597e'
debug: Application frame 38 (getEui64) received
debug: Send command sendUnicast
debug: Sending: b'0152219c546985ec99924a24ab1593499c4f26a8eccf676df57e'
debug: Data frame: b'1152a19c542527a37e'
debug: Sending: b'82503a7e'
debug: Application frame 52 (sendUnicast) received
debug: Data frame: b'2152b1f117babc2d7b6ab572a1556df79cd9ab7e'
debug: Sending: b'83401b7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'3152b197546985ec99924a24ab1592499c4126abed9aeb7e'
debug: Sending: b'8430fc7e'
debug: Application frame 63 (messageSentHandler) received
debug: Data frame: b'4152b1ed502a15b459944a2dab5592db63f3643b12316e8a00396788fd673fa74c737e'
debug: Sending: b'8520dd7e'
debug: Application frame 69 (incomingMessageHandler) received
debug: [0x9043:zdo] ZDO request 0x0006: [65533, 260, [25], []]
debug: Send command sendUnicast
debug: Sending: b'1553219c546985b25992ca25aa1593499c4c25adefce678bfcc70ed67e'
debug: Data frame: b'5253a19c543acadc7e'
debug: Sending: b'8610be7e'
debug: Application frame 52 (sendUnicast) received
debug: Data frame: b'6253b1f117babc2d7b6ab572a1556df49c6dfe7e'
debug: Sending: b'87009f7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'7253b197546985b25992ca25aa1593499c5e25abed1b957e'
debug: Sending: b'8070787e'
debug: Application frame 63 (messageSentHandler) received
warning: Unexpected message send notification
debug: Data frame: b'0253b1f117babc2d7b6ab572a1556df49c29f87e'
debug: Sending: b'8160597e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'1253b1ed542e14ab59954b65aa5592da63f0643b1231698afdc762f5ed7f1dd59eeccc6e8f5b057e'
debug: Sending: b'82503a7e'
debug: Application frame 69 (incomingMessageHandler) received
debug: [0x9043:1:0x0019] ZCL request 0x0101: [1, 4476, 8705, 304182642, 1]
debug: [0x9043:1:0x0019] No handler for cluster command 1
debug: Data frame: b'2253b1f117babc2d7b6ab572a1556df79c40a97e'
debug: Sending: b'83401b7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'3253b1ed542e14ab59954b65aa5592dd63f3643b1231698afcc762f5ed7f1dd59eeccc6e8f2b057e'
debug: Sending: b'8430fc7e'
debug: Application frame 69 (incomingMessageHandler) received
debug: [0x9043:1:0x0019] ZCL request 0x0101: [1, 4476, 8705, 304182642, 1]
debug: [0x9043:1:0x0019] No handler for cluster command 1
debug: Data frame: b'4253b1f117babc2d7b6ab572a1556df49c51fc7e'
debug: Sending: b'8520dd7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'5253b1ed542e14ab59954b65aa5592dc63f3643b1231698affc762f5ed7f1dd59eeccc6e8f06d97e'
debug: Sending: b'8610be7e'
debug: Application frame 69 (incomingMessageHandler) received
debug: [0x9043:1:0x0019] ZCL request 0x0101: [1, 4476, 8705, 304182642, 1]
debug: [0x9043:1:0x0019] No handler for cluster command 1
Traceback (most recent call last):
  File "/home/pi/bellows-dev/venv/bin/bellows", line 11, in <module>
    load_entry_point('bellows', 'console_scripts', 'bellows')()
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 722, in __call__
    return self.main(*args, **kwargs)
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 697, in main
    rv = self.invoke(ctx)
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 1066, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 1066, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 895, in invoke
    return ctx.invoke(self.callback, **ctx.params)
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 535, in invoke
    return callback(*args, **kwargs)
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/decorators.py", line 17, in new_func
    return f(get_current_context(), *args, **kwargs)
  File "/home/pi/bellows-dev/bellows/bellows/cli/util.py", line 72, in inner
    loop.run_until_complete(async_inner(*args, **kwargs))
  File "/usr/lib/python3.5/asyncio/base_events.py", line 466, in run_until_complete
    return future.result()
  File "/usr/lib/python3.5/asyncio/futures.py", line 293, in result
    raise self._exception
  File "/usr/lib/python3.5/asyncio/tasks.py", line 239, in _step
    result = coro.send(None)
  File "/home/pi/bellows-dev/bellows/bellows/cli/util.py", line 59, in async_inner
    yield from f(ctx, *args, **kwargs)
  File "/home/pi/bellows-dev/bellows/bellows/cli/application.py", line 306, in command
    v = yield from getattr(cluster, command)(*parameters)
  File "/home/pi/bellows-dev/bellows/bellows/zigbee/application.py", line 288, in request
    v = yield from asyncio.wait_for(reply_fut, timeout)
  File "/usr/lib/python3.5/asyncio/tasks.py", line 404, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError

AndreasBomholtz · 2017-11-10T07:17:15Z

@andyzickler Can you try to read some attributes from the basic cluster? (eg. use read_attributes).
Just want to see if that also fails in the same way...

andyzickler · 2017-11-10T17:24:16Z

Reading attributes is also resulting in a timeout error.

(venv) pi@raspberrypi:~/bellows-dev/bellows $ bellows -v DEBUG zcl -D app.db 00:0b:57:ff:fe:22:9f:a9 1 0 read_attribute 0
debug: Using selector: EpollSelector
debug: Loading application state from app.db
debug: Sending: b'1ac038bc7e'
debug: RSTACK Version: 2 Reason: RESET_SOFTWARE frame: b'c1020b0a527e'
debug: Send command version
debug: Sending: b'004221a850ed2c7e'
debug: Data frame: b'0142a1a8502805e67f627e'
debug: Sending: b'8160597e'
debug: Application frame 0 (version) received
debug: Send command setConfigurationValue
debug: Sending: b'7d314321fb582815c3277e'
debug: Data frame: b'1243a1fb54fb737e'
debug: Sending: b'82503a7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'224021fb592f15226f7e'
debug: Data frame: b'2340a1fb54c6107e'
debug: Sending: b'83401b7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'334121fb792b15a2d77e'
debug: Data frame: b'3441a1fb54d32a7e'
debug: Sending: b'8430fc7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'444621fb7d5e291514417e'
debug: Data frame: b'4546a1fb5435d07e'
debug: Sending: b'8520dd7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'554721fb4d2815713f7e'
debug: Data frame: b'5647a1fb54a9ec7e'
debug: Sending: b'8610be7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'664421fb55d515b18f7e'
debug: Data frame: b'6744a1fb54948f7e'
debug: Sending: b'87009f7e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'774521fb4a2b1524a97e'
debug: Data frame: b'7045a1fb5481b57e'
debug: Sending: b'8070787e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command setConfigurationValue
debug: Sending: b'004a21fb629e15b2107e'
debug: Data frame: b'014aa1fb63a4387e'
debug: Sending: b'8160597e'
debug: Application frame 83 (setConfigurationValue) received
debug: Send command networkInit
debug: Sending: b'7d314b21bf676c7e'
debug: Data frame: b'124ba5bf5463787e'
debug: Sending: b'82503a7e'
debug: Application frame 23 (networkInit) received
debug: Data frame: b'224bb1b1c450837e'
debug: Sending: b'83401b7e'
debug: Application frame 25 (stackStatusHandler) received
debug: Send command getNetworkParameters
debug: Sending: b'2348218038017e'
debug: Data frame: b'3348a180542ba49b4fd23f94a204afce944127abedce677302c1b4ab7e'
debug: Sending: b'8430fc7e'
debug: Application frame 40 (getNetworkParameters) received
debug: Send command setPolicy
debug: Sending: b'344921fd517a9c837e'
debug: Data frame: b'4449a1fd54e1c97e'
debug: Sending: b'8520dd7e'
debug: Application frame 85 (setPolicy) received
debug: Send command setPolicy
debug: Sending: b'454e21fd524b884a7e'
debug: Data frame: b'554ea1fd541eef7e'
debug: Sending: b'8610be7e'
debug: Application frame 85 (setPolicy) received
debug: Send command setPolicy
debug: Sending: b'564f21fd542b307f7e'
debug: Data frame: b'664fa1fd548a677e'
debug: Sending: b'87009f7e'
debug: Application frame 85 (setPolicy) received
debug: Send command getNodeId
debug: Sending: b'674c218fb1437e'
debug: Data frame: b'774ca18f542ad5747e'
debug: Sending: b'8070787e'
debug: Application frame 39 (getNodeId) received
debug: Send command getEui64
debug: Sending: b'704d218edcd87e'
debug: Data frame: b'004da18ed72b06b959fb47253fe17e'
debug: Sending: b'8160597e'
debug: Application frame 38 (getEui64) received
debug: Send command sendUnicast
debug: Sending: b'0152219c549fc0ec99944a24ab1593499c4f26aeedcf678bfd5caa7e'
debug: Data frame: b'1152a19c543ca4bb7e'
debug: Sending: b'82503a7e'
debug: Application frame 52 (sendUnicast) received
debug: Data frame: b'2152b1f1e1ffbc2d7b6ab572a1556dfa9c27d17e'
debug: Sending: b'83401b7e'
debug: Application frame 89 (incomingRouteRecordHandler) received
debug: Data frame: b'3152b197549fc0ec99944a24ab1592499c5826abed47be7e'
debug: Sending: b'8430fc7e'
debug: Application frame 63 (messageSentHandler) received
Traceback (most recent call last):
  File "/home/pi/bellows-dev/venv/bin/bellows", line 11, in <module>
    load_entry_point('bellows', 'console_scripts', 'bellows')()
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 722, in __call__
    return self.main(*args, **kwargs)
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 697, in main
    rv = self.invoke(ctx)
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 1066, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 1066, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 895, in invoke
    return ctx.invoke(self.callback, **ctx.params)
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/core.py", line 535, in invoke
    return callback(*args, **kwargs)
  File "/home/pi/bellows-dev/venv/lib/python3.5/site-packages/click/decorators.py", line 17, in new_func
    return f(get_current_context(), *args, **kwargs)
  File "/home/pi/bellows-dev/bellows/bellows/cli/util.py", line 72, in inner
    loop.run_until_complete(async_inner(*args, **kwargs))
  File "/usr/lib/python3.5/asyncio/base_events.py", line 466, in run_until_complete
    return future.result()
  File "/usr/lib/python3.5/asyncio/futures.py", line 293, in result
    raise self._exception
  File "/usr/lib/python3.5/asyncio/tasks.py", line 239, in _step
    result = coro.send(None)
  File "/home/pi/bellows-dev/bellows/bellows/cli/util.py", line 59, in async_inner
    yield from f(ctx, *args, **kwargs)
  File "/home/pi/bellows-dev/bellows/bellows/cli/application.py", line 241, in read_attribute
    v = yield from cluster.read_attributes([attribute], allow_cache=False)
  File "/home/pi/bellows-dev/bellows/bellows/zigbee/zcl/__init__.py", line 192, in read_attributes
    result = yield from self.read_attributes_raw(to_read)
  File "/home/pi/bellows-dev/bellows/bellows/zigbee/zcl/__init__.py", line 159, in read_attributes_raw
    v = yield from self.request(True, 0x00, schema, attributes)
  File "/home/pi/bellows-dev/bellows/bellows/zigbee/application.py", line 288, in request
    v = yield from asyncio.wait_for(reply_fut, timeout)
  File "/usr/lib/python3.5/asyncio/tasks.py", line 404, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError

coveralls · 2018-01-15T07:43:01Z

Coverage remained the same at 100.0% when pulling 8bd9fb7 on Seluxit:handle-new-id-in-join into e828ae8 on rcloran:master.

coveralls · 2018-01-15T19:37:35Z

Coverage remained the same at 100.0% when pulling 1e8c6a5 on Seluxit:handle-new-id-in-join into 655bb3e on rcloran:master.

AndreasBomholtz added 2 commits October 6, 2017 14:32

Handle that the device is switching ID

02eff7f

Cancel old request

1502632

AndreasBomholtz and others added 2 commits October 17, 2017 09:33

Forgot test case

7fbef10

Merge branch 'master' into handle-new-id-in-join

d16abfa

perosb mentioned this pull request Nov 7, 2017

Failed ZDO request during device initialization for Ikea bulb #44

Closed

Also send the event when the device changes id

ea0e3d7

dmulcahey mentioned this pull request Dec 30, 2017

Persisting new network addressed #83

Closed

Merge branch 'master' into handle-new-id-in-join

8bd9fb7

Merge branch 'master' into handle-new-id-in-join

1e8c6a5

rcloran merged commit 4cf1237 into zigpy:master Jan 15, 2018

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

Handle new id in join#65

Handle new id in join#65
rcloran merged 7 commits intozigpy:masterfrom
Seluxit:handle-new-id-in-join

AndreasBomholtz commented Oct 17, 2017

Uh oh!

coveralls commented Oct 17, 2017 •

edited

Loading

Uh oh!

coveralls commented Oct 17, 2017 •

edited

Loading

Uh oh!

coveralls commented Oct 17, 2017 •

edited

Loading

Uh oh!

coveralls commented Nov 8, 2017 •

edited

Loading

Uh oh!

andyzickler commented Nov 10, 2017 •

edited

Loading

Uh oh!

AndreasBomholtz commented Nov 10, 2017

Uh oh!

andyzickler commented Nov 10, 2017

Uh oh!

coveralls commented Jan 15, 2018 •

edited

Loading

Uh oh!

coveralls commented Jan 15, 2018 •

edited

Loading

Uh oh!

Reviewers

Assignees

Labels

Projects

Milestone

Development

Uh oh!

4 participants

Conversation

AndreasBomholtz commented Oct 17, 2017

Uh oh!

coveralls commented Oct 17, 2017 • edited Loading Uh oh! There was an error while loading. Please reload this page.

Uh oh!

Uh oh!

coveralls commented Oct 17, 2017 • edited Loading Uh oh! There was an error while loading. Please reload this page.

Uh oh!

Uh oh!

coveralls commented Oct 17, 2017 • edited Loading Uh oh! There was an error while loading. Please reload this page.

Uh oh!

Uh oh!

coveralls commented Nov 8, 2017 • edited Loading Uh oh! There was an error while loading. Please reload this page.

Uh oh!

Uh oh!

andyzickler commented Nov 10, 2017 • edited Loading Uh oh! There was an error while loading. Please reload this page.

Uh oh!

Uh oh!

AndreasBomholtz commented Nov 10, 2017

Uh oh!

andyzickler commented Nov 10, 2017

Uh oh!

coveralls commented Jan 15, 2018 • edited Loading Uh oh! There was an error while loading. Please reload this page.

Uh oh!

Uh oh!

coveralls commented Jan 15, 2018 • edited Loading Uh oh! There was an error while loading. Please reload this page.

Uh oh!

Uh oh!

Reviewers

Assignees

Labels

Projects

Milestone

Development

Uh oh!

4 participants

coveralls commented Oct 17, 2017 •

edited

Loading

coveralls commented Oct 17, 2017 •

edited

Loading

coveralls commented Oct 17, 2017 •

edited

Loading

coveralls commented Nov 8, 2017 •

edited

Loading

andyzickler commented Nov 10, 2017 •

edited

Loading

coveralls commented Jan 15, 2018 •

edited

Loading

coveralls commented Jan 15, 2018 •

edited

Loading