node-zwave-js icon indicating copy to clipboard operation
node-zwave-js copied to clipboard

Pairing issues- Devices going dead while pairing

Open mohanblaze opened this issue 1 year ago • 11 comments

Hi Robert,

I am using the chip ZGM130S as the controller for the zwave devices to pair and control. While in the pairing process, I am facing issues.

When I trigger the device after initiating the pairing from zwaveJs-UI, I see that the device addition fails(node is dead) within the range of 1 meter. This issue is happening with all devices, i.e., Power, Battery, and FLIRS.

I also see that re-interviewing or refreshing is helping to fetch the device info, but I need to perform it a couple or more times.

I do not know if there's any issue in the zwaveJS UI or with the setting of tx power but I am encountering this issue very frequently. I am attaching the setting.json file for reference and the controller options screenshot. Let me know, what else is needed to study this issue and to provide us a solution.

Thank you.

Regards, Mohan Krishna

settings.json Screenshot from 2024-01-04 13-04-42

mohanblaze avatar Jan 04 '24 07:01 mohanblaze

Please make a driver log, loglevel debug and attach it here as a file (drag & drop into the text field).

robertsLando avatar Jan 04 '24 08:01 robertsLando

Hi Robert,

Thanks for your immediate response.

Please find the attached driver_log(loglevel=debug) and settings.json for your reference.

You can determine the device RSSI after we re-interview and tapped the device again, and the device is approximately 1 meter away. Help me to understand and resolve the issue.

Regards, Mohan Krishna

settings.json zwavejs_2024-01-04.log

mohanblaze avatar Jan 04 '24 10:01 mohanblaze

@AlCalzone any clue what could cause this?

2024-01-04T09:57:43.042Z CNTRLR   finished adding node 2:
                                    basic device class:    Routing Slave
                                    generic device class:  Thermostat
                                    specific device class: General Thermostat V2
                                    supported CCs: 
                                    · Basic (0x20)
                                    · Manufacturer Specific (0x72)
                                    · Thermostat Mode (0x40)
                                    · Thermostat Setpoint (0x43)
                                    · Version (0x86)
                                    · Z-Wave Plus Info (0x5e)
                                    · Thermostat Fan Mode (0x44)
                                    · Multilevel Sensor (0x31)
                                    · Association (0x85)
                                    · Configuration (0x70)
                                    · Association Group Information (0x59)
                                    · Transport Service (0x55)
                                    · Device Reset Locally (0x5a)
                                    · Powerlevel (0x73)
                                    · Security (0x98)
                                    · Security 2 (0x9f)
                                    · Supervision (0x6c)
                                    · Firmware Update Meta Data (0x7a)
                                    controlled CCs: 
2024-01-04T09:57:43.046Z CNTRLR » [Node 002] Assigning SUC return route...
2024-01-04T09:57:43.047Z CNTRLR » [Node 002] Deleting SUC return route...
2024-01-04T09:57:43.060Z SERIAL » 0x01060055000205ab                                                   (8 bytes)
2024-01-04T09:57:43.062Z DRIVER » [Node 002] [REQ] [DeleteSUCReturnRoute]
                                    payload: 0x000205
2024-01-04T09:57:43.083Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:57:43.086Z SERIAL « 0x0104015501ae                                                       (6 bytes)
2024-01-04T09:57:43.088Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:43.090Z DRIVER « [RES] [DeleteSUCReturnRoute]
                                    was executed: true
2024-01-04T09:57:43.124Z SERIAL « 0x01210055050139000000007f7f7f7f7f00010400000000020300007f7f7f7f7f0 (35 bytes)
                                  000b2
2024-01-04T09:57:43.126Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:43.128Z DRIVER « [REQ] [DeleteSUCReturnRoute]
                                    callback id:     5
                                    transmit status: NoAck
2024-01-04T09:57:43.142Z SERIAL » 0x01060051000206ac                                                   (8 bytes)
2024-01-04T09:57:43.144Z DRIVER » [Node 002] [REQ] [AssignSUCReturnRoute]
                                    payload: 0x000206
2024-01-04T09:57:43.147Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:57:43.150Z SERIAL « 0x0104015101aa                                                       (6 bytes)
2024-01-04T09:57:43.152Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:43.154Z DRIVER « [RES] [AssignSUCReturnRoute]
                                    was executed: true
2024-01-04T09:57:43.231Z SERIAL « 0x01210051060151000000007f7f7f7f7f00010600000000020300007f7f7f7f7f0 (35 bytes)
                                  000df
2024-01-04T09:57:43.233Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:43.236Z DRIVER « [REQ] [AssignSUCReturnRoute]
                                    callback id:     6
                                    transmit status: NoAck
