How to debug devices having troubles communicating...

[Vincentoo]

Hi,

Today my Fibaro smoke sensor just died unexpectedly.
I presume the battery is dead (after 5-6 months ). I was wondering if this could be due to a bad communication with the Razberry controller (many retries?) as the device is located a bit further compared to other sensors (one floor down also).

Is there a way to check/see that a device is having troubles communicating, looking at the logs for instance?
From what I saw, it always woke up on time (most of the time) in the past.

V.

[pofs]

I believe all Fibaro devices have range test function, try it first.
Also check the Routing Table page. Multiple retransmissions may result in shortened battery life. Probably you'll need to update routes.

[Vincentoo]

Again battery dead
It is really weird... Looking at the logs, sometimes it seems there are a lot of (too many?) messages for a single wake up e.g.

Any idea what could be the issue?

Regards.

V.

Code: Select all

[2014-10-07 11:00:45.425] RECEIVED: ( 01 08 00 04 00 05 02 84 07 77 )
[2014-10-07 11:00:45.425] SENT ACK
[2014-10-07 11:00:45.425] SETDATA devices.5.data.lastReceived = 0 (0x00000000)
[2014-10-07 11:00:45.426] Node 5:0 CC Wakeup: Wakeup notification
[2014-10-07 11:00:45.426] SETDATA devices.5.instances.0.commandClasses.132.data.lastWakeup = 1412672445 (0x5433abbd)
[2014-10-07 11:00:45.426] SETDATA devices.5.data.isAwake = True
[2014-10-07 11:00:45.426] SETDATA devices.5.data.lastSend = 457253477 (0x1b412265)
[2014-10-07 11:00:45.426] SETDATA devices.5.data.lastNonceGet = 457252477 (0x1b411e7d)
[2014-10-07 11:00:45.427] Running wakeup handler for node 5
[2014-10-07 11:00:45.427] Job 0x13 (Wakeup Sleep): Cancelling job: Wakeup Sleep
[2014-10-07 11:00:45.427] Removing job: Wakeup Sleep
[2014-10-07 11:00:45.427] SETDATA devices.5.instances.0.commandClasses.132.data.lastSleep = 1412672445 (0x5433abbd)
[2014-10-07 11:00:45.427] Node 5:0 CC Wakeup: Send node to sleep
[2014-10-07 11:00:45.427] Adding job: Wakeup Sleep
[2014-10-07 11:00:45.494] RECEIVED: ( 01 08 00 04 00 05 02 84 07 77 )
[2014-10-07 11:00:45.495] SENT ACK
[2014-10-07 11:00:45.495] SETDATA devices.5.data.lastReceived = 0 (0x00000000)
[2014-10-07 11:00:45.495] Node 5:0 CC Wakeup: Wakeup notification
[2014-10-07 11:00:45.495] SETDATA devices.5.instances.0.commandClasses.132.data.lastWakeup = 1412672445 (0x5433abbd)
[2014-10-07 11:00:45.495] SETDATA devices.5.data.isAwake = True
[2014-10-07 11:00:45.495] SETDATA devices.5.data.lastSend = 457253483 (0x1b41226b)
[2014-10-07 11:00:45.496] SETDATA devices.5.data.lastNonceGet = 457252483 (0x1b411e83)
[2014-10-07 11:00:45.496] Running wakeup handler for node 5
[2014-10-07 11:00:45.496] SETDATA devices.5.instances.0.commandClasses.132.data.lastSleep = 1412672445 (0x5433abbd)
[2014-10-07 11:00:45.496] Node 5:0 CC Wakeup: Send node to sleep
[2014-10-07 11:00:45.497] Job 0x13 (Wakeup Sleep): removing duplicate
[2014-10-07 11:00:45.564] SENDING (cb 0xdf): ( 01 09 00 13 05 02 84 08 05 DF B4 )
[2014-10-07 11:00:45.575] RECEIVED ACK
[2014-10-07 11:00:45.586] RECEIVED: ( 01 04 01 13 01 E8 )
[2014-10-07 11:00:45.586] SENT ACK
[2014-10-07 11:00:45.586] Delivered to Z-Wave stack
[2014-10-07 11:00:46.559] RECEIVED: ( 01 08 00 04 00 05 02 84 07 77 )
[2014-10-07 11:00:46.560] SENT ACK
[2014-10-07 11:00:46.560] SETDATA devices.5.data.lastReceived = 0 (0x00000000)
[2014-10-07 11:00:46.560] Node 5:0 CC Wakeup: Wakeup notification
[2014-10-07 11:00:46.560] SETDATA devices.5.instances.0.commandClasses.132.data.lastWakeup = 1412672446 (0x5433abbe)
[2014-10-07 11:00:46.560] SETDATA devices.5.data.isAwake = True
[2014-10-07 11:00:46.561] SETDATA devices.5.data.lastSend = 457253577 (0x1b4122c9)
[2014-10-07 11:00:46.561] SETDATA devices.5.data.lastNonceGet = 457252577 (0x1b411ee1)
[2014-10-07 11:00:46.561] Running wakeup handler for node 5
[2014-10-07 11:00:46.561] SETDATA devices.5.instances.0.commandClasses.132.data.lastSleep = 1412672446 (0x5433abbe)
[2014-10-07 11:00:46.561] Node 5:0 CC Wakeup: Send node to sleep
[2014-10-07 11:00:46.562] Adding job: Wakeup Sleep
[2014-10-07 11:00:46.819] RECEIVED: ( 01 08 00 04 00 05 02 84 07 77 )
[2014-10-07 11:00:46.819] SENT ACK
[2014-10-07 11:00:46.820] SETDATA devices.5.data.lastReceived = 0 (0x00000000)
[2014-10-07 11:00:46.820] Node 5:0 CC Wakeup: Wakeup notification
[2014-10-07 11:00:46.820] SETDATA devices.5.instances.0.commandClasses.132.data.lastWakeup = 1412672446 (0x5433abbe)
[2014-10-07 11:00:46.820] SETDATA devices.5.data.isAwake = True
[2014-10-07 11:00:46.820] SETDATA devices.5.data.lastSend = 457253600 (0x1b4122e0)
[2014-10-07 11:00:46.820] SETDATA devices.5.data.lastNonceGet = 457252600 (0x1b411ef8)
[2014-10-07 11:00:46.821] Running wakeup handler for node 5
[2014-10-07 11:00:46.821] SETDATA devices.5.instances.0.commandClasses.132.data.lastSleep = 1412672446 (0x5433abbe)
[2014-10-07 11:00:46.821] Node 5:0 CC Wakeup: Send node to sleep
[2014-10-07 11:00:46.821] Job 0x13 (Wakeup Sleep): removing duplicate
[2014-10-07 11:00:47.012] RECEIVED: ( 01 08 00 04 00 05 02 84 07 77 )
[2014-10-07 11:00:47.012] SENT ACK
[2014-10-07 11:00:47.012] SETDATA devices.5.data.lastReceived = 0 (0x00000000)
[2014-10-07 11:00:47.012] Node 5:0 CC Wakeup: Wakeup notification
[2014-10-07 11:00:47.013] SETDATA devices.5.instances.0.commandClasses.132.data.lastWakeup = 1412672447 (0x5433abbf)
[2014-10-07 11:00:47.013] SETDATA devices.5.data.isAwake = True
[2014-10-07 11:00:47.013] SETDATA devices.5.data.lastSend = 457253617 (0x1b4122f1)
[2014-10-07 11:00:47.014] SETDATA devices.5.data.lastNonceGet = 457252617 (0x1b411f09)
[2014-10-07 11:00:47.014] Running wakeup handler for node 5
[2014-10-07 11:00:47.014] SETDATA devices.5.instances.0.commandClasses.132.data.lastSleep = 1412672447 (0x5433abbf)
[2014-10-07 11:00:47.014] Node 5:0 CC Wakeup: Send node to sleep
[2014-10-07 11:00:47.014] Job 0x13 (Wakeup Sleep): removing duplicate
[2014-10-07 11:00:47.201] RECEIVED: ( 01 05 00 13 DF 01 37 )
[2014-10-07 11:00:47.202] SENT ACK
[2014-10-07 11:00:47.202] Job 0x13 (Wakeup Sleep): Not delivered to recipient
[2014-10-07 11:00:47.202] SETDATA devices.5.data.lastPacketInfo.delivered = False
[2014-10-07 11:00:47.202] SETDATA devices.5.data.lastPacketInfo.packetLength = 5 (0x00000005)
[2014-10-07 11:00:47.202] SETDATA devices.5.data.lastPacketInfo.deliveryTime = 1616 (0x00000650)
[2014-10-07 11:00:47.203] SETDATA devices.5.data.lastPacketInfo = **********
[2014-10-07 11:00:47.203] SETDATA devices.5.data.isAwake = False
[2014-10-07 11:00:47.203] Sending the queue for node 5 into sleep