openhab / openhab1-addons

Add-ons for openHAB 1.x
Eclipse Public License 2.0
3.43k stars 1.7k forks source link

z-wave binding - setting configuration parameters not only manually #2082

Closed Phil2015 closed 9 years ago

Phil2015 commented 9 years ago

Would be great being able to send configuration parameters to devices (like sendcommand) and not to have the restriction to only change them manually. This would allow to change parameters by rules.

cdjackson commented 9 years ago

This is implemented but needs testing. I'll look to make a test version once the new initialisation code is merged, so this should be available over the coming weekend.

Phil2015 commented 9 years ago

Great!! Looking very much forward to it! Thank you for taking care of this!

cdjackson commented 9 years ago

This is now in the latest HABmin version - feedback welcome.

Example binding string - zwave="11:command=configuration,parameter=5".

Phil2015 commented 9 years ago

Can you explain a bit more how to proceed? Somewhere I might think wrong...

I have made an item as described. But how do I actually send the parameter? When I tried something like "sendCommand(xxxxxxxx,10)" I received the message "given command is NULL, couldn't send command to xxxxxxxxxxx". For example I want to set parameter=5 to value=10.

cdjackson commented 9 years ago

I’m not so sure in a rule - maybe you need to make sure it’s the right item type in the rule?

What I did to test this is to set up a parameter as a dimmer, and put it in the sitemap. Maybe in the rule you need to cast the 10 as a DecimalType?

cdjackson commented 9 years ago

please try the latest version. It should now support the syntax you've used above - previously the converters didn't work correctly for all item types.

Phil2015 commented 9 years ago

please try the latest version.

Unfortunately I can't test it within the next seven days but will do so when I return!

Phil

cdjackson commented 9 years ago

Ok - no worries…

Thanks.

loksbjerre commented 9 years ago

Hi, I am trying to use this feature, but I am not able to make it work. Trying to set parameter 37 for an AEOTEC DSD31 siren, as this would allow me to use the siren for various purposes.

I am using latest vertion of the ZWAVE binding from cloudbees from the 10th of April.

Has it been tested, is it working ?

Regards Lars

cdjackson commented 9 years ago

Has it been tested, is it working ?

Yes - I tested it when I wrote it, but I don’t use it myself.

Maybe you can describe what you’re trying to do, and provide a log?

loksbjerre commented 9 years ago

I am trying to set parameter 37 pf the AEOTEC DSD31 siren, so that I can change the sound depending upon if we are at home or not.

The siren I working, I can switch it on and off.

Here is my item configuration.

Switch Z63_Siren "Sirene [%s]" (ZSMOKE) { zwave="63"}

Dimmer Z63_Sound "Sirene lyd [%d]" (ZSMOKE) { zwave="63:command=configuration,parameter=37"}

I am updating the Z63_Sound parameter via a rule.

                                        sendCommand ( Z63_Sound, Z63_SetSound.state.toString )

where Z63_SetSound is a number between 255 and 259.

When looking at the trace, and activating the above sendCommand, then there is no zwave related entry in the trace.

Also, Parameter 37 cannot be set from habmin, nor from habmin2. Habmin do not allow to enter a value, it stays at 259, and Habmi2 does not show the configuration parameters, but there is an error message in the log

“Malformed domain request in GetConfiguration “undefined”

Regards Lars