2024-01-04T09:57:43.455Z SERIAL » 0x011000a900010002029f04250000000007fe                              (18 bytes)
2024-01-04T09:57:43.459Z DRIVER » [Node 002] [REQ] [SendDataBridge]
                                  │ source node id:   1
                                  │ transmit options: 0x25
                                  │ callback id:      7
                                  └─[Security2CCKEXGet]
2024-01-04T09:57:43.474Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:57:43.476Z SERIAL « 0x010401a90152                                                       (6 bytes)
2024-01-04T09:57:43.478Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:43.481Z DRIVER « [RES] [SendDataBridge]
                                    was sent: true
2024-01-04T09:57:47.645Z SERIAL « 0x011d00a90701019c007f7f7f7f7f00010700000000020400000000000000af    (31 bytes)
2024-01-04T09:57:47.658Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:47.672Z DRIVER « [REQ] [SendDataBridge]
                                    callback id:            7
                                    transmit status:        NoAck, took 4120 ms
                                    routing attempts:       4
                                    protocol & route speed: Z-Wave, 40 kbit/s
                                    routing scheme:         Explorer Frame
                                    TX channel no.:         1
                                    TX power:               0 dBm
                                    measured noise floor:   0 dBm
2024-01-04T09:57:47.681Z SERIAL » 0x011000a900010002029f04250000000007fe                              (18 bytes)
2024-01-04T09:57:47.682Z DRIVER » [Node 002] [REQ] [SendDataBridge]
                                  │ source node id:   1
                                  │ transmit options: 0x25
                                  │ callback id:      7
                                  └─[Security2CCKEXGet]
2024-01-04T09:57:47.685Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:57:47.689Z SERIAL « 0x010401a90152                                                       (6 bytes)
2024-01-04T09:57:47.690Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:47.692Z DRIVER « [RES] [SendDataBridge]
                                    was sent: true
2024-01-04T09:57:51.846Z SERIAL « 0x011d00a907010199007f7f7f7f7f00010700000000020400000000000000aa    (31 bytes)
2024-01-04T09:57:51.855Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:51.865Z DRIVER « [REQ] [SendDataBridge]
                                    callback id:            7
                                    transmit status:        NoAck, took 4090 ms
                                    routing attempts:       4
                                    protocol & route speed: Z-Wave, 40 kbit/s
                                    routing scheme:         Explorer Frame
                                    TX channel no.:         1
                                    TX power:               0 dBm
                                    measured noise floor:   0 dBm
2024-01-04T09:57:51.876Z SERIAL » 0x011000a900010002029f04250000000007fe                              (18 bytes)
2024-01-04T09:57:51.877Z DRIVER » [Node 002] [REQ] [SendDataBridge]
                                  │ source node id:   1
                                  │ transmit options: 0x25
                                  │ callback id:      7
                                  └─[Security2CCKEXGet]
2024-01-04T09:57:51.880Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:57:51.884Z SERIAL « 0x010401a90152                                                       (6 bytes)
2024-01-04T09:57:51.885Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:51.887Z DRIVER « [RES] [SendDataBridge]
                                    was sent: true
2024-01-04T09:57:56.017Z SERIAL « 0x011d00a907010197007f7f7f7f7f00010700000000020400000000000000a4    (31 bytes)
2024-01-04T09:57:56.027Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:56.035Z DRIVER « [REQ] [SendDataBridge]
                                    callback id:            7
                                    transmit status:        NoAck, took 4070 ms
                                    routing attempts:       4
                                    protocol & route speed: Z-Wave, 40 kbit/s
                                    routing scheme:         Explorer Frame
                                    TX channel no.:         1
                                    TX power:               0 dBm
                                    measured noise floor:   0 dBm
2024-01-04T09:57:56.047Z CNTRLR   [Node 002] The node did not respond after 3 attempts, it is presumed dead
2024-01-04T09:57:56.051Z CNTRLR   [Node 002] Security S2 bootstrapping failed, the node was not granted any S2 s
                                  ecurity class: The node did not acknowledge the command (ZW0204)
2024-01-04T09:57:56.055Z CNTRLR   [Node 002] Beginning interview - last completed stage: None
2024-01-04T09:57:56.056Z CNTRLR   [Node 002] new node, doing a full interview...
2024-01-04T09:57:56.056Z CNTRLR » [Node 002] querying protocol info...
2024-01-04T09:57:56.065Z CNTRLR   [Node 002] [+] [Node Naming and Location] name: "pac03"
2024-01-04T09:57:56.080Z DRIVER       the message was handled
2024-01-04T09:57:56.085Z SERIAL » 0x010500410002b9                                                     (7 bytes)
2024-01-04T09:57:56.086Z DRIVER » [REQ] [GetNodeProtocolInfo]
                                    payload: 0x0002
