[BTicino/OpenWebNet] New openHAB2 binding ready for testing

massi · May 29, 2021, 4:50pm

as already stated, no more support for OH 2.5 (officially OH 2.5 is even closed for bug fixes now).

aconte80 · May 29, 2021, 8:09pm

We are in the final rush!

There is an open PR (10756) that restores support for Thermoregulation (WHO=4) into OH3.
We (@massi , @gilberto.cocchi and I) hope that it will be included in this month milestone (3.1 M5).

Please note:

it is a first release so it could be that something is not working 100% as expected, I will open another community thread looking for testers: we need your help!
this release only supports stand-alone thermostats (like LN4691) and sensors (like NT4577): central units (4 or 99 zones) are not yet supported: we will work on this in next months.

schabkle · May 29, 2021, 8:28pm

That is very nice i have 3x ln4691 and i would like to be a tester so i am looking forward to the update. Thank you for your answer.

aconte80 · May 31, 2021, 5:42pm

Finally, it was not possible to include the binding with Thermoregulation support within 3.1 Milestone 5.
By the way, as promised, here’s the link of a dedicated community thread where you can download the standalone .JAR file with thermoregulation features!

Waiting for your feedbacks!

massi · June 1, 2021, 2:57pm

A suggested by Andrea, it would be useful if some expert users with different installations (standalone, central unit 4 or 99 zones) could test the Thermo version of the binding on OH3.
See the test list in the dedicated thread.

bastler · June 1, 2021, 5:59pm

just upgraded to oh3.1.0m5 and can confirm now shutters stay UNDEF after reboot.

this is very nice now, if somebody wants to set the last state (after reboot) this can be done with persistence. i like them to stay undef because i can be sure there is no wrong state in the system.

perfect, thank you

cybermcm · June 3, 2021, 6:36am

I want my shutter states to be restored after a reboot (currently updating during the night so no changes will happen) but they stay at UNDEF.
I’m using RRD4J default persistence (without any configuration) and the rrd files are there with a current timestamp. Is there something to do to get the values restored on reboot (should happen automatically according to binding description)?

bastler · June 3, 2021, 7:35am

i did never use persistence for shutters i cannot say surely what may work.

i have written all my rules in jython. here is a snippet that i used to check the previous state, perhaps you can use such a rule for initialisation on system start. this example will generate a log entry (here for persisted last temperature of item iBuero_Heizung)

LogAction.logInfo(u"jythonTest", u"### prev state: {}".format(PersistenceExtensions.previousState(ir.getItem("iBuero_Heizung"), True, "influxdb").state))

in the log:

2021-06-03 09:26:35.673 [INFO ] [openhab.core.model.script.jythonTest] - ### prev state: 22.5

cybermcm · June 3, 2021, 8:22am

thanks for your reply… maybe this is a timing issue. I noticed that after startup the item gets “reset” to UNDEF
log:

2021-06-03 10:12:26.936 [INFO ] [openhab.event.ItemCommandEvent      ] - Item 'H_R_A_fix' received command DOWN
2021-06-03 10:12:26.937 [INFO ] [penhab.event.ItemStatePredictedEvent] - Item 'H_R_A_fix' predicted to become DOWN
2021-06-03 10:12:26.943 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'H_R_A_fix' changed from UNDEF to 100
2021-06-03 10:12:29.708 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'H_R_A_fix' changed from 100 to UNDEF

after waiting for some time:

2021-06-03 10:14:27.391 [INFO ] [openhab.event.ItemCommandEvent      ] - Item 'H_R_A_fix' received command DOWN
2021-06-03 10:14:27.393 [INFO ] [penhab.event.ItemStatePredictedEvent] - Item 'H_R_A_fix' predicted to become DOWN
2021-06-03 10:14:27.401 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'H_R_A_fix' changed from UNDEF to 100

I think that the state gets restored by RRD4J but then gets overwritten by the binding? There is no log entry about the startup restore from RRD4J…
is there probably a workaround to delay startup restore of values?

bastler · June 3, 2021, 9:00am

dont know, sorry.

i checked my very old, archived dsl rules, i know then i tried a lot with init of shutters. i dont know if you are german, i noted some lines, but this i used together with the old binding (i beleive then shutters always where initialized to open at start). perhaps you can use sth as a workaround in a rule that runs some minutes after start, when you can be sure that the binding has initialized:


// geht nicht weil der State von Rollos und Jalos beim Start immer erst NULL, dann UNDEF und am Ende dann 0 (auf) ist
// iG_RolloJalo.members.filter[ i | i.state == NULL].forEach[ i | i.postUpdate(i.previousState().state)]
// historicState(now.minusMinutes(30)) zurückladen ist nicht gut weil sich der Status inzwischen schon wieder verändert haben kann
// iG_RolloJalo.members.forEach[ i | i.postUpdate((i.historicState(now.minusMinutes(30)).state as Number).intValue)]
// previousState() zurückladen ist nicht gut weil da manchmal das gleiche steht wie im aktuellen State
// previousState(true) zurückladen, so mach ich es aktuell, hatte da aber auch schon mal dann eine 0 drin stehen - beobachten!!
iG_RolloJalo.members.filter[ i | i.state !== NULL].forEach[ i | i.postUpdate((i.previousState(true).state as Number).intValue)]

cybermcm · June 3, 2021, 3:24pm

thx for this feedback, I can read it
My programming skills are novice level at best, but I managed to restore the values. In case someone is interested:
rrd4j.persist (I put all items which I want to restore in a group;
attention: restoreOnStartup doesn’t work for shutters in my case.)

Strategies {
    everyMinute : "0 * * * * ?"
}

Items {
    g_RRD4J* : strategy = everyMinute, everyChange, restoreOnStartup
}

and then a startup rule for all shutters (1 example see below):

var Timer DelayedStartTimer // to avoid error messages
rule "init"
when
	System started
then
	DelayedStartTimer = createTimer(now.plusMinutes(2)) [|
		logInfo("event.rules", "delayed start is now off")
		H_R_Shutter.postUpdate(H_R_Shutter.historicState(now.minusMinutes(5)).state.toString)
artTimerCountRestore)).state.toString)
	]
end

Rob-VF · June 4, 2021, 7:34am

Hello Massimo, please find as follows le INFO level debug:


=> /var/log/openhab/openhab.log <==
2021-06-04 09:06:48.418 [INFO ] [org.openwebnet4j.BUSGateway         ] - ##BUS## Init BUS (xxxxxxxxxxxx)...
2021-06-04 09:06:48.578 [INFO ] [e.automation.internal.RuleEngineImpl] - Rule engine started.
2021-06-04 09:06:48.587 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-MON <<<<==HS *#*1##
2021-06-04 09:06:48.589 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON -------> *99*1##
2021-06-04 09:06:48.591 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-MON HS==>>>> *99*1##
2021-06-04 09:06:48.632 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-MON <<<<==HS *#281163783##
2021-06-04 09:06:48.634 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON -------> *#2198016000##
2021-06-04 09:06:48.636 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-MON HS==>>>> *#2198016000##
2021-06-04 09:06:48.692 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-MON <<<<==HS *#*1##
2021-06-04 09:06:48.693 [INFO ] [nwebnet4j.communication.BUSConnector] - ##BUS-conn## ============ MON CONNECTED ============
2021-06-04 09:06:48.832 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD <<<<==HS *#*1##
2021-06-04 09:06:48.833 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *99*0##
2021-06-04 09:06:48.834 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD HS==>>>> *99*0##
2021-06-04 09:06:48.906 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD <<<<==HS *#275998527##
2021-06-04 09:06:48.907 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#3837788160##
2021-06-04 09:06:48.908 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD HS==>>>> *#3837788160##

==> /var/log/openhab/events.log <==
2021-06-04 09:06:48.972 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:13' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.974 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:0012' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.975 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:71h4h03' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.976 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:71h4h01' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.978 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:93h4h01' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.979 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:14' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.980 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:40h4h01' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.982 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:1004h4h01' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.988 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:23h4h01' changed from INITIALIZING to UNKNOWN: Waiting state update...
2021-06-04 09:06:48.997 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:0011' changed from UNINITIALIZED (BRIDGE_UNINITIALIZED) to INITIALIZING
2021-06-04 09:06:48.999 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:0011' changed from INITIALIZING to UNKNOWN: Waiting state update...

CUT ...