From: Chris Jackson [mailto:notifications@github.com] Sent: 10. april 2015 14:36 To: openhab/openhab Cc: loksbjerre Subject: Re: [openhab] z-wave binding - setting configuration parameters not only manually (#2082)

Has it been tested, is it working ?

Yes - I tested it when I wrote it, but I don’t use it myself.

Maybe you can describe what you’re trying to do, and provide a log?

— Reply to this email directly or view it on GitHub https://github.com/openhab/openhab/issues/2082#issuecomment-91539099 . https://github.com/notifications/beacon/AK0nrxEdmydbV3-X6sxo-ev_wyvaRF3xks5n97smgaJpZM4Dbymc.gif

cdjackson commented 9 years ago

What value are you trying to set. Looking at what’s in the database, it seems you’ll need to be careful with the setting or it will ignore the request.

loksbjerre commented 9 years ago

Parameter 37 for Aeotec dsd31

Sendt fra min IPad

On 10 Apr 2015, at 15:00, Chris Jackson notifications@github.com wrote:

What value are you trying to set. Looking at what’s in the database, it seems you’ll need to be careful with the setting or it will ignore the request.

— Reply to this email directly or view it on GitHub.

cdjackson commented 9 years ago

Yes, but what value are you trying to set?

loksbjerre commented 9 years ago

255, 256, 257, 258, and 259 have i tried

Sendt fra min IPad

On 10 Apr 2015, at 15:07, Chris Jackson notifications@github.com wrote:

Yes, but what value are you trying to set? — Reply to this email directly or view it on GitHub.

cdjackson commented 9 years ago

Is that using HABmin or the rule? HABmin should work for some of these values (257/258 and 259 I think ought to work - the others are invalid). I also assume that param 252 is not locked?

For setting this as a rule, the item is set as a dimmer so possibly won’t work for these values (I think the range is 0 to 255, and . It would be worth looking in the debug log if you can send it to me...

loksbjerre commented 9 years ago

Chris,

The other two parameters (80 and 252) can be set via Habmin OK.

I have tried to change the set parameter to a number in the item file, no difference, still does not work.

There is nothing in the debug log regarding node #63 (the siren) when issuing the sendCommand on the dimmer (or number) item..

Regards Lars

From: Chris Jackson [mailto:notifications@github.com] Sent: 10. april 2015 17:31 To: openhab/openhab Cc: loksbjerre Subject: Re: [openhab] z-wave binding - setting configuration parameters not only manually (#2082)

Is that using HABmin or the rule? HABmin should work for some of these values (257/258 and 259 I think ought to work - the others are invalid). I also assume that param 252 is not locked?

For setting this as a rule, the item is set as a dimmer so possibly won’t work for these values (I think the range is 0 to 255, and . It would be worth looking in the debug log if you can send it to me...

— Reply to this email directly or view it on GitHub https://github.com/openhab/openhab/issues/2082#issuecomment-91593354 . https://github.com/notifications/beacon/AK0nr5SNyQIR9HVubwV3THClq33RS08vks5n9-QsgaJpZM4Dbymc.gif

loksbjerre commented 9 years ago

“Is that using HABmin or the rule?”.

It is using the rule, as HABMin does not allow me to change the parameter, although it is displayed. Also HABmin displays the parameter as a combo box, but when clicking the pulldown there is nothing to select, of than the one value already displayed (259)

From: Chris Jackson [mailto:notifications@github.com] Sent: 10. april 2015 17:31 To: openhab/openhab Cc: loksbjerre Subject: Re: [openhab] z-wave binding - setting configuration parameters not only manually (#2082)

Is that using HABmin or the rule? HABmin should work for some of these values (257/258 and 259 I think ought to work - the others are invalid). I also assume that param 252 is not locked?

For setting this as a rule, the item is set as a dimmer so possibly won’t work for these values (I think the range is 0 to 255, and . It would be worth looking in the debug log if you can send it to me...

— Reply to this email directly or view it on GitHub https://github.com/openhab/openhab/issues/2082#issuecomment-91593354 . https://github.com/notifications/beacon/AK0nr5SNyQIR9HVubwV3THClq33RS08vks5n9-QsgaJpZM4Dbymc.gif

cdjackson commented 9 years ago

Also HABmin displays the parameter as a combo box,

Ah- ok, so that’s why HABmin doesn’t allow you to change it - it’s configured as a list, but there’s no list specified. I’ll change this shortly and then you ought to be able to configure it through HABmin…

It’s strange that there’s nothing in the log - can you enable trace logging to see what’s happening - with TRACE logging, there must be something logged when the command is received from OH.

loksbjerre commented 9 years ago

I don’t know what you mean by TRACE, do you mean DEBUG or is there an even more detailed log option called TRACE ?

When I referred to that there was nothing in the log regarding NODE 63 (the siren), that was with DEBUG enabled for the ZWAVE binding.

In the event.log I can see that the item is receiving the value, but nothing in openhab.log

From: Chris Jackson [mailto:notifications@github.com] Sent: 10. april 2015 18:12 To: openhab/openhab Cc: loksbjerre Subject: Re: [openhab] z-wave binding - setting configuration parameters not only manually (#2082)

Also HABmin displays the parameter as a combo box,

Ah- ok, so that’s why HABmin doesn’t allow you to change it - it’s configured as a list, but there’s no list specified. I’ll change this shortly and then you ought to be able to configure it through HABmin…

It’s strange that there’s nothing in the log - can you enable trace logging to see what’s happening - with TRACE logging, there must be something logged when the command is received from OH.

— Reply to this email directly or view it on GitHub https://github.com/openhab/openhab/issues/2082#issuecomment-91604482 . https://github.com/notifications/beacon/AK0nr8_k8R4BRXSBoAxjO0nQxZsw_Ob5ks5n9-3XgaJpZM4Dbymc.gif

cdjackson commented 9 years ago

I don’t know what you mean by TRACE, do you mean DEBUG or is there an even more detailed log option called TRACE ?

Yep - exactly. In the logbook file, change DEBUG to TRACE.

When I referred to that there was nothing in the log regarding NODE 63 (the siren), that was with DEBUG enabled for the ZWAVE binding. Ok - I would have thought there would be some messages - maybe they wouldn’t say the node, as the first thing that happens is the item and state information are fed into the binding, and it gets converted into a zwave parameter. I would have expected something to be logged when this happens if there was an error, but I’m not 100% sure.

loksbjerre commented 9 years ago

Chris,

I have enabled TRACE.

Attached a complete log from start to stop of openhab.

Only thing I did was to send value 257 to parameter 37 of node 63.

I think I saw something when I sent the value 257., hard to say with all this data.

Large log as I have 55 Z-Wave devices.

Regards

From: Chris Jackson [mailto:notifications@github.com] Sent: 10. april 2015 19:00 To: openhab/openhab Cc: loksbjerre Subject: Re: [openhab] z-wave binding - setting configuration parameters not only manually (#2082)

I don’t know what you mean by TRACE, do you mean DEBUG or is there an even more detailed log option called TRACE ?

Yep - exactly. In the logbook file, change DEBUG to TRACE.

When I referred to that there was nothing in the log regarding NODE 63 (the siren), that was with DEBUG enabled for the ZWAVE binding. Ok - I would have thought there would be some messages - maybe they wouldn’t say the node, as the first thing that happens is the item and state information are fed into the binding, and it gets converted into a zwave parameter. I would have expected something to be logged when this happens if there was an error, but I’m not 100% sure.

— Reply to this email directly or https://github.com/openhab/openhab/issues/2082#issuecomment-91621729 view it on GitHub. https://github.com/notifications/beacon/AK0nr078liIAqsRyyFKqqL2ZUopFjj1vks5n9_kegaJpZM4Dbymc.gif

cdjackson commented 9 years ago

Thanks - I’ll take a look.

FYI, this is what I did when I tested this -: Number Test_Dimmer_Max "Max Dimmer [%d]" {zwave="11:command=configuration,parameter=12”}

The above item was then linked to a slider in a sitemap, and when I changed the slider, the value was updated in the configuration on the device. I didn’t use a rule to test it, but it shouldn’t matter…

I don’t think a dimmer item will work well - you’ll probably be limited to numbers from 0 to 100...

cdjackson commented 9 years ago

Ahhh - Github removed your log - can you email it to me direct (chris -at- cd-jackson.com)

loksbjerre commented 9 years ago

cd@jackson.com mailto:cd@jackson.com ?

From: Chris Jackson [mailto:notifications@github.com] Sent: 10. april 2015 21:35 To: openhab/openhab Cc: loksbjerre Subject: Re: [openhab] z-wave binding - setting configuration parameters not only manually (#2082)

Ahhh - Github removed your log - can you email it to me direct (chris -at- cd-jackson.com)

— Reply to this email directly or view it on GitHub https://github.com/openhab/openhab/issues/2082#issuecomment-91660376 . https://github.com/notifications/beacon/AK0nrzx104kda3McjriaPFaRc0N7pelxks5n-B1rgaJpZM4Dbymc.gif

cdjackson commented 9 years ago

No - chris -at- cd-jackson.com

just replace the -at- with @

loksbjerre commented 9 years ago

Hi, did you received the log file ?

Here is an extract of the log after I set the parameter value to 257.

The entry Parm=257 is me using the logInfo function in the rule.

015-04-10 21:18:42.681 [INFO ] [org.openhab.model.script.SIREN] - Parm=257

2015-04-10 21:18:42.755 [TRACE] [.z.internal.ZWaveActiveBinding] - internalReceiveCommand(itemname = Z63_Sound, Command = 257)

2015-04-10 21:18:44.124 [DEBUG] [eController$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 2B 06 31 05 04 22 00 40 88

2015-04-10 21:18:44.124 [TRACE] [o.b.z.i.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 01 0C 00 04 00 2B 06 31 05 04 22 00 40 88

2015-04-10 21:18:44.124 [TRACE] [o.b.z.i.protocol.SerialMessage] - Calculated checksum = 0x88

2015-04-10 21:18:44.124 [TRACE] [o.b.z.i.protocol.SerialMessage] - NODE 255: Checksum matched

2015-04-10 21:18:44.124 [TRACE] [o.b.z.i.protocol.SerialMessage] - NODE 255: Message payload = 00 2B 06 31 05 04 22 00 40

2015-04-10 21:18:44.124 [TRACE] [eController$ZWaveReceiveThread] - Message is valid, sending ACK

2015-04-10 21:18:44.124 [TRACE] [eController$ZWaveReceiveThread] - Response SENT

2015-04-10 21:18:44.124 [DEBUG] [eController$ZWaveReceiveThread] - Receive queue ADD: Length=1

2015-04-10 21:18:44.124 [DEBUG] [b.z.i.protocol.ZWaveController] - Receive queue TAKE: Length=0

2015-04-10 21:18:44.125 [TRACE] [o.b.z.i.protocol.SerialMessage] - Calculated checksum = 0x88

2015-04-10 21:18:44.125 [DEBUG] [o.b.z.i.protocol.SerialMessage] - Assembled message buffer = 01 0C 00 04 00 2B 06 31 05 04 22 00 40 88

2015-04-10 21:18:44.125 [DEBUG] [b.z.i.protocol.ZWaveController] - Process Message = 01 0C 00 04 00 2B 06 31 05 04 22 00 40 88

2015-04-10 21:18:44.125 [DEBUG] [b.z.i.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 2B 06 31 05 04 22 00 40

2015-04-10 21:18:44.125 [TRACE] [b.z.i.protocol.ZWaveController] - Incoming Message type = REQUEST

2015-04-10 21:18:44.125 [TRACE] [ApplicationCommandMessageClass] - Handle Message Application Command Request

2015-04-10 21:18:44.125 [DEBUG] [ApplicationCommandMessageClass] - NODE 43: Application Command Request (ALIVE:DONE)

2015-04-10 21:18:44.125 [DEBUG] [ApplicationCommandMessageClass] - NODE 43: Incoming command class SENSOR_MULTILEVEL

2015-04-10 21:18:44.125 [TRACE] [ApplicationCommandMessageClass] - NODE 43: Found Command Class SENSOR_MULTILEVEL, passing to handleApplicationCommandRequest

2015-04-10 21:18:44.125 [DEBUG] [veMultiLevelSensorCommandClass] - NODE 43: Received Sensor Multi Level Request

2015-04-10 21:18:44.125 [DEBUG] [veMultiLevelSensorCommandClass] - NODE 43: Sensor Multi Level REPORT received

2015-04-10 21:18:44.126 [DEBUG] [veMultiLevelSensorCommandClass] - NODE 43: Sensor Type = Power(4), Scale = 0

2015-04-10 21:18:44.126 [DEBUG] [veMultiLevelSensorCommandClass] - NODE 43: Sensor Value = 6.4

From: Chris Jackson [mailto:notifications@github.com] Sent: 10. april 2015 21:38 To: openhab/openhab Cc: loksbjerre Subject: Re: [openhab] z-wave binding - setting configuration parameters not only manually (#2082)

No - chris -at- cd-jackson.com

just replace the -at- with @

— Reply to this email directly or view it on GitHub https://github.com/openhab/openhab/issues/2082#issuecomment-91661295 . https://github.com/notifications/beacon/AK0nr6K9Jmfx9erB7cCsmOaQzkseRTnDks5n-B4WgaJpZM4Dbymc.gif

cdjackson commented 9 years ago

Yep - got the log… Thanks.

Can you have a look in the main openhab log to see if there are any exceptions around the following time -: 2015-04-10 21:18:42.755 [TRACE] [.z.internal.ZWaveActiveBinding] - internalReceiveCommand(itemname = Z63_Sound, Command = 257) This log shows that we received the command, but I’ve just followed through the program flow and there almost has to be another entry logged, or a message sent to the device, and neither is the case. So, I’m wondering if there’s an exception being thrown sometime very shortly after this message is logged…

If not, then I’ll need to add more debug messages to work out what’s up...

loksbjerre commented 9 years ago

Chris,

I only have two loge, openhab.log – which I sent you and event.log

The even.log has the following entry around that time.

2015-04-10 21:18:42 - Z63_SetSound received command 257

2015-04-10 21:18:42 - Z63_Sound received command 257

2015-04-10 21:18:44 - H17_Fyr_Power state updated to 6.4

2015-04-10 21:18:45 - H17_Fyr_Power state updated to 32.3

2015-04-10 21:18:50 - Z27_Lux state updated to 31

2015-04-10 21:18:51 - Z27_Temp state updated to 24.5

2015-04-10 21:27:45 - AnetteMobile state updated to ON

2015-04-10 21:27:45 - LarsMobile state updated to ON

2015-04-10 21:27:47 - RINCON_000E582D70D401400_mute state updated to

From: Chris Jackson [mailto:notifications@github.com] Sent: 10. april 2015 21:56 To: openhab/openhab Cc: loksbjerre Subject: Re: [openhab] z-wave binding - setting configuration parameters not only manually (#2082)

Yep - got the log… Thanks.

Can you have a look in the main openhab log to see if there are any exceptions around the following time -: 2015-04-10 21:18:42.755 [TRACE] [.z.internal.ZWaveActiveBinding] - internalReceiveCommand(itemname = Z63_Sound, Command = 257) This log shows that we received the command, but I’ve just followed through the program flow and there almost has to be another entry logged, or a message sent to the device, and neither is the case. So, I’m wondering if there’s an exception being thrown sometime very shortly after this message is logged…

If not, then I’ll need to add more debug messages to work out what’s up...

— Reply to this email directly or view it on GitHub https://github.com/openhab/openhab/issues/2082#issuecomment-91664903 . https://github.com/notifications/beacon/AK0nr7EKL_PXCSZuUfcyzB2hjPKEywplks5n-CJpgaJpZM4Dbymc.gif

cdjackson commented 9 years ago

Hmmm - ok, the openhab log only seems to have zwave entries? Where do all your ‘other’ entries go? I have 3 logs - zwave.log, openhab.log (which has everything other than zwave stuff - so all my other bindings, rules, etc) and then events…

Maybe it’s printed to the console only? If so, maybe execute the rule again and see if something (i.e. an exception) is printed to the console?

cdjackson commented 9 years ago

Thanks to @loksbjerre for testing - this was traced to an exception getting the parameter from the database where parameter IDs weren't contiguous starting at 1.

2440 fixes this issue and this can now be closed.

rezethon commented 9 years ago

Hello Chris I've done it the same way you did and I can update parameter value but when trying to get it back I get this "NODE 4: No converter found for item = PhilioMeterConfig, endpoint = 0, ignoring event.":

2015-04-23 11:19:37.372 [DEBUG] [ZWaveConfigurationCommandClass:182 ]- NODE 4: Creating new message for application command CONFIGURATIONCMD_SET
2015-04-23 11:19:37.377 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 4: Creating empty message of class = SendData (0x13), type = Request (0x00)
2015-04-23 11:19:37.377 [DEBUG] [b.z.i.protocol.ZWaveController:976 ]- Callback ID = 178
2015-04-23 11:19:37.377 [DEBUG] [b.z.i.protocol.ZWaveController:658 ]- Enqueueing message. Queue length = 1
2015-04-23 11:19:37.377 [DEBUG] [WaveController$ZWaveSendThread:1249]- Took message from queue for sending. Queue length = 0
2015-04-23 11:19:37.377 [DEBUG] [ZWaveConfigurationCommandClass:154 ]- NODE 4: Creating new message for application command CONFIGURATIONCMD_GET
2015-04-23 11:19:37.377 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 0C 00 13 04 05 70 04 0A 01 02 25 B2 0B 
2015-04-23 11:19:37.377 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 4: Creating empty message of class = SendData (0x13), type = Request (0x00)
2015-04-23 11:19:37.382 [DEBUG] [WaveController$ZWaveSendThread:1306]- NODE 4: Sending REQUEST Message = 01 0C 00 13 04 05 70 04 0A 01 02 25 B2 0B 
2015-04-23 11:19:37.382 [DEBUG] [b.z.i.protocol.ZWaveController:976 ]- Callback ID = 179
2015-04-23 11:19:37.382 [DEBUG] [b.z.i.protocol.ZWaveController:658 ]- Enqueueing message. Queue length = 1
2015-04-23 11:19:37.387 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 04 01 13 01 E8 
2015-04-23 11:19:37.392 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 11:19:37.392 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 11:19:37.392 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 04 01 13 01 E8 
2015-04-23 11:19:37.392 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 04 01 13 01 E8 
2015-04-23 11:19:37.392 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Response (0x01), payload = 01 
2015-04-23 11:19:37.392 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38  ]- NODE 4: Sent Data successfully placed on stack.
2015-04-23 11:19:37.407 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 07 00 13 B2 00 00 02 5B 
2015-04-23 11:19:37.407 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 11:19:37.407 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 11:19:37.412 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 09 00 13 B2 00 00 02 00 00 55 
2015-04-23 11:19:37.412 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 09 00 13 B2 00 00 02 00 00 55 
2015-04-23 11:19:37.412 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Request (0x00), payload = B2 00 00 02 
2015-04-23 11:19:37.412 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74  ]- NODE 4: SendData Request. CallBack ID = 178, Status = Transmission complete and ACK received(0)
2015-04-23 11:19:37.412 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63  ]- Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 04 05 70 04 0A 01 02 
2015-04-23 11:19:37.412 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64  ]- Recv message Message: class = SendData (0x13), type = Request (0x00), payload = B2 00 00 02 
2015-04-23 11:19:37.412 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65  ]- Checking transaction complete: class=SendData, expected=SendData, cancelled=false
2015-04-23 11:19:37.417 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68  ]-          transaction complete!
2015-04-23 11:19:37.417 [DEBUG] [b.z.i.protocol.ZWaveController:673 ]- Notifying event listeners: ZWaveTransactionCompletedEvent
2015-04-23 11:19:37.417 [DEBUG] [.z.internal.ZWaveActiveBinding:433 ]- ZwaveIncomingEvent
2015-04-23 11:19:37.417 [DEBUG] [WaveController$ZWaveSendThread:1365]- NODE 4: Response processed after 35ms/150ms.
2015-04-23 11:19:37.417 [DEBUG] [WaveController$ZWaveSendThread:1249]- Took message from queue for sending. Queue length = 0
2015-04-23 11:19:37.417 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 0A 00 13 04 03 70 05 0A 25 B3 08 
2015-04-23 11:19:37.417 [DEBUG] [WaveController$ZWaveSendThread:1306]- NODE 4: Sending REQUEST Message = 01 0A 00 13 04 03 70 05 0A 25 B3 08 
2015-04-23 11:19:37.427 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 04 01 13 01 E8 
2015-04-23 11:19:37.432 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 11:19:37.432 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 11:19:37.432 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 04 01 13 01 E8 
2015-04-23 11:19:37.432 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 04 01 13 01 E8 
2015-04-23 11:19:37.432 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Response (0x01), payload = 01 
2015-04-23 11:19:37.432 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38  ]- NODE 4: Sent Data successfully placed on stack.
2015-04-23 11:19:37.442 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 07 00 13 B3 00 00 02 5A 
2015-04-23 11:19:37.447 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 11:19:37.447 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 11:19:37.447 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 09 00 13 B3 00 00 02 00 00 54 
2015-04-23 11:19:37.447 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 09 00 13 B3 00 00 02 00 00 54 
2015-04-23 11:19:37.452 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Request (0x00), payload = B3 00 00 02 
2015-04-23 11:19:37.452 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74  ]- NODE 4: SendData Request. CallBack ID = 179, Status = Transmission complete and ACK received(0)
2015-04-23 11:19:37.452 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63  ]- Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 04 03 70 05 0A 
2015-04-23 11:19:37.452 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64  ]- Recv message Message: class = SendData (0x13), type = Request (0x00), payload = B3 00 00 02 
2015-04-23 11:19:37.452 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65  ]- Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false
2015-04-23 11:19:37.457 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 0B 00 04 00 04 05 70 06 0A 01 02 8E 
2015-04-23 11:19:37.457 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 11:19:37.457 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 11:19:37.457 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 0B 00 04 00 04 05 70 06 0A 01 02 8E 
2015-04-23 11:19:37.462 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 0B 00 04 00 04 05 70 06 0A 01 02 8E 
2015-04-23 11:19:37.462 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 04 05 70 06 0A 01 02 
2015-04-23 11:19:37.462 [DEBUG] [ApplicationCommandMessageClass:38  ]- NODE 4: Application Command Request (ALIVE:DONE)
2015-04-23 11:19:37.462 [DEBUG] [ApplicationCommandMessageClass:56  ]- NODE 4: Incoming command class CONFIGURATION
2015-04-23 11:19:37.462 [DEBUG] [ZWaveConfigurationCommandClass:76  ]- NODE 4: Received Configuration Request
2015-04-23 11:19:37.462 [DEBUG] [ZWaveConfigurationCommandClass:115 ]- NODE 4: Node configuration report, parameter = 10, value = 2
2015-04-23 11:19:37.462 [DEBUG] [b.z.i.protocol.ZWaveController:673 ]- Notifying event listeners: ZWaveConfigurationParameterEvent
2015-04-23 11:19:37.462 [DEBUG] [.z.internal.ZWaveActiveBinding:433 ]- ZwaveIncomingEvent
2015-04-23 11:19:37.462 [DEBUG] [.z.internal.ZWaveActiveBinding:450 ]- NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@160552d
2015-04-23 11:19:37.467 [WARN ] [.c.ZWaveConfigurationConverter:99  ]- NODE 4: No converter found for item = PhilioMeterConfig, endpoint = 0, ignoring event.
2015-04-23 11:19:37.487 [DEBUG] [.b.z.i.p.i.ZWaveNodeSerializer:107 ]- NODE 4: Serializing to file etc\zwave\node4.xml
2015-04-23 11:19:37.507 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63  ]- Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 04 03 70 05 0A 
2015-04-23 11:19:37.512 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64  ]- Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 04 05 70 06 0A 01 02 
2015-04-23 11:19:37.512 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65  ]- Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false
2015-04-23 11:19:37.512 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68  ]-          transaction complete!
2015-04-23 11:19:37.512 [DEBUG] [b.z.i.protocol.ZWaveController:673 ]- Notifying event listeners: ZWaveTransactionCompletedEvent
2015-04-23 11:19:37.512 [DEBUG] [.z.internal.ZWaveActiveBinding:433 ]- ZwaveIncomingEvent
2015-04-23 11:19:37.512 [DEBUG] [WaveController$ZWaveSendThread:1365]- NODE 4: Response processed after 90ms/150ms.
2015-04-23 11:19:40.863 [DEBUG] [.c.ZWaveConfigurationConverter:71  ]- NODE 4: Generating poll message for CONFIGURATION, endpoint 0
2015-04-23 11:19:40.863 [DEBUG] [ZWaveConfigurationCommandClass:154 ]- NODE 4: Creating new message for application command CONFIGURATIONCMD_GET
2015-04-23 11:19:40.863 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 4: Creating empty message of class = SendData (0x13), type = Request (0x00)
2015-04-23 11:19:40.863 [DEBUG] [b.z.i.protocol.ZWaveController:976 ]- Callback ID = 180
2015-04-23 11:19:40.863 [DEBUG] [b.z.i.protocol.ZWaveController:658 ]- Enqueueing message. Queue length = 1
2015-04-23 11:19:40.863 [DEBUG] [WaveController$ZWaveSendThread:1249]- Took message from queue for sending. Queue length = 0
2015-04-23 11:19:40.863 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 0A 00 13 04 03 70 05 0A 25 B4 0F 
2015-04-23 11:19:40.863 [DEBUG] [WaveController$ZWaveSendThread:1306]- NODE 4: Sending REQUEST Message = 01 0A 00 13 04 03 70 05 0A 25 B4 0F 
2015-04-23 11:19:40.873 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 04 01 13 01 E8 
2015-04-23 11:19:40.873 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 11:19:40.873 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 11:19:40.873 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 04 01 13 01 E8 
2015-04-23 11:19:40.873 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 04 01 13 01 E8 
2015-04-23 11:19:40.878 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Response (0x01), payload = 01 
2015-04-23 11:19:40.878 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38  ]- NODE 4: Sent Data successfully placed on stack.
2015-04-23 11:19:40.888 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 07 00 13 B4 00 00 02 5D 
2015-04-23 11:19:40.893 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 11:19:40.893 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 11:19:40.893 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 09 00 13 B4 00 00 02 00 00 53 
2015-04-23 11:19:40.893 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 09 00 13 B4 00 00 02 00 00 53 
2015-04-23 11:19:40.893 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Request (0x00), payload = B4 00 00 02 
2015-04-23 11:19:40.893 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74  ]- NODE 4: SendData Request. CallBack ID = 180, Status = Transmission complete and ACK received(0)
2015-04-23 11:19:40.893 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63  ]- Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 04 03 70 05 0A 
2015-04-23 11:19:40.893 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64  ]- Recv message Message: class = SendData (0x13), type = Request (0x00), payload = B4 00 00 02 
2015-04-23 11:19:40.893 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65  ]- Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false
2015-04-23 11:19:40.898 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 0B 00 04 00 04 05 70 06 0A 01 02 8E 
2015-04-23 11:19:40.903 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 11:19:40.903 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 11:19:40.903 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 0B 00 04 00 04 05 70 06 0A 01 02 8E 
2015-04-23 11:19:40.903 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 0B 00 04 00 04 05 70 06 0A 01 02 8E 
2015-04-23 11:19:40.903 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 04 05 70 06 0A 01 02 
2015-04-23 11:19:40.903 [DEBUG] [ApplicationCommandMessageClass:38  ]- NODE 4: Application Command Request (ALIVE:DONE)
2015-04-23 11:19:40.903 [DEBUG] [ApplicationCommandMessageClass:56  ]- NODE 4: Incoming command class CONFIGURATION
2015-04-23 11:19:40.903 [DEBUG] [ZWaveConfigurationCommandClass:76  ]- NODE 4: Received Configuration Request
2015-04-23 11:19:40.903 [DEBUG] [ZWaveConfigurationCommandClass:115 ]- NODE 4: Node configuration report, parameter = 10, value = 2
2015-04-23 11:19:40.903 [DEBUG] [b.z.i.protocol.ZWaveController:673 ]- Notifying event listeners: ZWaveConfigurationParameterEvent
2015-04-23 11:19:40.903 [DEBUG] [.z.internal.ZWaveActiveBinding:433 ]- ZwaveIncomingEvent
2015-04-23 11:19:40.903 [DEBUG] [.z.internal.ZWaveActiveBinding:450 ]- NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@160552d
2015-04-23 11:19:40.903 [WARN ] [.c.ZWaveConfigurationConverter:99  ]- NODE 4: No converter found for item = PhilioMeterConfig, endpoint = 0, ignoring event.
2015-04-23 11:19:40.918 [DEBUG] [.b.z.i.p.i.ZWaveNodeSerializer:107 ]- NODE 4: Serializing to file etc\zwave\node4.xml
2015-04-23 11:19:40.933 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63  ]- Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 04 03 70 05 0A 
2015-04-23 11:19:40.938 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64  ]- Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 04 05 70 06 0A 01 02 
2015-04-23 11:19:40.938 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65  ]- Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false
2015-04-23 11:19:40.938 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68  ]-          transaction complete!
2015-04-23 11:19:40.938 [DEBUG] [b.z.i.protocol.ZWaveController:673 ]- Notifying event listeners: ZWaveTransactionCompletedEvent
2015-04-23 11:19:40.938 [DEBUG] [.z.internal.ZWaveActiveBinding:433 ]- ZwaveIncomingEvent
2015-04-23 11:19:40.938 [DEBUG] [WaveController$ZWaveSendThread:1365]- NODE 4: Response processed after 75ms/150ms.