2024-01-04T09:57:56.098Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:57:56.101Z SERIAL « 0x010a0141d39c0104080600f1                                          (12 bytes)
2024-01-04T09:57:56.102Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:56.104Z DRIVER « [RES] [GetNodeProtocolInfo]
                                    payload: 0xd39c0104080600
2024-01-04T09:57:56.109Z CNTRLR « [Node 002] received response for protocol info:
                                  basic device class:    Routing Slave
                                  generic device class:  Thermostat
                                  specific device class: General Thermostat V2
                                  node type:             End Node
                                  is always listening:   true
                                  is frequent listening: false
                                  can route messages:    true
                                  supports security:     false
                                  supports beaming:      true
                                  maximum data rate:     100000 kbps
                                  protocol version:      3
2024-01-04T09:57:56.121Z CNTRLR   [Node 002] Interview stage completed: ProtocolInfo
2024-01-04T09:57:56.123Z CNTRLR » [Node 002] pinging the node...
2024-01-04T09:57:56.141Z SERIAL » 0x010f00a900010002010025000000000876                                (17 bytes)
2024-01-04T09:57:56.143Z DRIVER » [Node 002] [REQ] [SendDataBridge]
                                  │ source node id:   1
                                  │ transmit options: 0x25
                                  │ callback id:      8
                                  └─[NoOperationCC]
2024-01-04T09:57:56.150Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:57:56.153Z SERIAL « 0x010401a90152                                                       (6 bytes)
2024-01-04T09:57:56.155Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:57:56.157Z DRIVER « [RES] [SendDataBridge]
                                    was sent: true
2024-01-04T09:58:00.294Z SERIAL « 0x011d00a908010198007f7f7f7f7f00010700000000020400000000000000a4    (31 bytes)
2024-01-04T09:58:00.312Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:58:00.322Z DRIVER « [REQ] [SendDataBridge]
                                    callback id:            8
                                    transmit status:        NoAck, took 4080 ms
                                    routing attempts:       4
                                    protocol & route speed: Z-Wave, 40 kbit/s
                                    routing scheme:         Explorer Frame
                                    TX channel no.:         1
                                    TX power:               0 dBm
                                    measured noise floor:   0 dBm
2024-01-04T09:58:00.327Z CNTRLR   [Node 002] The node did not respond after 1 attempts, it is presumed dead
2024-01-04T09:58:00.329Z CNTRLR   [Node 002] ping failed: The node did not acknowledge the command (ZW0204)
2024-01-04T09:58:00.332Z CNTRLR » [Node 002] querying node info...
2024-01-04T09:58:00.335Z CNTRLR » [Node 002] pinging the node...
2024-01-04T09:58:00.345Z SERIAL » 0x010f00a900010002010025000000000977                                (17 bytes)
2024-01-04T09:58:00.346Z DRIVER » [Node 002] [REQ] [SendDataBridge]
                                  │ source node id:   1
                                  │ transmit options: 0x25
                                  │ callback id:      9
                                  └─[NoOperationCC]
2024-01-04T09:58:00.350Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:58:00.354Z SERIAL « 0x010401a90152                                                       (6 bytes)
2024-01-04T09:58:00.355Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:58:00.356Z DRIVER « [RES] [SendDataBridge]
                                    was sent: true
2024-01-04T09:58:04.462Z SERIAL « 0x011d00a909010195007f7f7f7f7f00010700000000020400000000000000a8    (31 bytes)
2024-01-04T09:58:04.472Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:58:04.482Z DRIVER « [REQ] [SendDataBridge]
                                    callback id:            9
                                    transmit status:        NoAck, took 4050 ms
                                    routing attempts:       4
                                    protocol & route speed: Z-Wave, 40 kbit/s
                                    routing scheme:         Explorer Frame
                                    TX channel no.:         1
                                    TX power:               0 dBm
                                    measured noise floor:   0 dBm
2024-01-04T09:58:04.489Z CNTRLR   [Node 002] The node did not respond after 1 attempts, it is presumed dead
2024-01-04T09:58:04.492Z CNTRLR   [Node 002] ping failed: The node did not acknowledge the command (ZW0204)
2024-01-04T09:58:04.494Z CNTRLR   [Node 002] Interview attempt (1/5) failed, node is dead.
2024-01-04T09:58:04.507Z DRIVER   all queues idle
2024-01-04T09:58:04.523Z CNTRLR » [Node 002] querying current thermostat mode...
2024-01-04T09:58:04.526Z CNTRLR » [Node 002] pinging the node...
2024-01-04T09:58:04.578Z DRIVER   all queues busy
2024-01-04T09:58:04.584Z SERIAL » 0x010f00a900010002010025000000000a74                                (17 bytes)
2024-01-04T09:58:04.585Z DRIVER » [Node 002] [REQ] [SendDataBridge]
                                  │ source node id:   1
                                  │ transmit options: 0x25
                                  │ callback id:      10
                                  └─[NoOperationCC]