2021-06-04 09:06:48.956 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD <<<<==HS *#*1##
2021-06-04 09:06:48.957 [INFO ] [nwebnet4j.communication.BUSConnector] - ##BUS-conn## ============ CMD CONNECTED ============
2021-06-04 09:06:49.011 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#13**12##
2021-06-04 09:06:49.020 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#13**12##
2021-06-04 09:06:49.106 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#13**12*0*3*80*143*31*106##
2021-06-04 09:06:49.210 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*#13**12*0*3*80*143*31*106##>, <*#*1##>]
2021-06-04 09:06:49.225 [INFO ] [org.openwebnet4j.OpenGateway        ] - ##GW## MAC ADDRESS: 00:03:50:8f:1f:6a
2021-06-04 09:06:49.226 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#13**16##
2021-06-04 09:06:49.227 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#13**16##
2021-06-04 09:06:49.336 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#13**16*2*0*51##
2021-06-04 09:06:49.352 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*#13**16*2*0*51##>, <*#*1##>]
2021-06-04 09:06:49.354 [INFO ] [org.openwebnet4j.OpenGateway        ] - ##GW## FIRMWARE: 2.0.51
2021-06-04 09:06:49.354 [INFO ] [org.openwebnet4j.OpenGateway        ] - ##GW## ============ OpenGateway CONNECTED! ============
2021-06-04 09:06:49.379 [INFO ] [bnet.handler.OpenWebNetBridgeHandler] - ---- CONNECTED to BUS gateway bridge 'openwebnet:bus_gateway:F454_xxxxxxxxxxxx' (xxxxxxxxxxxx)
2021-06-04 09:06:49.385 [INFO ] [bnet.handler.OpenWebNetBridgeHandler] - properties updated for bridge 'openwebnet:bus_gateway:F454_xxxxxxxxxxxx'
2021-06-04 09:06:49.498 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#18*52*#1200#1*10##
2021-06-04 09:06:49.499 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#18*52*#1200#1*10##
2021-06-04 09:06:49.656 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*#*1##>]
2021-06-04 09:06:49.776 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*1200#1*10##
2021-06-04 09:06:49.817 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*587##
2021-06-04 09:06:49.910 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *2*0*0411#4#03##
2021-06-04 09:06:49.924 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *2*0*0411#4#03##

2021-06-04 09:06:50.000 [INFO ] [.handler.FlashBriefingProfileHandler] - FlashBriefingProfileHandler initialized
2021-06-04 09:06:50.098 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*#*1##>]
2021-06-04 09:06:50.098 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*1000#0*0411#4#03##
2021-06-04 09:06:50.102 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#18*52*#1200#1*10##
2021-06-04 09:06:50.103 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#18*52*#1200#1*10##
2021-06-04 09:06:50.123 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*0411#4#03##
2021-06-04 09:06:50.265 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*#*1##>]
2021-06-04 09:06:50.267 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#1*0##
2021-06-04 09:06:50.268 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#1*0##
2021-06-04 09:06:50.360 [INFO ] [mekit.internal.HomekitChangeListener] - Created 0 HomeKit items.
2021-06-04 09:06:50.420 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*1200#1*10##
2021-06-04 09:06:50.475 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*587##
2021-06-04 09:06:50.637 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*40#4#01##
2021-06-04 09:06:50.711 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*46#4#01##
2021-06-04 09:06:50.796 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*01##
2021-06-04 09:06:50.889 [INFO ] [netty.handler.logging.LoggingHandler] - [id: 0x08fb543c] REGISTERED
2021-06-04 09:06:50.894 [INFO ] [netty.handler.logging.LoggingHandler] - [id: 0x08fb543c] BIND: 0.0.0.0/0.0.0.0:9123
2021-06-04 09:06:50.900 [INFO ] [er.impl.jmdns.JmdnsHomekitAdvertiser] - Registering _hap._tcp.local. on port 9123
2021-06-04 09:06:50.906 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*01#4#01##

2021-06-04 09:06:51.035 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*11#4#03##
2021-06-04 09:06:51.037 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*02#4#01##
2021-06-04 09:06:51.038 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0010##
2021-06-04 09:06:51.042 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*11#4#01##
2021-06-04 09:06:51.087 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*03##
2021-06-04 09:06:51.088 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*12#4#01##
2021-06-04 09:06:51.146 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*02##
2021-06-04 09:06:51.206 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*21#4#01##
2021-06-04 09:06:51.207 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*04##
2021-06-04 09:06:51.266 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*22#4#01##
2021-06-04 09:06:51.326 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*31#4#01##
2021-06-04 09:06:51.327 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*41#4#01##
2021-06-04 09:06:51.387 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*61#4#01##
2021-06-04 09:06:51.441 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*71#4#01##
2021-06-04 09:06:51.481 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*81#4#01##
2021-06-04 09:06:51.551 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*72#4#01##
2021-06-04 09:06:51.621 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*82#4#01##
2021-06-04 09:06:51.682 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1001#4#01##
2021-06-04 09:06:51.683 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*91#4#01##
2021-06-04 09:06:51.741 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1002#4#01##
2021-06-04 09:06:51.745 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = xxxxxxxxxxxxxxx, base URL = http://localhost:8080)

2021-06-04 09:06:53.975 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*27#4#01##
2021-06-04 09:06:53.977 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*18#4#01##
2021-06-04 09:06:54.021 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*37#4#01##
2021-06-04 09:06:54.065 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*47#4#01##
2021-06-04 09:06:54.120 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*57#4#01##
2021-06-04 09:06:54.212 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*48#4#01##
2021-06-04 09:06:54.266 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*67#4#01##
2021-06-04 09:06:54.267 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*87#4#01##
2021-06-04 09:06:54.316 [INFO ] [vice.internal.HttpServiceFactoryImpl] - Binding bundle: [org.openhab.ui.habpanel_3.1.0.M5 [283]] to http service
2021-06-04 09:06:54.356 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*88#4#01##
2021-06-04 09:06:54.357 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*28#4#01##
2021-06-04 09:06:54.369 [INFO ] [rg.ops4j.pax.web.utils.ClassPathUtil] - Ignoring bundle scan for /META-INF/services javax.servlet.ServletContainerInitializer.
2021-06-04 09:06:54.388 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering context DefaultHttpContext [bundle=org.openhab.ui.habpanel_3.1.0.M5 [283], contextID=default], with context-name: 
2021-06-04 09:06:54.393 [INFO ] [ce.jetty.internal.HttpServiceContext] - registering JasperInitializer
2021-06-04 09:06:54.401 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*38#4#01##
2021-06-04 09:06:54.461 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*58#4#01##
2021-06-04 09:06:54.464 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/c-1_0-rt.tld
2021-06-04 09:06:54.511 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*68#4#01##
2021-06-04 09:06:54.516 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/c-1_0.tld
2021-06-04 09:06:54.562 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*78#4#01##
2021-06-04 09:06:54.602 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/c-1_1.tld
2021-06-04 09:06:54.610 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*79#4#01##
2021-06-04 09:06:54.612 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*29#4#01##
2021-06-04 09:06:54.623 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/c.tld
2021-06-04 09:06:54.647 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/fmt-1_0-rt.tld
2021-06-04 09:06:54.661 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*19#4#01##
2021-06-04 09:06:54.671 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/fmt-1_0.tld
2021-06-04 09:06:54.687 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/fmt.tld
2021-06-04 09:06:54.710 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/fn.tld
2021-06-04 09:06:54.715 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/permittedTaglibs.tld
2021-06-04 09:06:54.727 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/scriptfree.tld
2021-06-04 09:06:54.730 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/sql-1_0-rt.tld
2021-06-04 09:06:54.737 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*39#4#01##
2021-06-04 09:06:54.737 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/sql-1_0.tld
2021-06-04 09:06:54.761 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/sql.tld
2021-06-04 09:06:54.767 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/x-1_0-rt.tld
2021-06-04 09:06:54.795 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/x-1_0.tld
2021-06-04 09:06:54.796 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*59#4#01##
2021-06-04 09:06:54.805 [INFO ] [org.ops4j.pax.web.jsp.TldScanner    ] - found TLD bundleresource://223.fwk25594263/META-INF/x.tld
2021-06-04 09:06:54.841 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*69#4#01##
2021-06-04 09:06:54.891 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*89#4#01##
2021-06-04 09:06:54.893 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0110#4#01##
2021-06-04 09:06:54.915 [INFO ] [.jetty.server.handler.ContextHandler] - Started HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.habpanel_3.1.0.M5 [283], contextID=default]}
2021-06-04 09:06:54.922 [INFO ] [ab.ui.habpanel.internal.HABPanelTile] - Started HABPanel at /habpanel
2021-06-04 09:06:54.941 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*1*0111#4#01##