My Item and sitemap definitions:

Number PhilioMeterConfig  "Parameter Change [%d]" {zwave="4:command=CONFIGURATION, parameter=10, refresh_interval=10"  }

Setpoint item=PhilioMeterConfig minValue=1 maxValue=2 step=1

This is also in relation to HABmin isuue #232. I've left you a comment there.

cdjackson commented 9 years ago

Can you try the binding that will be on PR #2500. Once the Cloudbees build occurs (probably an hour or so) there will be a link there where you can download the binding - it won't solve the problem, but please post the debug log again when you do the get.

rezethon commented 9 years ago

I've tried new build and it's still the same. I've changed parameter 10 in HABmin and you can see that below (first event) but then since my item has refresh_interval=10 you can see that at next refresh message from before appears again. Hope that helps.


2015-04-23 14:48:27.432 [DEBUG] [.z.internal.ZWaveActiveBinding:433 ]- ZwaveIncomingEvent
2015-04-23 14:48:27.432 [TRACE] [b.z.i.protocol.ZWaveController:225 ]- Released. Transaction completed permit count -> 1
2015-04-23 14:48:27.432 [DEBUG] [WaveController$ZWaveSendThread:1365]- NODE 4: Response processed after 110ms/150ms.
2015-04-23 14:48:27.432 [TRACE] [WaveController$ZWaveSendThread:1366]- Acquired. Transaction completed permit count -> 0
2015-04-23 14:48:29.597 [DEBUG] [.z.i.config.ZWaveConfiguration:1071]- doSet domain 'nodes/node4/parameters/configuration10' to '1'
2015-04-23 14:48:29.702 [DEBUG] [.z.i.config.ZWaveConfiguration:1136]- Set parameter index '10' to '1'
2015-04-23 14:48:29.707 [DEBUG] [ZWaveConfigurationCommandClass:182 ]- NODE 4: Creating new message for application command CONFIGURATIONCMD_SET
2015-04-23 14:48:29.707 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 4: Creating empty message of class = SendData (0x13), type = Request (0x00)
2015-04-23 14:48:29.707 [DEBUG] [b.z.i.protocol.ZWaveController:976 ]- Callback ID = 74
2015-04-23 14:48:29.707 [DEBUG] [b.z.i.protocol.ZWaveController:658 ]- Enqueueing message. Queue length = 1
2015-04-23 14:48:29.707 [DEBUG] [WaveController$ZWaveSendThread:1249]- Took message from queue for sending. Queue length = 0
2015-04-23 14:48:29.712 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xF0
2015-04-23 14:48:29.707 [DEBUG] [ZWaveConfigurationCommandClass:154 ]- NODE 4: Creating new message for application command CONFIGURATIONCMD_GET
2015-04-23 14:48:29.712 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 0C 00 13 04 05 70 04 0A 01 01 25 4A F0 
2015-04-23 14:48:29.712 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ]- NODE 4: Creating empty message of class = SendData (0x13), type = Request (0x00)
2015-04-23 14:48:29.712 [DEBUG] [WaveController$ZWaveSendThread:1306]- NODE 4: Sending REQUEST Message = 01 0C 00 13 04 05 70 04 0A 01 01 25 4A F0 
2015-04-23 14:48:29.712 [DEBUG] [b.z.i.protocol.ZWaveController:976 ]- Callback ID = 75
2015-04-23 14:48:29.712 [TRACE] [WaveController$ZWaveSendThread:1312]- Message SENT
2015-04-23 14:48:29.712 [DEBUG] [b.z.i.protocol.ZWaveController:658 ]- Enqueueing message. Queue length = 1
2015-04-23 14:48:29.712 [TRACE] [eController$ZWaveReceiveThread:1524]- Received ACK
2015-04-23 14:48:29.722 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 04 01 13 01 E8 
2015-04-23 14:48:29.722 [TRACE] [o.b.z.i.protocol.SerialMessage:136 ]- NODE 255: Creating new SerialMessage from buffer = 01 04 01 13 01 E8 
2015-04-23 14:48:29.722 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xE8
2015-04-23 14:48:29.722 [TRACE] [o.b.z.i.protocol.SerialMessage:141 ]- NODE 255: Checksum matched
2015-04-23 14:48:29.722 [TRACE] [o.b.z.i.protocol.SerialMessage:153 ]- NODE 255: Message payload = 01 
2015-04-23 14:48:29.722 [TRACE] [eController$ZWaveReceiveThread:1428]- Message is valid, sending ACK
2015-04-23 14:48:29.722 [TRACE] [eController$ZWaveReceiveThread:1413]- Response SENT
2015-04-23 14:48:29.722 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 14:48:29.722 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 14:48:29.722 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xE8
2015-04-23 14:48:29.722 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 04 01 13 01 E8 
2015-04-23 14:48:29.722 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 04 01 13 01 E8 
2015-04-23 14:48:29.722 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Response (0x01), payload = 01 
2015-04-23 14:48:29.727 [TRACE] [b.z.i.protocol.ZWaveController:244 ]- Incoming Message type = RESPONSE
2015-04-23 14:48:29.727 [TRACE] [b.z.i.p.s.SendDataMessageClass:36  ]- Handle Message Send Data Response
2015-04-23 14:48:29.727 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38  ]- NODE 4: Sent Data successfully placed on stack.
2015-04-23 14:48:29.737 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 07 00 13 4A 00 00 02 A3 
2015-04-23 14:48:29.737 [TRACE] [o.b.z.i.protocol.SerialMessage:136 ]- NODE 255: Creating new SerialMessage from buffer = 01 07 00 13 4A 00 00 02 A3 
2015-04-23 14:48:29.737 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xA3
2015-04-23 14:48:29.737 [TRACE] [o.b.z.i.protocol.SerialMessage:141 ]- NODE 255: Checksum matched
2015-04-23 14:48:29.737 [TRACE] [o.b.z.i.protocol.SerialMessage:153 ]- NODE 255: Message payload = 4A 00 00 02 
2015-04-23 14:48:29.737 [TRACE] [eController$ZWaveReceiveThread:1428]- Message is valid, sending ACK
2015-04-23 14:48:29.737 [TRACE] [eController$ZWaveReceiveThread:1413]- Response SENT
2015-04-23 14:48:29.737 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 14:48:29.737 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 14:48:29.742 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xAD
2015-04-23 14:48:29.742 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 09 00 13 4A 00 00 02 00 00 AD 
2015-04-23 14:48:29.742 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 09 00 13 4A 00 00 02 00 00 AD 
2015-04-23 14:48:29.742 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Request (0x00), payload = 4A 00 00 02 
2015-04-23 14:48:29.742 [TRACE] [b.z.i.protocol.ZWaveController:210 ]- Incoming Message type = REQUEST
2015-04-23 14:48:29.742 [TRACE] [b.z.i.p.s.SendDataMessageClass:58  ]- Handle Message Send Data Request
2015-04-23 14:48:29.742 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74  ]- NODE 4: SendData Request. CallBack ID = 74, Status = Transmission complete and ACK received(0)
2015-04-23 14:48:29.742 [TRACE] [o.b.z.i.protocol.SerialMessage:399 ]- Ack Pending cleared
2015-04-23 14:48:29.742 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63  ]- Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 04 05 70 04 0A 01 01 
2015-04-23 14:48:29.742 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64  ]- Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 4A 00 00 02 
2015-04-23 14:48:29.742 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65  ]- Checking transaction complete: class=SendData, expected=SendData, cancelled=false
2015-04-23 14:48:29.742 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68  ]-          transaction complete!
2015-04-23 14:48:29.742 [DEBUG] [b.z.i.protocol.ZWaveController:673 ]- Notifying event listeners: ZWaveTransactionCompletedEvent
2015-04-23 14:48:29.742 [DEBUG] [.z.internal.ZWaveActiveBinding:433 ]- ZwaveIncomingEvent
2015-04-23 14:48:29.742 [TRACE] [b.z.i.protocol.ZWaveController:225 ]- Released. Transaction completed permit count -> 1
2015-04-23 14:48:29.742 [DEBUG] [WaveController$ZWaveSendThread:1365]- NODE 4: Response processed after 30ms/150ms.
2015-04-23 14:48:29.747 [TRACE] [WaveController$ZWaveSendThread:1366]- Acquired. Transaction completed permit count -> 0
2015-04-23 14:48:29.747 [DEBUG] [WaveController$ZWaveSendThread:1249]- Took message from queue for sending. Queue length = 0
2015-04-23 14:48:29.747 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xF0
2015-04-23 14:48:29.747 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 0A 00 13 04 03 70 05 0A 25 4B F0 
2015-04-23 14:48:29.747 [DEBUG] [WaveController$ZWaveSendThread:1306]- NODE 4: Sending REQUEST Message = 01 0A 00 13 04 03 70 05 0A 25 4B F0 
2015-04-23 14:48:29.747 [TRACE] [WaveController$ZWaveSendThread:1312]- Message SENT
2015-04-23 14:48:29.747 [TRACE] [eController$ZWaveReceiveThread:1524]- Received ACK
2015-04-23 14:48:29.757 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 04 01 13 01 E8 
2015-04-23 14:48:29.757 [TRACE] [o.b.z.i.protocol.SerialMessage:136 ]- NODE 255: Creating new SerialMessage from buffer = 01 04 01 13 01 E8 
2015-04-23 14:48:29.757 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xE8
2015-04-23 14:48:29.757 [TRACE] [o.b.z.i.protocol.SerialMessage:141 ]- NODE 255: Checksum matched
2015-04-23 14:48:29.757 [TRACE] [o.b.z.i.protocol.SerialMessage:153 ]- NODE 255: Message payload = 01 
2015-04-23 14:48:29.757 [TRACE] [eController$ZWaveReceiveThread:1428]- Message is valid, sending ACK
2015-04-23 14:48:29.757 [TRACE] [eController$ZWaveReceiveThread:1413]- Response SENT
2015-04-23 14:48:29.757 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 14:48:29.757 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 14:48:29.757 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xE8
2015-04-23 14:48:29.762 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 04 01 13 01 E8 
2015-04-23 14:48:29.762 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 04 01 13 01 E8 
2015-04-23 14:48:29.762 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Response (0x01), payload = 01 
2015-04-23 14:48:29.762 [TRACE] [b.z.i.protocol.ZWaveController:244 ]- Incoming Message type = RESPONSE
2015-04-23 14:48:29.762 [TRACE] [b.z.i.p.s.SendDataMessageClass:36  ]- Handle Message Send Data Response
2015-04-23 14:48:29.762 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38  ]- NODE 4: Sent Data successfully placed on stack.
2015-04-23 14:48:29.772 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 07 00 13 4B 00 00 02 A2 
2015-04-23 14:48:29.772 [TRACE] [o.b.z.i.protocol.SerialMessage:136 ]- NODE 255: Creating new SerialMessage from buffer = 01 07 00 13 4B 00 00 02 A2 
2015-04-23 14:48:29.772 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xA2
2015-04-23 14:48:29.772 [TRACE] [o.b.z.i.protocol.SerialMessage:141 ]- NODE 255: Checksum matched
2015-04-23 14:48:29.772 [TRACE] [o.b.z.i.protocol.SerialMessage:153 ]- NODE 255: Message payload = 4B 00 00 02 
2015-04-23 14:48:29.772 [TRACE] [eController$ZWaveReceiveThread:1428]- Message is valid, sending ACK
2015-04-23 14:48:29.772 [TRACE] [eController$ZWaveReceiveThread:1413]- Response SENT
2015-04-23 14:48:29.772 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 14:48:29.777 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 14:48:29.777 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0xAC
2015-04-23 14:48:29.777 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 09 00 13 4B 00 00 02 00 00 AC 
2015-04-23 14:48:29.777 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 09 00 13 4B 00 00 02 00 00 AC 
2015-04-23 14:48:29.777 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = SendData (0x13), type = Request (0x00), payload = 4B 00 00 02 
2015-04-23 14:48:29.777 [TRACE] [b.z.i.protocol.ZWaveController:210 ]- Incoming Message type = REQUEST
2015-04-23 14:48:29.777 [TRACE] [b.z.i.p.s.SendDataMessageClass:58  ]- Handle Message Send Data Request
2015-04-23 14:48:29.777 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74  ]- NODE 4: SendData Request. CallBack ID = 75, Status = Transmission complete and ACK received(0)
2015-04-23 14:48:29.777 [TRACE] [o.b.z.i.protocol.SerialMessage:399 ]- Ack Pending cleared
2015-04-23 14:48:29.777 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63  ]- Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 04 03 70 05 0A 
2015-04-23 14:48:29.782 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64  ]- Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 4B 00 00 02 
2015-04-23 14:48:29.782 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65  ]- Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false
2015-04-23 14:48:29.782 [DEBUG] [eController$ZWaveReceiveThread:1519]- Receive Message = 01 0B 00 04 00 04 05 70 06 0A 01 01 8D 
2015-04-23 14:48:29.782 [TRACE] [o.b.z.i.protocol.SerialMessage:136 ]- NODE 255: Creating new SerialMessage from buffer = 01 0B 00 04 00 04 05 70 06 0A 01 01 8D 
2015-04-23 14:48:29.782 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0x8D
2015-04-23 14:48:29.782 [TRACE] [o.b.z.i.protocol.SerialMessage:141 ]- NODE 255: Checksum matched
2015-04-23 14:48:29.782 [TRACE] [o.b.z.i.protocol.SerialMessage:153 ]- NODE 255: Message payload = 00 04 05 70 06 0A 01 01 
2015-04-23 14:48:29.787 [TRACE] [eController$ZWaveReceiveThread:1428]- Message is valid, sending ACK
2015-04-23 14:48:29.787 [TRACE] [eController$ZWaveReceiveThread:1413]- Response SENT
2015-04-23 14:48:29.787 [DEBUG] [eController$ZWaveReceiveThread:1443]- Receive queue ADD: Length=1
2015-04-23 14:48:29.787 [DEBUG] [b.z.i.protocol.ZWaveController:1201]- Receive queue TAKE: Length=0
2015-04-23 14:48:29.787 [TRACE] [o.b.z.i.protocol.SerialMessage:179 ]- Calculated checksum = 0x8D
2015-04-23 14:48:29.787 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ]- Assembled message buffer = 01 0B 00 04 00 04 05 70 06 0A 01 01 8D 
2015-04-23 14:48:29.792 [DEBUG] [b.z.i.protocol.ZWaveController:1202]- Process Message = 01 0B 00 04 00 04 05 70 06 0A 01 01 8D 
2015-04-23 14:48:29.792 [DEBUG] [b.z.i.protocol.ZWaveController:190 ]- Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 04 05 70 06 0A 01 01 
2015-04-23 14:48:29.792 [TRACE] [b.z.i.protocol.ZWaveController:210 ]- Incoming Message type = REQUEST
2015-04-23 14:48:29.792 [TRACE] [ApplicationCommandMessageClass:30  ]- Handle Message Application Command Request
2015-04-23 14:48:29.792 [DEBUG] [ApplicationCommandMessageClass:38  ]- NODE 4: Application Command Request (ALIVE:DONE)
2015-04-23 14:48:29.797 [DEBUG] [ApplicationCommandMessageClass:56  ]- NODE 4: Incoming command class CONFIGURATION
2015-04-23 14:48:29.797 [TRACE] [ApplicationCommandMessageClass:79  ]- NODE 4: Found Command Class CONFIGURATION, passing to handleApplicationCommandRequest
2015-04-23 14:48:29.797 [DEBUG] [ZWaveConfigurationCommandClass:76  ]- NODE 4: Received Configuration Request
2015-04-23 14:48:29.797 [TRACE] [ZWaveConfigurationCommandClass:87  ]- NODE 4: Process Configuration Report
2015-04-23 14:48:29.797 [DEBUG] [ZWaveConfigurationCommandClass:115 ]- NODE 4: Node configuration report, parameter = 10, value = 1
2015-04-23 14:48:29.797 [DEBUG] [b.z.i.protocol.ZWaveController:673 ]- Notifying event listeners: ZWaveConfigurationParameterEvent
2015-04-23 14:48:29.797 [DEBUG] [.z.internal.ZWaveActiveBinding:433 ]- ZwaveIncomingEvent
2015-04-23 14:48:29.797 [DEBUG] [.z.internal.ZWaveActiveBinding:450 ]- NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@dbe647
2015-04-23 14:48:29.802 [TRACE] [.b.z.i.c.ZWaveConverterHandler:340 ]- Getting converter for item = PhilioMeterConfig, command class = CONFIGURATION, item command class = configuration
2015-04-23 14:48:29.802 [WARN ] [.c.ZWaveConfigurationConverter:99  ]- NODE 4: No converter found for item = PhilioMeterConfig(NumberItem), endpoint = 0, ignoring event.
2015-04-23 14:48:29.807 [TRACE] [.b.z.i.p.i.ZWaveNodeSerializer:50  ]- Initializing ZWaveNodeSerializer.
2015-04-23 14:48:29.822 [TRACE] [.b.z.i.p.i.ZWaveNodeSerializer:85  ]- Initialized ZWaveNodeSerializer.
2015-04-23 14:48:29.827 [DEBUG] [.b.z.i.p.i.ZWaveNodeSerializer:107 ]- NODE 4: Serializing to file etc\zwave\node4.xml
2015-04-23 14:48:29.847 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63  ]- Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 04 03 70 05 0A 
2015-04-23 14:48:29.847 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64  ]- Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 04 05 70 06 0A 01 01 
2015-04-23 14:48:29.847 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65  ]- Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false
2015-04-23 14:48:29.847 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68  ]-          transaction complete!
cdjackson commented 9 years ago

