Hi
I tested the current snapshot, but also this happend on older snapshots:
I used KNXD and EIBD to connect to KNX - both with same result.
With Openhab 1.x it works fine.
Items:
Number Temperatur_DG_Schlafen_Soll “Schlafen Soll” { knx="<4/3/30" }
Number Temperatur_OG_Finja_Soll “Finja Soll” { knx="<4/2/33" }
Number Temperatur_OG_Bad_Soll “Badezimmer Soll” { knx="<4/2/31" }
These are reading the to be temperature in the rooms. Similar current temperature items are working fine.
When I enable more then one item (one is working) I get:
2016-05-15 18:15:33.543 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Initializing read of item Temperatur_DG_Schlafen_Soll.
2016-05-15 18:15:33.547 [DEBUG] [x.internal.bus.KNXBusReaderScheduler] - Datapoint ‘Temperatur_DG_Schlafen_Soll’: one time reading scheduled.
2016-05-15 18:15:33.550 [DEBUG] [al.bus.KNXBindingDatapointReaderTask] - Autorefresh: got new item Temperatur_DG_Schlafen_Soll in reader queue
2016-05-15 18:15:33.552 [DEBUG] [al.bus.KNXBindingDatapointReaderTask] - Autorefresh: Trying to read from KNX bus: command DP 4/3/30 ATemperatur_DG_Schlafen_Soll, DPT main 0 id 9.001, low priority
2016-05-15 18:15:33.555 [DEBUG] [al.bus.KNXBindingDatapointReaderTask] - Autorefresh: Sending read request to KNX for item ‘Temperatur_DG_Schlafen_Soll’ DPT '9.001’
2016-05-15 18:15:33.644 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:15:33.645 [DEBUG] [al.bus.KNXBindingDatapointReaderTask] - Autorefresh: DatapointReaderTask Waiting 50 msecs to prevent KNX bus overload
2016-05-15 18:15:33.654 [INFO ] [smarthome.event.ItemCommandEvent ] - Item ‘Temperatur_DG_Schlafen_Soll’ received command 21.5
2016-05-15 18:15:33.683 [INFO ] [marthome.event.ItemStateChangedEvent] - ATemperatur_DG_Schlafen_Soll changed from NULL to 21.5
2016-05-15 18:15:33.687 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item=‘ATemperatur_DG_Schlafen_Soll’, state=‘21.5’)
2016-05-15 18:15:33.694 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value ‘21.5’ to datapoint 'command DP 4/3/30 Temperatur_DG_Schlafen_Soll, DPT main 0 id 9.001, low priority’
2016-05-15 18:15:33.699 [DEBUG] [al.bus.KNXBindingDatapointReaderTask] - Autorefresh: Waiting for new item in reader queue
2016-05-15 18:15:40.425 [INFO ] [el.core.internal.ModelRepositoryImpl] - Refreshing model ‘knx-heizung.items’
When I uncomment the second item there will be an endless loop to read these items
2016-05-15 18:19:18.055 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:18.061 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:18.071 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:18.076 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:18.204 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:18.210 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:18.220 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:18.226 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:18.353 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:18.358 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:18.367 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:18.372 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:18.503 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:18.517 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:18.537 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:18.543 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:18.637 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:18.642 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:18.651 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:18.660 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:18.802 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:18.808 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:18.816 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:18.822 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:18.958 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:18.962 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:18.976 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:18.981 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:19.106 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:19.112 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:19.121 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:19.127 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:19.256 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:19.261 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:19.273 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:19.280 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:19.404 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:19.409 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:19.417 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:19.422 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:19.554 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:19.559 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:19.567 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:19.574 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:19.702 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:19.707 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:19.715 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:19.720 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:19.857 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:19.862 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:19.870 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:19.876 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:20.006 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:20.011 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:20.021 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:20.027 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:20.155 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:20.160 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:20.168 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:20.176 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
2016-05-15 18:19:20.311 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received groupWrite Event.
2016-05-15 18:19:20.316 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'Temperatur_OG_Finja_Soll' received command 23.5
2016-05-15 18:19:20.328 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Received update (item='Temperatur_OG_Finja_Soll', state='23.5')
2016-05-15 18:19:20.334 [DEBUG] [.binding.knx.internal.bus.KNXBinding] - Wrote value '23.5' to datapoint 'command DP 4/2/33 Temperatur_OG_Finja_Soll, DPT main 0 id 9.001, low priority'
It seems to be the Binding reads the value and write the result back to bus, where the device will update his new value back to bus and this will cause the loop.
This I did not see in openhab 1.x - is this a changed behavior?
I fixed it now by changing the Flags on the KNX device and uncheck the transmit.
Still wonder why it work until now.
Also I notice when I comment a line in the item file the following lines are ignored.
Is this the expected behavior?