==> /var/log/openhab/events.log <==
2021-06-04 09:06:55.016 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:0013h4h01' changed from UNKNOWN: Waiting state update... to ONLINE
2021-06-04 09:06:55.062 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:0014h4h01' changed from UNKNOWN: Waiting state update... to ONLINE
2021-06-04 09:06:55.101 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:24' changed from UNKNOWN: Waiting state update... to ONLINE
2021-06-04 09:06:55.228 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:09' changed from UNKNOWN: Waiting state update... to ONLINE
2021-06-04 09:06:55.306 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:08' changed from UNKNOWN: Waiting state update... to ONLINE
2021-06-04 09:06:55.313 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:0012' changed from UNKNOWN: Waiting state update... to ONLINE
2021-06-04 09:06:55.447 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:0011' changed from UNKNOWN: Waiting state update... to ONLINE
2021-06-04 09:06:55.482 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'openwebnet:bus_on_off_switch:F454_xxxxxxxxxxxx:71h4h03' changed from UNKNOWN: Waiting state update... to ONLINE

2021-06-04 09:06:56.705 [INFO ] [org.openhab.rule.2b4fe99a63         ] - TO APIO (false) > 111 pompapozzo 1
2021-06-04 09:06:56.726 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*53#4#03##
2021-06-04 09:06:56.727 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*93#4#03##
2021-06-04 09:06:56.727 [INFO ] [ery.OpenWebNetDeviceDiscoveryService] - newDiscoveryResult() WHERE=w:53#4#03, deviceType=SCS_SHUTTER_CONTROL
2021-06-04 09:06:56.776 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*1003#4#03##
2021-06-04 09:06:56.778 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*04#4#03##
2021-06-04 09:06:56.827 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*#*1##>]
2021-06-04 09:06:56.828 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#1*0##
2021-06-04 09:06:56.829 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#1*0##
2021-06-04 09:06:56.837 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*1000#0*0411#4#03##
2021-06-04 09:06:56.907 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*04#4#03##
2021-06-04 09:06:56.908 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*44#4#03##
2021-06-04 09:06:56.911 [INFO ] [ery.OpenWebNetDeviceDiscoveryService] - newDiscoveryResult() WHERE=w:44#4#03, deviceType=SCS_SHUTTER_CONTROL