Thanks - as I said earlier, this won’t fix it as I have only added more debug - nothing else. I’ll take a look...

cdjackson commented 9 years ago

I’ve pushed another change - I’m not sure it will solve it, but let’s see...

viper1705 commented 9 years ago

I have a Vision Security Siren, of which I'm trying to set the sound / Strobe parameter. I have tried with the zwave binding from cloudbees and the method from above, but I cannot set the paramter. It's parameter=0, and I get a message saying that the parameter should be between 1 and 255. If I try to set parameter 1 (which is the timing of the sound), it works, so it seems the parameter shoould also accept parameter=0

thx

cdjackson commented 9 years ago

I can't really do anything without a logfile - can you provide a debug log so I can see what's going on?

loksbjerre commented 9 years ago

Hi viper1705,

Only certain values are allowed. Here is ythe complete list that I tested.

sitemap:

    Selection item=Z63_SetSound label="sound 1" mappings=[261="H5",260="H4",259="H3", 258="H2", 257="H1"]
    Selection item=Z63_SetSound label="sound 2" mappings=[517="H5",516="H4",515="H3", 514="H2", 513="H1"]
    Selection item=Z63_SetSound label="sound 3" mappings=[773="H5",772="H4",771="H3", 770="H2", 769="H1"]
    Selection item=Z63_SetSound label="sound 4" mappings=[1029="H5",1028="H4",1027="H3", 1026="H2", 1025="H1"]
    Selection item=Z63_SetSound label="sound 5" mappings=[1285="H5",1284="H4",1283="H3", 1282="H2", 1282="H1"]