2024-01-04T09:58:04.589Z SERIAL « [ACK]                                                                   (0x06)
2024-01-04T09:58:04.593Z SERIAL « 0x010401a90152                                                       (6 bytes)
2024-01-04T09:58:04.594Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:58:04.596Z DRIVER « [RES] [SendDataBridge]
                                    was sent: true
2024-01-04T09:58:08.736Z SERIAL « 0x011d00a90a010198007f7f7f7f7f00010700000000020400000000000000a6    (31 bytes)
2024-01-04T09:58:08.751Z SERIAL » [ACK]                                                                   (0x06)
2024-01-04T09:58:08.762Z DRIVER « [REQ] [SendDataBridge]
                                    callback id:            10
                                    transmit status:        NoAck, took 4080 ms
                                    routing attempts:       4
                                    protocol & route speed: Z-Wave, 40 kbit/s
                                    routing scheme:         Explorer Frame
                                    TX channel no.:         1
                                    TX power:               0 dBm
                                    measured noise floor:   0 dBm
2024-01-04T09:58:08.769Z CNTRLR   [Node 002] The node did not respond after 1 attempts, it is presumed dead
2024-01-04T09:58:08.772Z CNTRLR   [Node 002] ping failed: The node did not acknowledge the command (ZW0204)
2024-01-04T09:58:08.774Z CNTRLR   [Node 002] failed to refresh values for Thermostat Mode, endpoint 0: The messa
                                  ge cannot be sent because node 2 is dead (ZW0202)
2024-01-04T09:58:08.779Z DRIVER   all queues idle

robertsLando avatar Jan 04 '24 14:01 robertsLando

Did you change the power values, especially the measured at 0? If so, did someone tell you which values to use?

Which specific controller are you using?

AlCalzone avatar Jan 04 '24 16:01 AlCalzone

Hi @AlCalzone ,

Thanks for your response.

Yes, we updated the values of the measured at 0 to 3.3. PFA screenshot for reference.

And we are using ZGM130S , which is a silabs controller(700 series). Let me know if anything is needed.

Regards, Mohan Krishna

Screenshot from 2024-01-04 13-04-42 Screenshot from 2024-01-05 12-16-40

mohanblaze avatar Jan 05 '24 06:01 mohanblaze

Hi @AlCalzone,

Do you happen to have any updates on the above data? Can you please help us to sort out this?

Regards, Mohan Krishna

mohanblaze avatar Jan 09 '24 05:01 mohanblaze

https://github.com/zwave-js/node-zwave-js/issues/6521

AlCalzone avatar Jan 09 '24 07:01 AlCalzone

One thing that might help is to upgrade the firmware on the Zstick. I see from the picture it is 7.15.4. Might want to read this https://zwave-js.github.io/node-zwave-js/#/troubleshooting/otw-upgrade

Also is the thermostat connected to a C wire for power? It seems to stop responding, almost like a battery device

apella12 avatar Jan 09 '24 21:01 apella12

Hi @apella12,

Thanks for your response.

Yes, the thermostat is connected to a 5v DC input. The issue is not with a single device, and all powered devices are working in the same manner. When the pairing is initiated, we trigger the node info button to release NodeInfo from the device. Thereafter, we noticed the device is paired as dead and once we refresh CC or re-interview the nodeId then it'll pull the info from the device. It just stopped while pairing, as you said like a battery device.

Btw, Is there any problem with the power settings? I used 9.9, 3.3 dbm as the values for the normal power level & measured power at 0 dbm. Help us to resolve this issue.

Regards, Mohan Krishna

mohanblaze avatar Jan 10 '24 11:01 mohanblaze

As this is happening with all devices it could be the controller. I would update the firmware to 7.18.3 That what I am using. As to the power I don't know. I have gotten conflicting advice from mfg, but my 700 is (6, 0) in USA). Your values could be too high.

apella12 avatar Jan 10 '24 16:01 apella12

Unfortunately, the logs can't tell us why there is a connectivity problem with the device, but there is one. A few ideas:

  • The inclusion might (not sure) be happening at 40 kbps and then for normal communication the controller attempts to use 100 kbps, which is channel 0. That channel has a much higher background noise than the others (-87 dBm vs. -108 dBm), so there might be too much noise for reliable communication. Is there another device nearby that could cause this RF noise?
  • I'm still not sure which controller you have (the actual device, not the chip). Most 700 series controllers are indistinguishable from software. Is this a GPIO module or a USB stick? If it's a USB stick, did you put it on an extension cord?
  • Where did you get the values for the power setting from? Wrong values may cause connectivity issues.
  • Are both the controller and the devices using the same RF region (Europe)?

AlCalzone avatar Jan 12 '24 20:01 AlCalzone