[BTicino/OpenWebNet] New openHAB2 binding ready for testing

Pinocchio · May 29, 2021, 10:00am

Debug output:

2021-05-29 11:59:31.079 [DEBUG] [ebnet.handler.OpenWebNetThingHandler] - ==OWN:ThingHandler== handleCommand() (command=PRESSED - channel=openwebnet:bus_cen_scenario_control:mybridge:MH202_CEN_scenario:button_32)
2021-05-29 11:59:31.126 [DEBUG] [et.handler.OpenWebNetScenarioHandler] - ==OWN:ScenarioHandler== handleChannelCommand() (command=PRESSED)
2021-05-29 11:59:31.144 [WARN ] [penwebnet.message.OpenMessageFactory] - ##openwebnet## unsupported WHAT 32 from frame *15*32*99##
2021-05-29 11:59:31.290 [DEBUG] [bnet.handler.OpenWebNetBridgeHandler] - ==OWN==  GatewayManagement WHAT = null, ignoring
2021-05-29 11:59:31.447 [DEBUG] [et.handler.OpenWebNetScenarioHandler] - ==OWN:ScenarioHandler== # 99 # sending CEN virtual release...
2021-05-29 11:59:31.449 [WARN ] [penwebnet.message.OpenMessageFactory] - ##openwebnet## unsupported WHAT 32#1 from frame *15*32#1*99##

schabkle · May 29, 2021, 10:10am

Is there any way to include the old WHO=4 thermofunction back into the binding?

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.