2021-06-04 09:07:13.016 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*586##
2021-06-04 09:07:13.097 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*13#4#01##
2021-06-04 09:07:13.101 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*23#4#01##
2021-06-04 09:07:13.182 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*14#4#01##
2021-06-04 09:07:13.184 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*24#4#01##
2021-06-04 09:07:13.241 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*13#4#01##
2021-06-04 09:07:13.244 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*23#4#01##
2021-06-04 09:07:13.297 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*14#4#01##
2021-06-04 09:07:13.341 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*24#4#01##
2021-06-04 09:07:13.442 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*33#4#01##
2021-06-04 09:07:13.506 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*43#4#01##
2021-06-04 09:07:13.508 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*33#4#01##
2021-06-04 09:07:13.532 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*2*0*99#4#03##>, <*2*0*99#4#03##>, <*2*0*1009#4#03##>, <*2*0*1009#4#03##>, <*2*0*0411#4#03##>, <*2*0*0411#4#03##>, <*2*0*0411#4#03##>, <*2*0*51#4#03##>, <*2*0*1001#4#03##>, <*2*0*42#4#03##>, <*2*0*92#4#03##>, <*2*0*1002#4#03##>, <*2*0*33#4#03##>, <*2*0*53#4#03##>, <*2*0*93#4#03##>, <*2*0*1003#4#03##>, <*2*0*04#4#03##>, <*2*0*44#4#03##>, <*2*0*94#4#03##>, <*2*0*1004#4#03##>, <*2*0*35#4#03##>, <*2*0*55#4#03##>, <*2*0*95#4#03##>, <*2*0*1005#4#03##>, <*2*0*46#4#03##>, <*2*0*96#4#03##>, <*2*0*1006#4#03##>, <*2*0*37#4#03##>, <*2*0*97#4#03##>, <*2*0*1007#4#03##>, <*2*0*38#4#03##>, <*2*0*48#4#03##>, <*2*0*98#4#03##>, <*2*0*99#4#03##>, <*2*0*1009#4#03##>, <*2*0*0411#4#03##>, <*2*0*31#4#01##>, <*2*0*41#4#01##>, <*2*0*31#4#01##>, <*2*0*41#4#01##>, <*2*0*61#4#01##>, <*2*0*61#4#01##>, <*2*0*32#4#01##>, <*2*0*32#4#01##>, <*2*0*42#4#01##>, <*2*0*32#4#01##>, <*2*0*42#4#01##>, <*2*0*52#4#01##>, <*2*0*62#4#01##>, <*2*0*52#4#01##>, <*2*0*62#4#01##>, <*2*0*33#4#01##>, <*2*0*43#4#01##>, <*#*0##>]
2021-06-04 09:07:13.533 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#1*0##
2021-06-04 09:07:13.534 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#1*0##
2021-06-04 09:07:13.576 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*43#4#01##
2021-06-04 09:07:13.579 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*53#4#01##
2021-06-04 09:07:13.636 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*63#4#01##
2021-06-04 09:07:13.712 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*53#4#01##
2021-06-04 09:07:13.792 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*63#4#01##
2021-06-04 09:07:13.892 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*83#4#01##
2021-06-04 09:07:13.894 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#1*73#4#01*4*100*2##
2021-06-04 09:07:13.897 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*84#4#01##
2021-06-04 09:07:13.977 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#1*73#4#01*4*100*2##
2021-06-04 09:07:13.981 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*83#4#01##
2021-06-04 09:07:14.037 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*93#4#01##
2021-06-04 09:07:14.087 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*84#4#01##
2021-06-04 09:07:14.090 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*93#4#01##
2021-06-04 09:07:14.147 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*34#4#01##
2021-06-04 09:07:14.191 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*54#4#01##
2021-06-04 09:07:14.272 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*64#4#01##
2021-06-04 09:07:14.342 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*54#4#01##
2021-06-04 09:07:14.344 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*34#4#01##
2021-06-04 09:07:14.422 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*54#4#01##
2021-06-04 09:07:14.424 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*64#4#01##
2021-06-04 09:07:14.486 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*54#4#01##
2021-06-04 09:07:14.546 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*74#4#01##
2021-06-04 09:07:14.605 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*75#4#01##
2021-06-04 09:07:14.608 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*76#4#01##
2021-06-04 09:07:14.682 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*77#4#01##
2021-06-04 09:07:14.684 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*74#4#01##
2021-06-04 09:07:14.736 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*75#4#01##
2021-06-04 09:07:14.822 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*76#4#01##
2021-06-04 09:07:14.872 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*77#4#01##
2021-06-04 09:07:14.874 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*15#4#01##
2021-06-04 09:07:14.937 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*25#4#01##
2021-06-04 09:07:14.996 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*35#4#01##
2021-06-04 09:07:15.086 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*16#4#01##
2021-06-04 09:07:15.166 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*25#4#01##
2021-06-04 09:07:15.168 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*35#4#01##
2021-06-04 09:07:15.170 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*25#4#01##
2021-06-04 09:07:15.226 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*15#4#01##
2021-06-04 09:07:15.301 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*45#4#01##
2021-06-04 09:07:15.346 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*16#4#01##
2021-06-04 09:07:15.391 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*44#4#01##
2021-06-04 09:07:15.486 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*45#4#01##
2021-06-04 09:07:15.541 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*65#4#01##
2021-06-04 09:07:15.543 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*44#4#01##
2021-06-04 09:07:15.606 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*85#4#01##
2021-06-04 09:07:15.608 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*65#4#01##
2021-06-04 09:07:15.681 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1005#4#01##
2021-06-04 09:07:15.741 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*86#4#01##
2021-06-04 09:07:15.806 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1006#4#01##
2021-06-04 09:07:15.872 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*85#4#01##
2021-06-04 09:07:15.875 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1007#4#01##
2021-06-04 09:07:15.976 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*86#4#01##
2021-06-04 09:07:16.052 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1008#4#01##
2021-06-04 09:07:16.054 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1005#4#01##
2021-06-04 09:07:16.056 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*26#4#01##
2021-06-04 09:07:16.101 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1006#4#01##
2021-06-04 09:07:16.167 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1007#4#01##
2021-06-04 09:07:16.222 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*26#4#01##
2021-06-04 09:07:16.224 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1008#4#01##
2021-06-04 09:07:16.226 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*36#4#01##
2021-06-04 09:07:16.276 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*56#4#01##
2021-06-04 09:07:16.336 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*36#4#01##
2021-06-04 09:07:16.396 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*56#4#01##
2021-06-04 09:07:16.466 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*66#4#01##
2021-06-04 09:07:16.468 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*66#4#01##
2021-06-04 09:07:16.552 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*17#4#01##
2021-06-04 09:07:16.608 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*27#4#01##
2021-06-04 09:07:16.610 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*18#4#01##
2021-06-04 09:07:16.692 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*27#4#01##
2021-06-04 09:07:16.806 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*17#4#01##
2021-06-04 09:07:16.808 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*37#4#01##
2021-06-04 09:07:16.866 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*18#4#01##
2021-06-04 09:07:16.868 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*37#4#01##
2021-06-04 09:07:16.957 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*47#4#01##
2021-06-04 09:07:17.026 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*57#4#01##
2021-06-04 09:07:17.028 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*48#4#01##
2021-06-04 09:07:17.029 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*57#4#01##
2021-06-04 09:07:17.077 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*47#4#01##
2021-06-04 09:07:17.136 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*67#4#01##
2021-06-04 09:07:17.217 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*48#4#01##
2021-06-04 09:07:17.266 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*67#4#01##
2021-06-04 09:07:17.268 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*87#4#01##
2021-06-04 09:07:17.346 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*88#4#01##
2021-06-04 09:07:17.421 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*87#4#01##
2021-06-04 09:07:17.423 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*88#4#01##
2021-06-04 09:07:17.487 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*28#4#01##
2021-06-04 09:07:17.591 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*38#4#01##
2021-06-04 09:07:17.593 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*28#4#01##
2021-06-04 09:07:17.655 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*38#4#01##
2021-06-04 09:07:17.657 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*58#4#01##
2021-06-04 09:07:17.706 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*68#4#01##
2021-06-04 09:07:17.751 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*78#4#01##
2021-06-04 09:07:17.752 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*58#4#01##
2021-06-04 09:07:17.822 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*68#4#01##
2021-06-04 09:07:17.887 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*79#4#01##
2021-06-04 09:07:17.991 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*78#4#01##
2021-06-04 09:07:17.993 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*79#4#01##
2021-06-04 09:07:18.042 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*29#4#01##
2021-06-04 09:07:18.111 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*19#4#01##
2021-06-04 09:07:18.113 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*29#4#01##
2021-06-04 09:07:18.161 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*19#4#01##
2021-06-04 09:07:18.236 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*39#4#01##
2021-06-04 09:07:18.326 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*59#4#01##
2021-06-04 09:07:18.328 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*39#4#01##
2021-06-04 09:07:18.386 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*59#4#01##
2021-06-04 09:07:18.387 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*69#4#01##
2021-06-04 09:07:18.441 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*89#4#01##
2021-06-04 09:07:18.506 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*69#4#01##
2021-06-04 09:07:18.602 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*89#4#01##
2021-06-04 09:07:18.604 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0110#4#01##
2021-06-04 09:07:18.605 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*1*0111#4#01##
2021-06-04 09:07:18.677 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0110#4#01##
2021-06-04 09:07:18.747 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*1*0111#4#01##
2021-06-04 09:07:18.801 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0013#4#01##
2021-06-04 09:07:18.857 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0014#4#01##
2021-06-04 09:07:18.859 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0013#4#01##
2021-06-04 09:07:18.917 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0014#4#01##
2021-06-04 09:07:19.136 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*40#4#01##
2021-06-04 09:07:19.211 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*01##
2021-06-04 09:07:19.301 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*46#4#01##
2021-06-04 09:07:19.356 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0010##
2021-06-04 09:07:19.357 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*01#4#01##
2021-06-04 09:07:19.426 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*03##
2021-06-04 09:07:19.506 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*02#4#01##
2021-06-04 09:07:19.561 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*02##
2021-06-04 09:07:19.562 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*04##
2021-06-04 09:07:19.564 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*24##
2021-06-04 09:07:19.656 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*09##
2021-06-04 09:07:19.712 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*1*0*83#4#01##>, <*#1*73#4#01*4*100*2##>, <*1*0*84#4#01##>, <*#1*73#4#01*4*100*2##>, <*1*0*83#4#01##>, <*1*0*93#4#01##>, <*1*0*84#4#01##>, <*1*0*93#4#01##>, <*1*0*54#4#01##>, <*1*0*54#4#01##>, <*1*0*54#4#01##>, <*1*0*54#4#01##>, <*1*0*74#4#01##>, <*1*0*75#4#01##>, <*1*0*76#4#01##>, <*1*0*77#4#01##>, <*1*0*74#4#01##>, <*1*0*75#4#01##>, <*1*0*76#4#01##>, <*1*0*77#4#01##>, <*1*0*15#4#01##>, <*1*0*25#4#01##>, <*1*0*16#4#01##>, <*1*0*25#4#01##>, <*1*0*25#4#01##>, <*1*0*15#4#01##>, <*1*0*45#4#01##>, <*1*0*16#4#01##>, <*1*0*44#4#01##>, <*1*0*45#4#01##>, <*1*0*44#4#01##>, <*1*0*85#4#01##>, <*1*0*1005#4#01##>, <*1*0*86#4#01##>, <*1*0*1006#4#01##>, <*1*0*85#4#01##>, <*1*0*1007#4#01##>, <*1*0*86#4#01##>, <*1*0*1008#4#01##>, <*1*0*1005#4#01##>, <*1*0*1006#4#01##>, <*1*0*1007#4#01##>, <*1*0*1008#4#01##>, <*1*0*17#4#01##>, <*1*0*18#4#01##>, <*1*0*17#4#01##>, <*1*0*18#4#01##>, <*1*0*47#4#01##>, <*1*0*48#4#01##>, <*1*0*47#4#01##>, <*1*0*48#4#01##>, <*1*0*87#4#01##>, <*1*0*88#4#01##>, <*1*0*87#4#01##>, <*1*0*88#4#01##>, <*1*0*78#4#01##>, <*1*0*79#4#01##>, <*1*0*78#4#01##>, <*1*0*79#4#01##>, <*1*0*19#4#01##>, <*1*0*19#4#01##>, <*1*0*89#4#01##>, <*1*0*89#4#01##>, <*1*0*0110#4#01##>, <*1*1*0111#4#01##>, <*1*0*0110#4#01##>, <*1*1*0111#4#01##>, <*1*0*0013#4#01##>, <*1*0*0014#4#01##>, <*1*0*0013#4#01##>, <*1*0*0014#4#01##>, <*1*0*40#4#01##>, <*1*0*01##>, <*1*0*46#4#01##>, <*1*0*0010##>, <*1*0*01#4#01##>, <*1*0*03##>, <*1*0*02#4#01##>, <*1*0*02##>, <*1*0*04##>, <*1*0*24##>, <*1*0*09##>, <*1*0*11#4#01##>, <*1*0*08##>, <*#*1##>]
2021-06-04 09:07:19.714 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#2*0##
2021-06-04 09:07:19.715 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#2*0##
2021-06-04 09:07:19.721 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*11#4#01##
2021-06-04 09:07:19.722 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*08##
2021-06-04 09:07:19.776 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*12#4#01##
2021-06-04 09:07:19.777 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*21#4#01##
2021-06-04 09:07:19.846 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*31#4#01##
2021-06-04 09:07:19.911 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*22#4#01##
2021-06-04 09:07:19.950 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*41#4#01##
2021-06-04 09:07:20.016 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*61#4#01##
2021-06-04 09:07:20.017 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*71#4#01##
2021-06-04 09:07:20.171 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*81#4#01##
2021-06-04 09:07:20.221 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*72#4#01##
2021-06-04 09:07:20.222 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*82#4#01##
2021-06-04 09:07:20.224 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1001#4#01##
2021-06-04 09:07:20.316 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*91#4#01##
2021-06-04 09:07:20.318 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1002#4#01##
2021-06-04 09:07:20.461 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1003#4#01##
2021-06-04 09:07:20.511 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*32#4#01##
2021-06-04 09:07:20.512 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*1004#4#01##
2021-06-04 09:07:20.565 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*42#4#01##
2021-06-04 09:07:20.567 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*52#4#01##
2021-06-04 09:07:20.616 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*62#4#01##
2021-06-04 09:07:20.618 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*92#4#01##
2021-06-04 09:07:20.673 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*13#4#01##
2021-06-04 09:07:20.736 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*23#4#01##
2021-06-04 09:07:20.792 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*14#4#01##
2021-06-04 09:07:20.847 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*24#4#01##
2021-06-04 09:07:20.881 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*33#4#01##
2021-06-04 09:07:20.931 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*43#4#01##
2021-06-04 09:07:20.976 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*53#4#01##
2021-06-04 09:07:21.041 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*63#4#01##
2021-06-04 09:07:21.096 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*83#4#01##
2021-06-04 09:07:21.098 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#1*73#4#01*4*100*2##
2021-06-04 09:07:21.136 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*84#4#01##
2021-06-04 09:07:21.196 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*93#4#01##
2021-06-04 09:07:21.292 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*34#4#01##
2021-06-04 09:07:21.346 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*54#4#01##
2021-06-04 09:07:21.347 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*64#4#01##
2021-06-04 09:07:21.431 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*54#4#01##
2021-06-04 09:07:21.538 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*74#4#01##
2021-06-04 09:07:21.538 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*2*0*41#4#01##>, <*2*0*61#4#01##>, <*2*0*32#4#01##>, <*2*0*42#4#01##>, <*2*0*52#4#01##>, <*2*0*62#4#01##>, <*2*0*33#4#01##>, <*2*0*43#4#01##>, <*2*0*53#4#01##>, <*2*0*63#4#01##>, <*2*0*34#4#01##>, <*2*0*64#4#01##>, <*#*0##>]
2021-06-04 09:07:21.539 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#1*0##