item definition:

Switch Z63_Siren "Sirene [%s]" { zwave="63"} Number Z63_Sound "Sirene lyd [%d]" {zwave="63:command=configuration,parameter=37"}

When setting the parameter, the siren starts, somehow odd.

Regards Lars

loksbjerre commented 9 years ago

Hi viper1705,

forgor the rule:

rule "Update Siren Sound" when Item Z63_SetSound received update then
logInfo ( "SIREN", "Parm=" + Z63_SetSound.state.toString ) sendCommand ( Z63_Sound, Z63_SetSound.state.toString ) end

and the corresponding item:

Number Z63_SetSound "Sirene lyd [%d]"

Regards Lars

viper1705 commented 9 years ago

Hi Chris,

I included the log.

[image: Inline afbeelding 1]

as you can see in above screenshot, the parameter for the Siren Strobe Mode is parameter 0, so my item is defined as follows: Number SndSiren "Sound / Strobe"

{ zwave="6:command=CONFIGURATION,parameter=0" } And in my sitemap I have following: Selection item=SndSiren mappings=[00="Strobe + Sound", 02="Strobe"] However, when I select the values in the selection item it gives me following error: 2015-05-06 21:28:08.974 ERROR o.o.b.z.i.c.ZWaveConfigurationConverter[:126]- NODE 6: 'parameter' option must be between 1 and 255. I think I saw this test somewhere in the binding (I'm using org.openhab.binding.zwave-1.7.0-SNAPSHOT from cloudbees) the test <= 0 and > 255 -> error, so this is exactly my problem, my parameter to set is 0 BR 2015-05-06 18:16 GMT+02:00 Chris Jackson notifications@github.com: > I can't really do anything without a logfile - can you provide a debug log > so I can see what's going on? > > — > Reply to this email directly or view it on GitHub > https://github.com/openhab/openhab/issues/2082#issuecomment-99526719.
viper1705 commented 9 years ago

Chris,

Did you get my log ? (I mailed it to you since it seems it cannot be attached to this issue list)

cdjackson commented 9 years ago

Yes - I'm sure I have it - I just haven't had the chance to look at it yet. I'll try and do it tomorrow.

Chris

cdjackson commented 9 years ago

See https://github.com/openhab/openhab/pull/2572

I suggest if there's further problems can we open another issue - tracking closed issues is a bit difficult :)