JUMPING TO END

2021-06-04 09:21:48.703 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON -------> *#*1##
2021-06-04 09:21:48.704 [INFO ] [communication.BUSConnector.keepalive] - BUS-MON =KA=>>>> *#*1##
2021-06-04 09:21:48.748 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0412#4#03##
2021-06-04 09:21:48.833 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0413#4#03##
2021-06-04 09:21:48.835 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0412#4#03##
2021-06-04 09:21:48.883 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0415#4#03##
2021-06-04 09:21:48.884 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0414#4#03##
2021-06-04 09:21:48.943 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0415#4#03##
2021-06-04 09:21:49.038 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0414#4#03##

==> /var/log/openhab/events.log <==
2021-06-04 09:21:55.042 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'EnergyMeterWHERE52_Power' changed from 507 W to 485 W

==> /var/log/openhab/openhab.log <==
2021-06-04 09:21:55.034 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*485##

==> /var/log/openhab/events.log <==
2021-06-04 09:22:24.887 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'EnergyMeterWHERE52_Power' changed from 485 W to 486 W

==> /var/log/openhab/openhab.log <==
2021-06-04 09:22:24.879 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*486##
2021-06-04 09:22:54.764 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*486##
2021-06-04 09:23:18.704 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON -------> *#*1##
2021-06-04 09:23:18.704 [INFO ] [communication.BUSConnector.keepalive] - BUS-MON =KA=>>>> *#*1##

I know it’s really long but you can see this way the repetition of scanning… started at 9:06, ended at 09:23 (now the bus runs normal).

It seems that there’s a sort of “reset” on the bus and the system starts to re-scan everything all the times.

I’ll collect DEBUG also

Rob-VF · June 4, 2021, 8:21am

Adding also the DEBUG:

2021-06-04 09:41:49.524 [DEBUG] [org.eclipse.jetty.server.session    ] - Entering scope org.eclipse.jetty.server.session.SessionHandler29294729==dftMaxIdleSec=600, dispatch=REQUEST asyncstarted=false
2021-06-04 09:41:49.524 [DEBUG] [org.eclipse.jetty.server.session    ] - sessionHandler=org.eclipse.jetty.server.session.SessionHandler29294729==dftMaxIdleSec=600 session=null
2021-06-04 09:41:49.525 [DEBUG] [eclipse.jetty.servlet.ServletHandler] - servlet /rest||/sitemaps/events/........ -> cxf-servlet==org.apache.aries.jax.rs.whiteboard.internal.Whiteboard$1@e2fb1709{jsp=null,order=-1,inst=true,async=true,src=EMBEDDED:null}
2021-06-04 09:41:49.526 [DEBUG] [ce.jetty.internal.HttpServiceContext] - Handling request for [/sitemaps/events/97d6a248-a707-44d6-88dd-f7088b498d43] using http context [org.ops4j.pax.web.extender.whiteboard.internal.WebApplication$1@6fd1b3]
2021-06-04 09:41:49.526 [DEBUG] [y.internal.HttpServiceServletHandler] - handling request org.ops4j.pax.web.service.jetty.internal.HttpServiceRequestWrapper@12cded6, org.ops4j.pax.web.service.jetty.internal.HttpServiceResponseWrapper@b49161
2021-06-04 09:41:49.527 [DEBUG] [eclipse.jetty.servlet.ServletHandler] - chain=null
2021-06-04 09:41:49.532 [DEBUG] [org.eclipse.jetty.server.session    ] - Leaving scope org.eclipse.jetty.server.session.SessionHandler29294729==dftMaxIdleSec=600 dispatch=REQUEST, async=true, session=null, oldsession=null, oldsessionhandler=null
021-06-04 09:41:49.536 [DEBUG] [y.util.thread.ReservedThreadExecutor] - ReservedThreadExecutor@1f761d1{s=2/4,p=0}@a0e77c waiting
2021-06-04 09:41:49.552 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*1*0*88#4#03##]
2021-06-04 09:41:49.553 [DEBUG] [.openwebnet4j.communication.Response] - <*#1*0##>   <<add   <*1*0*88#4#03##>
2021-06-04 09:41:49.554 [DEBUG] [.openwebnet4j.communication.Response] - now: <*#1*0##>   <<==    [<*1*0*89#4#03##>, <*1*0*66#4#03##>, <*1*0*86#4#03##>, <*1*0*67#4#03##>, <*1*0*87#4#03##>, <*1*0*68#4#03##>, <*1*0*88#4#03##>, <*1*0*66#4#03##>, <*1*0*89#4#03##>, <*1*0*67#4#03##>, <*1*0*86#4#03##>, <*1*0*68#4#03##>, <*1*0*87#4#03##>, <*1*0*69#4#03##>, <*1*0*88#4#03##>, <*1*0*86#4#03##>, <*1*0*87#4#03##>, <*1*0*88#4#03##>, <*1*0*89#4#03##>, <*1*0*17#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*11#4#03##>, <*1*0*12#4#03##>, <*1*0*71#4#03##>, <*1*0*91#4#03##>, <*1*0*72#4#03##>, <*1*0*0010#4#03##>, <*1*0*0010#4#03##>, <*1*0*73#4#03##>, <*1*0*74#4#03##>, <*1*0*32#4#03##>, <*1*0*24#4#03##>, <*1*0*62#4#03##>, <*1*0*63#4#03##>, <*1*0*13#4#03##>, <*1*0*14#4#03##>, <*1*0*54#4#03##>, <*1*0*64#4#03##>, <*1*0*52#4#03##>, <*1*0*65#4#03##>, <*1*0*84#4#03##>, <*1*0*85#4#03##>, <*1*0*15#4#03##>, <*1*0*25#4#03##>, <*1*0*07#4#03##>, <*1*0*26#4#03##>, <*1*0*75#4#03##>, <*1*0*76#4#03##>, <*1*0*77#4#03##>, <*1*0*78#4#03##>, <*1*0*16#4#03##>, <*1*0*31#4#03##>, <*1*0*66#4#03##>, <*1*0*86#4#03##>, <*1*0*67#4#03##>, <*1*0*87#4#03##>, <*1*0*68#4#03##>, <*1*0*88#4#03##>]
2021-06-04 09:41:49.555 [DEBUG] [j.communication.BUSConnector.message] - BUS-CMD   <<==   *1*0*88#4#03##
2021-06-04 09:41:49.555 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*1*0*69#4#03##]
2021-06-04 09:41:49.556 [DEBUG] [.openwebnet4j.communication.Response] - <*#1*0##>   <<add   <*1*0*69#4#03##>
2021-06-04 09:41:49.557 [DEBUG] [.openwebnet4j.communication.Response] - now: <*#1*0##>   <<==    [<*1*0*89#4#03##>, <*1*0*66#4#03##>, <*1*0*86#4#03##>, <*1*0*67#4#03##>, <*1*0*87#4#03##>, <*1*0*68#4#03##>, <*1*0*88#4#03##>, <*1*0*66#4#03##>, <*1*0*89#4#03##>, <*1*0*67#4#03##>, <*1*0*86#4#03##>, <*1*0*68#4#03##>, <*1*0*87#4#03##>, <*1*0*69#4#03##>, <*1*0*88#4#03##>, <*1*0*86#4#03##>, <*1*0*87#4#03##>, <*1*0*88#4#03##>, <*1*0*89#4#03##>, <*1*0*17#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*11#4#03##>, <*1*0*12#4#03##>, <*1*0*71#4#03##>, <*1*0*91#4#03##>, <*1*0*72#4#03##>, <*1*0*0010#4#03##>, <*1*0*0010#4#03##>, <*1*0*73#4#03##>, <*1*0*74#4#03##>, <*1*0*32#4#03##>, <*1*0*24#4#03##>, <*1*0*62#4#03##>, <*1*0*63#4#03##>, <*1*0*13#4#03##>, <*1*0*14#4#03##>, <*1*0*54#4#03##>, <*1*0*64#4#03##>, <*1*0*52#4#03##>, <*1*0*65#4#03##>, <*1*0*84#4#03##>, <*1*0*85#4#03##>, <*1*0*15#4#03##>, <*1*0*25#4#03##>, <*1*0*07#4#03##>, <*1*0*26#4#03##>, <*1*0*75#4#03##>, <*1*0*76#4#03##>, <*1*0*77#4#03##>, <*1*0*78#4#03##>, <*1*0*16#4#03##>, <*1*0*31#4#03##>, <*1*0*66#4#03##>, <*1*0*86#4#03##>, <*1*0*67#4#03##>, <*1*0*87#4#03##>, <*1*0*68#4#03##>, <*1*0*88#4#03##>, <*1*0*69#4#03##>]
2021-06-04 09:41:49.557 [DEBUG] [j.communication.BUSConnector.message] - BUS-CMD   <<==   *1*0*69#4#03##
2021-06-04 09:41:49.598 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*69#4#03##]
2021-06-04 09:41:49.598 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*69#4#03##
2021-06-04 09:41:49.600 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*89#4#03##]
2021-06-04 09:41:49.600 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*89#4#03##
2021-06-04 09:41:49.634 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*1*0*89#4#03##]
2021-06-04 09:41:49.635 [DEBUG] [.openwebnet4j.communication.Response] - <*#1*0##>   <<add   <*1*0*89#4#03##>
2021-06-04 09:41:49.635 [DEBUG] [.openwebnet4j.communication.Response] - now: <*#1*0##>   <<==    [<*1*0*89#4#03##>, <*1*0*66#4#03##>, <*1*0*86#4#03##>, <*1*0*67#4#03##>, <*1*0*87#4#03##>, <*1*0*68#4#03##>, <*1*0*88#4#03##>, <*1*0*66#4#03##>, <*1*0*89#4#03##>, <*1*0*67#4#03##>, <*1*0*86#4#03##>, <*1*0*68#4#03##>, <*1*0*87#4#03##>, <*1*0*69#4#03##>, <*1*0*88#4#03##>, <*1*0*86#4#03##>, <*1*0*87#4#03##>, <*1*0*88#4#03##>, <*1*0*89#4#03##>, <*1*0*17#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*27#4#03##>, <*1*0*17#4#03##>, <*1*0*21#4#03##>, <*1*0*23#4#03##>, <*1*0*11#4#03##>, <*1*0*12#4#03##>, <*1*0*71#4#03##>, <*1*0*91#4#03##>, <*1*0*72#4#03##>, <*1*0*0010#4#03##>, <*1*0*0010#4#03##>, <*1*0*73#4#03##>, <*1*0*74#4#03##>, <*1*0*32#4#03##>, <*1*0*24#4#03##>, <*1*0*62#4#03##>, <*1*0*63#4#03##>, <*1*0*13#4#03##>, <*1*0*14#4#03##>, <*1*0*54#4#03##>, <*1*0*64#4#03##>, <*1*0*52#4#03##>, <*1*0*65#4#03##>, <*1*0*84#4#03##>, <*1*0*85#4#03##>, <*1*0*15#4#03##>, <*1*0*25#4#03##>, <*1*0*07#4#03##>, <*1*0*26#4#03##>, <*1*0*75#4#03##>, <*1*0*76#4#03##>, <*1*0*77#4#03##>, <*1*0*78#4#03##>, <*1*0*16#4#03##>, <*1*0*31#4#03##>, <*1*0*66#4#03##>, <*1*0*86#4#03##>, <*1*0*67#4#03##>, <*1*0*87#4#03##>, <*1*0*68#4#03##>, <*1*0*88#4#03##>, <*1*0*69#4#03##>, <*1*0*89#4#03##>]
2021-06-04 09:41:49.636 [DEBUG] [j.communication.BUSConnector.message] - BUS-CMD   <<==   *1*0*89#4#03##
2021-06-04 09:41:49.653 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*96#4#03##]
2021-06-04 09:41:49.654 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*96#4#03##
2021-06-04 09:41:49.655 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*96#4#03##]
2021-06-04 09:41:49.656 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*96#4#03##
2021-06-04 09:41:49.751 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*1*0*17#4#03##]
2021-06-04 09:41:49.751 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*1006#4#03##]
2021-06-04 09:41:49.751 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*1006#4#03##


2021-06-04 09:41:50.395 [INFO ] [ery.OpenWebNetDeviceDiscoveryService] - newDiscoveryResult() WHERE=w:37#4#03, deviceType=SCS_SHUTTER_CONTROL
2021-06-04 09:41:50.418 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*1*0*21#4#03##]
2021-06-04 09:41:50.419 [DEBUG] [.openwebnet4j.communication.Response] - <*#1*0##>   <<add   <*1*0*21#4#03##>
2021-06-04 09:41:50.419 [DEBUG] [.openwebnet4j.communication.Response] - now: <*#1*0##>   <<==    [<*1*0*17#4#03##>, <*1*0*27#4#03##>, <*1*0*23#4#03##>, <*1*0*21#4#03##>, <*1*0*17#4#03##>, <*1*0*27#4#03##>, <*1*0*23#4#03##>, <*1*0*21#4#03##>]
2021-06-04 09:41:50.444 [DEBUG] [j.communication.BUSConnector.message] - BUS-CMD   <<==   *1*0*21#4#03##
2021-06-04 09:41:50.478 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*1*0*27#4#03##]
2021-06-04 09:41:50.479 [DEBUG] [.openwebnet4j.communication.Response] - <*#1*0##>   <<add   <*1*0*27#4#03##>
2021-06-04 09:41:50.480 [DEBUG] [.openwebnet4j.communication.Response] - now: <*#1*0##>   <<==    [<*1*0*17#4#03##>, <*1*0*27#4#03##>, <*1*0*23#4#03##>, <*1*0*21#4#03##>, <*1*0*17#4#03##>, <*1*0*27#4#03##>, <*1*0*23#4#03##>, <*1*0*21#4#03##>, <*1*0*27#4#03##>]
2021-06-04 09:41:50.480 [DEBUG] [j.communication.BUSConnector.message] - BUS-CMD   <<==   *1*0*27#4#03##
2021-06-04 09:41:50.492 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*27#4#03##]
2021-06-04 09:41:50.493 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*27#4#03##
2021-06-04 09:41:50.495 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*37#4#03##]
2021-06-04 09:41:50.495 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*37#4#03##
2021-06-04 09:41:50.497 [INFO ] [ery.OpenWebNetDeviceDiscoveryService] - newDiscoveryResult() WHERE=w:37#4#03, deviceType=SCS_SHUTTER_CONTROL
2021-06-04 09:41:50.543 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*1*0*21#4#03##]
2021-06-04 09:41:50.543 [DEBUG] [.openwebnet4j.communication.Response] - <*#1*0##>   <<add   <*1*0*21#4#03##>
2021-06-04 09:41:50.544 [DEBUG] [.openwebnet4j.communication.Response] - now: <*#1*0##>   <<==    [<*1*0*17#4#03##>, <*1*0*27#4#03##>, <*1*0*23#4#03##>, <*1*0*21#4#03##>, <*1*0*17#4#03##>, <*1*0*27#4#03##>, <*1*0*23#4#03##>, <*1*0*21#4#03##>, <*1*0*27#4#03##>, <*1*0*21#4#03##>]
2021-06-04 09:41:50.544 [DEBUG] [j.communication.BUSConnector.message] - BUS-CMD   <<==   *1*0*21#4#03##
2021-06-04 09:41:50.552 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*21#4#03##]
2021-06-04 09:41:50.553 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*21#4#03##
2021-06-04 09:41:50.555 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*37#4#03##]
2021-06-04 09:41:50.555 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*37#4#03##
2021-06-04 09:41:50.556 [INFO ] [ery.OpenWebNetDeviceDiscoveryService] - newDiscoveryResult() WHERE=w:37#4#03, deviceType=SCS_SHUTTER_CONTROL
2021-06-04 09:41:50.583 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*1*0*57#4#03##]
2021-06-04 09:41:50.583 [DEBUG] [.openwebnet4j.communication.Response] - <*#1*0##>   <<add   <*1*0*57#4#03##>
2021-06-04 09:41:50.584 [DEBUG] [.openwebnet4j.communication.Response] - now: <*#1*0##>   <<==    [<*1*0*17#4#03##>, <*1*0*27#4#03##>, <*1*0*23#4#03##>, <*1*0*21#4#03##>, <*1*0*17#4#03##>, <*1*0*27#4#03##>, <*1*0*23#4#03##>, <*1*0*21#4#03##>, <*1*0*27#4#03##>, <*1*0*21#4#03##>, <*1*0*57#4#03##>]
2021-06-04 09:41:50.585 [DEBUG] [j.communication.BUSConnector.message] - BUS-CMD   <<==   *1*0*57#4#03##
2021-06-04 09:41:50.613 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*57#4#03##]
2021-06-04 09:41:50.613 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*57#4#03##
2021-06-04 09:41:50.733 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*37#4#03##]

2021-06-04 10:06:22.728 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*98#4#03##
2021-06-04 10:06:22.730 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*98#4#03##]
2021-06-04 10:06:22.731 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*98#4#03##
2021-06-04 10:06:22.788 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*59#4#03##]
2021-06-04 10:06:22.788 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*59#4#03##
2021-06-04 10:06:22.848 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*79#4#03##]
2021-06-04 10:06:22.848 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*79#4#03##
2021-06-04 10:06:22.850 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*61#4#03##]
2021-06-04 10:06:22.851 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*61#4#03##
2021-06-04 10:06:22.898 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*81#4#03##]
2021-06-04 10:06:22.898 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*81#4#03##
2021-06-04 10:06:22.953 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*59#4#03##]
2021-06-04 10:06:22.954 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*59#4#03##
2021-06-04 10:06:23.008 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*82#4#03##]
2021-06-04 10:06:23.009 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*82#4#03##
2021-06-04 10:06:23.098 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*61#4#03##]
2021-06-04 10:06:23.098 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*61#4#03##
2021-06-04 10:06:23.213 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*83#4#03##]
2021-06-04 10:06:23.213 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*83#4#03##
2021-06-04 10:06:23.215 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*59#4#03##]
2021-06-04 10:06:23.216 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*59#4#03##
2021-06-04 10:06:23.267 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*79#4#03##]
2021-06-04 10:06:23.268 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*79#4#03##
2021-06-04 10:06:23.270 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*61#4#03##]
2021-06-04 10:06:23.270 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*61#4#03##
2021-06-04 10:06:23.272 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*81#4#03##]
2021-06-04 10:06:23.273 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*81#4#03##
2021-06-04 10:06:23.322 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*59#4#03##]
2021-06-04 10:06:23.323 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*59#4#03##
2021-06-04 10:06:23.403 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*82#4#03##]
2021-06-04 10:06:23.403 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*82#4#03##
2021-06-04 10:06:23.458 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*61#4#03##]
2021-06-04 10:06:23.458 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*61#4#03##
2021-06-04 10:06:23.513 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*83#4#03##]
2021-06-04 10:06:23.513 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*83#4#03##
2021-06-04 10:06:23.515 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*59#4#03##]
2021-06-04 10:06:23.515 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*59#4#03##
2021-06-04 10:06:23.568 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*79#4#03##]
2021-06-04 10:06:23.568 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*79#4#03##
2021-06-04 10:06:23.627 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*61#4#03##]
2021-06-04 10:06:23.628 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*61#4#03##
2021-06-04 10:06:23.683 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*81#4#03##]
2021-06-04 10:06:23.683 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*81#4#03##
2021-06-04 10:06:23.749 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*99#4#03##]
2021-06-04 10:06:23.750 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*99#4#03##
2021-06-04 10:06:23.803 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*82#4#03##]
2021-06-04 10:06:23.804 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*82#4#03##
2021-06-04 10:06:23.805 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*99#4#03##]
2021-06-04 10:06:23.806 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*99#4#03##
2021-06-04 10:06:23.859 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*83#4#03##]
2021-06-04 10:06:23.859 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*83#4#03##
2021-06-04 10:06:23.929 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*99#4#03##]
2021-06-04 10:06:23.929 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*99#4#03##
2021-06-04 10:06:23.931 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*79#4#03##]
2021-06-04 10:06:23.932 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*79#4#03##
2021-06-04 10:06:24.025 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*99#4#03##]
2021-06-04 10:06:24.025 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*99#4#03##
2021-06-04 10:06:24.093 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*81#4#03##]
2021-06-04 10:06:24.093 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*81#4#03##
2021-06-04 10:06:24.095 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*99#4#03##]
2021-06-04 10:06:24.095 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*99#4#03##
2021-06-04 10:06:24.188 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*82#4#03##]
2021-06-04 10:06:24.189 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*82#4#03##
2021-06-04 10:06:24.190 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*1009#4#03##]
2021-06-04 10:06:24.191 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*1009#4#03##
2021-06-04 10:06:24.243 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*83#4#03##]
2021-06-04 10:06:24.243 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*83#4#03##
2021-06-04 10:06:24.245 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*1009#4#03##]
2021-06-04 10:06:24.246 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*1009#4#03##
2021-06-04 10:06:24.298 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*79#4#03##]
2021-06-04 10:06:24.298 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*79#4#03##
2021-06-04 10:06:24.342 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*1009#4#03##]
2021-06-04 10:06:24.343 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*1009#4#03##
2021-06-04 10:06:24.408 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*81#4#03##]
2021-06-04 10:06:24.409 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*81#4#03##
2021-06-04 10:06:24.468 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*1009#4#03##]
2021-06-04 10:06:24.468 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*1009#4#03##
2021-06-04 10:06:24.470 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*82#4#03##]
2021-06-04 10:06:24.471 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*82#4#03##
2021-06-04 10:06:24.538 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*1009#4#03##]
2021-06-04 10:06:24.538 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*1009#4#03##
2021-06-04 10:06:24.597 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*83#4#03##]
2021-06-04 10:06:24.598 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*83#4#03##
2021-06-04 10:06:24.653 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0510#4#03##]
2021-06-04 10:06:24.654 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0510#4#03##
2021-06-04 10:06:24.655 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*56#4#03##]
2021-06-04 10:06:24.656 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*56#4#03##
2021-06-04 10:06:24.733 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0510#4#03##]
2021-06-04 10:06:24.733 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0510#4#03##
2021-06-04 10:06:24.735 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*56#4#03##]
2021-06-04 10:06:24.735 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*56#4#03##
2021-06-04 10:06:24.787 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0510#4#03##]
2021-06-04 10:06:24.788 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0510#4#03##
2021-06-04 10:06:25.018 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*56#4#03##]
2021-06-04 10:06:25.018 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*56#4#03##
2021-06-04 10:06:25.020 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0510#4#03##]
2021-06-04 10:06:25.020 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0510#4#03##
2021-06-04 10:06:25.022 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*56#4#03##]
2021-06-04 10:06:25.023 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*56#4#03##
2021-06-04 10:06:25.024 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0510#4#03##]
2021-06-04 10:06:25.025 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0510#4#03##
2021-06-04 10:06:25.068 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*56#4#03##]
2021-06-04 10:06:25.069 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*56#4#03##
2021-06-04 10:06:25.071 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*0411#4#03##]
2021-06-04 10:06:25.071 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*0411#4#03##
2021-06-04 10:06:25.128 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*0411#4#03##]
2021-06-04 10:06:25.128 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*0411#4#03##
2021-06-04 10:06:25.173 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*0411#4#03##]
2021-06-04 10:06:25.173 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*0411#4#03##
2021-06-04 10:06:25.258 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*0411#4#03##]
2021-06-04 10:06:25.258 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*0411#4#03##
2021-06-04 10:06:25.313 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0413#4#03##]
2021-06-04 10:06:25.313 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0413#4#03##
2021-06-04 10:06:25.353 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0412#4#03##]
2021-06-04 10:06:25.353 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0412#4#03##
2021-06-04 10:06:25.468 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*2*0*0411#4#03##]
2021-06-04 10:06:25.469 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *2*0*0411#4#03##
2021-06-04 10:06:25.573 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0413#4#03##]
2021-06-04 10:06:25.573 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0413#4#03##
2021-06-04 10:06:25.575 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0412#4#03##]
2021-06-04 10:06:25.576 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0412#4#03##
2021-06-04 10:06:25.577 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*0413#4#03##]
2021-06-04 10:06:25.578 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*0413#4#03##

==> /var/log/openhab/openhab.log <==
2021-06-04 10:06:30.315 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON -------> *#*1##
2021-06-04 10:06:30.316 [INFO ] [communication.BUSConnector.keepalive] - BUS-MON =KA=>>>> *#*1##
2021-06-04 10:06:30.368 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*1*0*15#4#04##]
2021-06-04 10:06:30.369 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *1*0*15#4#04##

==> /var/log/openhab/openhab.log <==
2021-06-04 10:06:43.528 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*#18*52*113*828##]
2021-06-04 10:06:43.528 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*828##
2021-06-04 10:06:53.657 [DEBUG] [org.apache.felix.configadmin        ] - getConfiguration(pid=org.openhab.addons)
2021-06-04 10:06:53.657 [DEBUG] [org.apache.felix.configadmin        ] - Found cached configuration org.openhab.addons bound to mvn:org.openhab.core.bundles/org.openhab.core.karaf/3.1.0.M5
2021-06-04 10:07:02.622 [DEBUG] [e.jetty.util.thread.QueuedThreadPool] - shrinking QueuedThreadPool[jupnp-jetty-client]@675e04{STARTED,5<=9<=20,i=7,r=-1,q=0}[ReservedThreadExecutor@abaf26{s=0/2,p=0}]
2021-06-04 10:07:02.623 [DEBUG] [e.jetty.util.thread.QueuedThreadPool] - Thread[jupnp-jetty-client-692,5,main] exited for QueuedThreadPool[jupnp-jetty-client]@675e04{STARTED,5<=8<=20,i=6,r=-1,q=0}[ReservedThreadExecutor@abaf26{s=0/2,p=0}]
==> /var/log/openhab/openhab.log <==
2021-06-04 10:07:13.402 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*#18*52*113*812##]
2021-06-04 10:07:13.403 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*812##
2021-06-04 10:07:25.173 [DEBUG] [org.eclipse.jetty.server.session    ] - node0 scavenging sessions
2021-06-04 10:07:25.228 [DEBUG] [org.eclipse.jetty.server.session    ] - org.eclipse.jetty.server.session.SessionHandler6327071==dftMaxIdleSec=600 scavenging session ids []
2021-06-04 10:07:25.228 [DEBUG] [org.eclipse.jetty.server.session    ] - org.eclipse.jetty.server.session.DefaultSessionCache@a396fa[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false] checking expiration on []

==> /var/log/openhab/openhab.log <==
2021-06-04 10:07:43.347 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*#18*52*113*815##]
2021-06-04 10:07:43.348 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*815##
2021-06-04 10:07:53.659 [DEBUG] [org.apache.felix.configadmin        ] - getConfiguration(pid=org.openhab.addons)
2021-06-04 10:07:53.660 [DEBUG] [org.apache.felix.configadmin        ] - Found cached configuration org.openhab.addons bound to mvn:org.openhab.core.bundles/org.openhab.core.karaf/3.1.0.M5
2021-06-04 10:07:58.302 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*#13**#1*05*04*06*2021##]
2021-06-04 10:07:58.303 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#13**#1*05*04*06*2021##
2021-06-04 10:07:58.357 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*#13**#0*10*00*00*001##]
2021-06-04 10:07:58.358 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#13**#0*10*00*00*001##
2021-06-04 10:08:00.316 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON -------> *#*1##
2021-06-04 10:08:00.317 [INFO ] [communication.BUSConnector.keepalive] - BUS-MON =KA=>>>> *#*1##
2021-06-04 10:08:01.120 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#18*52*#1200#1*10##
2021-06-04 10:08:01.122 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#18*52*#1200#1*10##
2021-06-04 10:08:01.122 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD |<--     NO DATA (size=0)
2021-06-04 10:08:01.123 [DEBUG] [nwebnet4j.communication.BUSConnector] - ##BUS-conn## Exception: Received null frame while reading responses to command
2021-06-04 10:08:01.126 [DEBUG] [nwebnet4j.communication.BUSConnector] - ##BUS-conn## trying NEW CMD connection...
2021-06-04 10:08:01.127 [DEBUG] [nwebnet4j.communication.BUSConnector] - ##BUS-conn## Establishing CMD connection to BUS Gateway on xxxxxxxxxxxx...
2021-06-04 10:08:01.247 [DEBUG] [nwebnet4j.communication.BUSConnector] - ##BUS-conn## CMD socket connected
2021-06-04 10:08:01.248 [DEBUG] [nwebnet4j.communication.BUSConnector] - (HS) starting HANDSHAKE on channel BUS-CMD... 
2021-06-04 10:08:01.250 [DEBUG] [communication.BUSConnector.handshake] - (HS) ... STEP-1: receive ACK from GW
2021-06-04 10:08:01.318 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*#*1##]
2021-06-04 10:08:01.319 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD <<<<==HS *#*1##
2021-06-04 10:08:01.320 [DEBUG] [communication.BUSConnector.handshake] - (HS) ... STEP-1: first ACK received
2021-06-04 10:08:01.320 [DEBUG] [communication.BUSConnector.handshake] - (HS) ... STEP-2: send session request *99*0## ... 
2021-06-04 10:08:01.321 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *99*0##
2021-06-04 10:08:01.322 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD HS==>>>> *99*0##
2021-06-04 10:08:01.372 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*#141049725##]
2021-06-04 10:08:01.373 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD <<<<==HS *#141049725##
2021-06-04 10:08:01.374 [DEBUG] [communication.BUSConnector.handshake] - (HS) ... STEP-2: OPEN_AUTH: received nonce=141049725 ... 
2021-06-04 10:08:01.374 [DEBUG] [communication.BUSConnector.handshake] - (HS) ... STEP-3: OPEN_AUTH: sending encoded pwd ... 
2021-06-04 10:08:01.375 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#4193910495##
2021-06-04 10:08:01.376 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD HS==>>>> *#4193910495##
2021-06-04 10:08:01.427 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*#*1##]
2021-06-04 10:08:01.428 [INFO ] [communication.BUSConnector.handshake] - (HS) BUS-CMD <<<<==HS *#*1##
2021-06-04 10:08:01.428 [DEBUG] [communication.BUSConnector.handshake] - (HS) ... STEP-3: OPEN_AUTH: pwd accepted ==HANDSHAKE COMPLETED==
2021-06-04 10:08:01.429 [INFO ] [nwebnet4j.communication.BUSConnector] - ##BUS-conn## ============ CMD CONNECTED ============
2021-06-04 10:08:01.430 [INFO ] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD -------> *#18*52*#1200#1*10##
2021-06-04 10:08:01.431 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD ====>>>> *#18*52*#1200#1*10##
2021-06-04 10:08:01.597 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-CMD <------- [*#*1##]
2021-06-04 10:08:01.598 [DEBUG] [.openwebnet4j.communication.Response] - <*#18*52*#1200#1*10##>   <<add   <*#*1##>
2021-06-04 10:08:01.598 [DEBUG] [.openwebnet4j.communication.Response] - now: <*#18*52*#1200#1*10##>   <<==    [<*#*1##>]
2021-06-04 10:08:01.599 [DEBUG] [j.communication.BUSConnector.message] - BUS-CMD   <<==   *#*1##
2021-06-04 10:08:01.599 [INFO ] [j.communication.BUSConnector.message] - BUS-CMD <<<<==== [<*#*1##>]

==> /var/log/openhab/openhab.log <==
2021-06-04 10:08:01.712 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*#18*52*1200#1*10##]
2021-06-04 10:08:01.713 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*1200#1*10##
2021-06-04 10:08:01.777 [DEBUG] [nwebnet4j.communication.FrameChannel] - -FC-BUS-MON <------- [*#18*52*113*816##]
2021-06-04 10:08:01.778 [INFO ] [unication.BUSConnector.message.event] - BUS-MON <<<<<<<< *#18*52*113*816##

Then it works ok (about 20 mins flooding)

I just checked w openhabian/Raspi4 and Linux VM… there’s no difference.

Thanks for your help

massi · June 7, 2021, 7:23am

hi @Rob-VF can you test again with the current OH3 snapshot ? (you should be able to select to update to the snapshot version from openhabian)

Rob-VF · June 8, 2021, 8:18am

Ciao Massimo,

it’s the same, just tested… about 20mins of bus flooding

R

massi · June 12, 2021, 12:51pm

Hallo. Anyone with a Thermo 4-zone setup available to do some tests with the goal of adding support for this configuration in the official binding?

Daniele_Z · June 12, 2021, 2:28pm

Hi massi,I have the NT 4695 - AM 5875 4 zone unit

massi · June 12, 2021, 9:39pm

I think the log you provided is cut and not complete.
To understand the problem:

make sure to use 3.1M5
set log level to DEBUG, from Karaf console:
- log:set DEBUG org.openhab.binding.openwebnet
- log:set DEBUG org.openwebnet4j
remove all things found in inbox
restart OH3 then start a new scan

Then via Personal Message send me the entire openhab.log file from the moment you restarted OH3.

Rob-VF · June 13, 2021, 4:38am

Ciao Massimo,

The log was cut (too may rows), I will start a fresh installation without any thing/item else, collect all logs and send you by message asap

Thinks

R

fmalfatto · June 13, 2021, 6:33am

Hallo. Anyone with a Thermo 4-zone setup available to do some tests with the goal of adding support for this configuration in the official binding?

I have a NT4695 not actually configured because it is not supported from MHS1. Two LN4691 are directly controlled from MHS1 as Residential Thermostate and they still work under 2.5.0 Testing. Another Raspberry is running OH 3 with official bindig, so I’m ready to test what you want, configuring the NT4695 through the old LN4890 unofficial gateway, if it would be useful.