pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Virtualisierte CCU für Raspberry Pi und Clones

Moderator: Co-Administratoren

Antworten
Bator82
Beiträge: 5
Registriert: 16.08.2023, 11:45
System: Alternative CCU (auf Basis OCCU)
Hat sich bedankt: 1 Mal
Danksagung erhalten: 1 Mal

pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Beitrag von Bator82 » 16.08.2023, 13:21

Hallo zusammen,

bisher hatte ich nur HomaticIP Geräte angelernt und damit auch noch nie Probleme. Inzwischen haben ich mir aber einen "HM-ES-TX-WM" zum einbinden meines Stromzählers zugelegt, welchen ich gerne anbinden will. Leider bietet mir die Oberfläche beim anlernen von neune Geräten nur HomematicIP an und keine Möglichkeit von bidCos? Was habe ich falsch gemacht?

Die pivccu läuft bei mir auf einem Raspberry IV mit angebundenem "HM-MOD-RPI-PCB", mit welchem ich ja auch die HMIP-Geräte bereits am laufen habe.

Soweit ich das hier im Forum verstanden habe ist ein dualer Betrieb von HMIP und HMRF mit meinem Modul möglich? Muss ich hier noch etwas zusätzlich konfigurieren?

Vielen Dank für eure Hilfe!
Gruß
Stefan


Bator82
Beiträge: 5
Registriert: 16.08.2023, 11:45
System: Alternative CCU (auf Basis OCCU)
Hat sich bedankt: 1 Mal
Danksagung erhalten: 1 Mal

Re: pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Beitrag von Bator82 » 17.08.2023, 12:23

Hallo Alex,

vielen Dank für deine schnelle Hilfe!

Hier noch ein paar Screenshots:
pivccuInfo.png
pivccu.jpg

Benutzeravatar
deimos
Beiträge: 5399
Registriert: 20.06.2017, 10:38
System: Alternative CCU (auf Basis OCCU)
Wohnort: Leimersheim
Hat sich bedankt: 121 Mal
Danksagung erhalten: 958 Mal
Kontaktdaten:

Re: pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Beitrag von deimos » 17.08.2023, 13:04

Hi,

Sehr strange, weil das Modul korrekt erkannt wird. Hast du mal einen Reboot gemacht? Kommt beim Öffnen der WebUI eine Fehlermeldung, dass eine Komponente der Homematic Zentrale nicht reagiert?

Viele Grüße
Alex

Bator82
Beiträge: 5
Registriert: 16.08.2023, 11:45
System: Alternative CCU (auf Basis OCCU)
Hat sich bedankt: 1 Mal
Danksagung erhalten: 1 Mal

Re: pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Beitrag von Bator82 » 17.08.2023, 15:46

Hi,

ja Reboots hatte ich schon des Öfteren gemacht. Aufgesetzt habe ich das ganze vor ca. einem Jahr und ich hatte schon immer nur die Auswahl von HMIP, was mir bisher aber nicht bewusst war das hier mehr kommen sollte, da ich ja auch nur HMIP angesteuert habe.

Ja ich bekomme immer wieder eine Meldung, sehe auch leider jetzt erst das es sich ja auch um die BidCos-Komponente handelt :-(
pivccu_Fehlermeldung.png
Bin davon ausgegangen das es einfach ein Geschwindigkeitsproblem der Virtualisierung ist? Habe ansonsten auch keinerlei Probleme gehabt....

Bator82
Beiträge: 5
Registriert: 16.08.2023, 11:45
System: Alternative CCU (auf Basis OCCU)
Hat sich bedankt: 1 Mal
Danksagung erhalten: 1 Mal

Re: pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Beitrag von Bator82 » 22.08.2023, 10:35

So nachdem mir ein Blitzeinschlag mein Raspberry zerstört hat musste ich erst mal Ersatz besorgen :-( Daher melde ich mich erst jetzt
(SD-Karte hat zum Glück kein Schaden genommen)

Ich bin immer noch auf der Fehlersuche
Hier noch ein Screenshoot mit einer Fehlermeldung die kommt wenn ich bei der BidCos-Komponente auf Einstellungen gehe:
bidCos_RF_Fehlermeldung.png
bidCos_RF_Fehlermeldung.png (15.58 KiB) 876 mal betrachtet

Log habe ich inzwischen auch was gefunden:

Code: Alles auswählen

2023-08-22 10:21:30,299 de.eq3.ccu.hmip.accesspoint.update.AccessPointUpdateLoaderWorker INFO  [vert.x-worker-thread-4] SYSTEM: Firmware update directory is set to /etc/config/firmware 
2023-08-22 10:21:30,302 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of AccessPointUpdateServerWorker succeeded (a336adf3-73db-4e51-862b-776a9fdaf52a) 
2023-08-22 10:21:30,302 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of AccessPointUpdateLoaderWorker succeeded (7b03776b-a05a-4ea2-aefe-c814eef235c6) 
2023-08-22 10:21:30,357 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of GroupRequestWorker succeeded (b0d80193-a792-47f7-9d55-7fb09338222e) 
2023-08-22 10:21:30,357 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DiagramRequestWorker succeeded (3b76744d-1ec6-4c57-a2b4-ed61279e712f) 
2023-08-22 10:21:30,358 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (b74b0969-072c-4ca6-81c3-a9ec6d56c519) 
2023-08-22 10:21:30,370 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: initial deployment complete _____________________________________________________ 
2023-08-22 10:21:30,371 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Starting HMServer at 127.0.0.1:39292 
2023-08-22 10:21:30,371 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Read Configuration 
2023-08-22 10:21:30,489 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create Bidcos Dispatcher 
2023-08-22 10:21:30,524 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] InitBidCosCache 
2023-08-22 10:21:31,631 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Thread-2] BidCosCache could not be initialized 
2023-08-22 10:21:31,632 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Thread-2] java.net.ConnectException: Connection refused (Connection refused) 
2023-08-22 10:21:31,632 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create groupDefinitionProvider 
2023-08-22 10:21:31,878 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create VirtualDeviceHolder 
2023-08-22 10:21:31,881 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create VirtualDeviceHandlerRega 
2023-08-22 10:21:31,887 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupAdministrationService 
2023-08-22 10:21:31,887 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupDeviceDispatcher 
2023-08-22 10:21:31,888 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupDeviceHandler 
2023-08-22 10:21:31,894 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] @GroupDeviceHandler - initializing... 
2023-08-22 10:21:31,894 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created groupDeviceDispatcher (GroupDeviceService to BidCoS (via Dispatcher)) 
2023-08-22 10:21:31,894 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created virtualDeviceHandler (GroupDeviceService to ReGa) 
2023-08-22 10:21:31,894 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> got groupDefinitionProvider 
2023-08-22 10:21:31,894 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create BidCosGroupMemberProvider 
2023-08-22 10:21:31,935 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init groupAdministrationService 
2023-08-22 10:21:31,938 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init Virtual OS Device 
2023-08-22 10:21:31,942 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init ESHLight Bridge 
2023-08-22 10:21:32,378 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create RrdDatalogging 
2023-08-22 10:21:32,382 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create MeasurementService 
2023-08-22 10:21:32,386 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init MeasurementService 
2023-08-22 10:21:32,445 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create HTTP Server 
2023-08-22 10:21:32,452 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create BidCos context and start handler 
2023-08-22 10:21:32,457 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create group context and start handler 
2023-08-22 10:21:32,470 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher [color=#FF0000]ERROR [Timer-2] Could not register BidCos-RF_java [/color]
2023-08-22 10:21:32,476 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-1] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:39292/bidcos 
2023-08-22 10:21:32,482 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [HmIP-RF_java_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 10:21:32,485 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [HmIP-RF_java_WorkerPool-0] init finished 
2023-08-22 10:21:32,488 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-5] SYSTEM: Checking all devices on all accesspoints for updates 
2023-08-22 10:21:32,492 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-3] Added InterfaceId: HmIP-RF_java 
2023-08-22 10:21:32,534 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-3] updateDevicesForClient HmIP-RF_java -> 122 device addresses will be added 
2023-08-22 10:21:33,468 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Starting HMServer done 
2023-08-22 10:21:37,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2][color=#FF0000] Could not register BidCos-RF_java [/color]
2023-08-22 10:21:41,676 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] (un)registerCallback on VirtualDeviceHandlerRega called from url: xmlrpc_bin://127.0.0.1:31999 
2023-08-22 10:21:41,682 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] Added InterfaceId: 1008 
2023-08-22 10:21:41,687 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-12] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
2023-08-22 10:21:42,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] [color=#FF0000]Could not register BidCos-RF_java [/color]
2023-08-22 10:21:44,241 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 2562 ms, time limit is 2000 ms 
2023-08-22 10:21:45,238 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 3563 ms, time limit is 2000 ms 
2023-08-22 10:21:46,239 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 4563 ms, time limit is 2000 ms 
2023-08-22 10:21:47,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 5564 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:47,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] [color=#FF0000]Could not register BidCos-RF_java [/color]
2023-08-22 10:21:48,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 6564 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:49,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 7564 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:50,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 8563 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:51,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 9564 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:51,694 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-2] (un)registerCallback on LegacyServiceHandler called from url: xmlrpc_bin://127.0.0.1:31999 
2023-08-22 10:21:51,697 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [1009_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 10:21:51,699 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [1009_WorkerPool-0] init finished 
2023-08-22 10:21:51,699 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-1] Added InterfaceId: 1009 
2023-08-22 10:21:51,776 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-1] updateDevicesForClient 1009 -> 2 device addresses will be added 
[color=#FF0000]2023-08-22 10:21:52,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:21:57,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:02,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:07,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:12,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:17,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:22,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:27,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:32,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:37,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:42,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:47,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:52,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:57,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:23:02,464 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:23:07,464 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:23:12,465 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java [/color]
Was läuft hier falsch? Komme nicht weiter :-(


Gruß
Stefan
Zuletzt geändert von Bator82 am 22.08.2023, 12:39, insgesamt 1-mal geändert.

Silverstar
Beiträge: 369
Registriert: 11.02.2020, 12:14
System: Alternative CCU (auf Basis OCCU)
Hat sich bedankt: 95 Mal
Danksagung erhalten: 68 Mal

Re: pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Beitrag von Silverstar » 22.08.2023, 11:59

Bator82 hat geschrieben:
22.08.2023, 10:35

Code: Alles auswählen

2023-08-22 10:21:30,299 de.eq3.ccu.hmip.accesspoint.update.AccessPointUpdateLoaderWorker INFO  [vert.x-worker-thread-4] SYSTEM: Firmware update directory is set to /etc/config/firmware 
2023-08-22 10:21:30,302 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of AccessPointUpdateServerWorker succeeded (a336adf3-73db-4e51-862b-776a9fdaf52a) 
2023-08-22 10:21:30,302 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of AccessPointUpdateLoaderWorker succeeded (7b03776b-a05a-4ea2-aefe-c814eef235c6) 
2023-08-22 10:21:30,357 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of GroupRequestWorker succeeded (b0d80193-a792-47f7-9d55-7fb09338222e) 
2023-08-22 10:21:30,357 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DiagramRequestWorker succeeded (3b76744d-1ec6-4c57-a2b4-ed61279e712f) 
2023-08-22 10:21:30,358 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (b74b0969-072c-4ca6-81c3-a9ec6d56c519) 
2023-08-22 10:21:30,370 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: initial deployment complete _____________________________________________________ 
2023-08-22 10:21:30,371 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Starting HMServer at 127.0.0.1:39292 
2023-08-22 10:21:30,371 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Read Configuration 
2023-08-22 10:21:30,489 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create Bidcos Dispatcher 
2023-08-22 10:21:30,524 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] InitBidCosCache 
2023-08-22 10:21:31,631 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Thread-2] BidCosCache could not be initialized 
2023-08-22 10:21:31,632 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Thread-2] java.net.ConnectException: Connection refused (Connection refused) 
2023-08-22 10:21:31,632 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create groupDefinitionProvider 
2023-08-22 10:21:31,878 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create VirtualDeviceHolder 
2023-08-22 10:21:31,881 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create VirtualDeviceHandlerRega 
2023-08-22 10:21:31,887 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupAdministrationService 
2023-08-22 10:21:31,887 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupDeviceDispatcher 
2023-08-22 10:21:31,888 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupDeviceHandler 
2023-08-22 10:21:31,894 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] @GroupDeviceHandler - initializing... 
2023-08-22 10:21:31,894 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created groupDeviceDispatcher (GroupDeviceService to BidCoS (via Dispatcher)) 
2023-08-22 10:21:31,894 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created virtualDeviceHandler (GroupDeviceService to ReGa) 
2023-08-22 10:21:31,894 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> got groupDefinitionProvider 
2023-08-22 10:21:31,894 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create BidCosGroupMemberProvider 
2023-08-22 10:21:31,935 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init groupAdministrationService 
2023-08-22 10:21:31,938 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init Virtual OS Device 
2023-08-22 10:21:31,942 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init ESHLight Bridge 
2023-08-22 10:21:32,378 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create RrdDatalogging 
2023-08-22 10:21:32,382 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create MeasurementService 
2023-08-22 10:21:32,386 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init MeasurementService 
2023-08-22 10:21:32,445 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create HTTP Server 
2023-08-22 10:21:32,452 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create BidCos context and start handler 
2023-08-22 10:21:32,457 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create group context and start handler 
2023-08-22 10:21:32,470 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher [color=#FF0000]ERROR [Timer-2] Could not register BidCos-RF_java [/color]
2023-08-22 10:21:32,476 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-1] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:39292/bidcos 
2023-08-22 10:21:32,482 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [HmIP-RF_java_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 10:21:32,485 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [HmIP-RF_java_WorkerPool-0] init finished 
2023-08-22 10:21:32,488 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-5] SYSTEM: Checking all devices on all accesspoints for updates 
2023-08-22 10:21:32,492 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-3] Added InterfaceId: HmIP-RF_java 
2023-08-22 10:21:32,534 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-3] updateDevicesForClient HmIP-RF_java -> 122 device addresses will be added 
2023-08-22 10:21:33,468 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Starting HMServer done 
2023-08-22 10:21:37,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2][color=#FF0000] Could not register BidCos-RF_java [/color]
2023-08-22 10:21:41,676 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] (un)registerCallback on VirtualDeviceHandlerRega called from url: xmlrpc_bin://127.0.0.1:31999 
2023-08-22 10:21:41,682 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] Added InterfaceId: 1008 
2023-08-22 10:21:41,687 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-12] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
2023-08-22 10:21:42,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] [color=#FF0000]Could not register BidCos-RF_java [/color]
2023-08-22 10:21:44,241 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 2562 ms, time limit is 2000 ms 
2023-08-22 10:21:45,238 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 3563 ms, time limit is 2000 ms 
2023-08-22 10:21:46,239 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 4563 ms, time limit is 2000 ms 
2023-08-22 10:21:47,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 5564 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:47,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] [color=#FF0000]Could not register BidCos-RF_java [/color]
2023-08-22 10:21:48,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 6564 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:49,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 7564 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:50,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 8563 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:51,240 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 9564 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$66/11671292.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$65/30836640.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 10:21:51,694 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-2] (un)registerCallback on LegacyServiceHandler called from url: xmlrpc_bin://127.0.0.1:31999 
2023-08-22 10:21:51,697 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [1009_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 10:21:51,699 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [1009_WorkerPool-0] init finished 
2023-08-22 10:21:51,699 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-1] Added InterfaceId: 1009 
2023-08-22 10:21:51,776 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-1] updateDevicesForClient 1009 -> 2 device addresses will be added 
[color=#FF0000]2023-08-22 10:21:52,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:21:57,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:02,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:07,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:12,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:17,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:22,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:27,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:32,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:37,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:42,462 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:47,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:52,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:22:57,463 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:23:02,464 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:23:07,464 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 10:23:12,465 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java [/color]
IMG-20230822-WA0004.jpg

Benutzeravatar
deimos
Beiträge: 5399
Registriert: 20.06.2017, 10:38
System: Alternative CCU (auf Basis OCCU)
Wohnort: Leimersheim
Hat sich bedankt: 121 Mal
Danksagung erhalten: 958 Mal
Kontaktdaten:

Re: pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Beitrag von deimos » 22.08.2023, 14:15

Hi,

nach einem Blitzschlag, welches den Pi zerstört hat, würde ich im Zweifel davon ausgehen, dass sowohl die SD Karte als auch das Funkmodul auch etwas abbekommen haben.
Dein Log ist nicht vollständig, aber man erkennt, dass der rfcd keine Verbindungen annimmt. Interessant wäre jetzt, was pivccu-info liefert um überhaupt erstmal zu schauen, ob das Funkmodul überhaupt noch antwortet. Wenn es da sichtbar ist, wäre der nächste Schritt zu prüfen, ob der rfcd überhaupt läuft.

Viele Grüße
Alex

Bator82
Beiträge: 5
Registriert: 16.08.2023, 11:45
System: Alternative CCU (auf Basis OCCU)
Hat sich bedankt: 1 Mal
Danksagung erhalten: 1 Mal

Re: pivccu mit HM-MOD-RPI-PCB Dualbetrieb HMIP HMRF (bidCos)

Beitrag von Bator82 » 22.08.2023, 14:47

Hi,

SD scheint in in Ordnung zu sein. Auf dem Server läuft neben pivccu auch FHEM (CULs + JeeLink) hier geht auch noch alles.
Kann auch immer noch alle HMIP-Geräte steuern also denke ich mal wirklich nur der Raspi hinüber und grundsätzlich läuft das Funkmodul ja wenn HMIP geht?!

Hier nochmal ein neuer pivccu-info Screenshot
pivccu_info.jpg
Hier auch noch mal das Log:

Code: Alles auswählen

***** messages *****
Aug 22 12:41:52 piVCCU syslog.info syslogd started: BusyBox v1.29.2
Aug 22 12:41:52 piVCCU user.notice kernel: klogd started: BusyBox v1.29.2 (2023-04-12 13:18:50 CEST)
Aug 22 12:41:52 piVCCU syslog.info syslogd exiting
Aug 22 12:41:52 homematic-raspi syslog.info syslogd started: BusyBox v1.29.2
Aug 22 12:41:52 homematic-raspi user.notice kernel: klogd started: BusyBox v1.29.2 (2023-04-12 13:18:50 CEST)
Aug 22 12:41:52 homematic-raspi daemon.err udhcpc[184]: started, v1.29.2
Aug 22 12:41:52 homematic-raspi daemon.err udhcpc[184]: sending discover
Aug 22 12:41:53 homematic-raspi daemon.err udhcpc[184]: sending select for 192.168.3.12
Aug 22 12:41:53 homematic-raspi daemon.err udhcpc[184]: lease of 192.168.3.12 obtained, lease time 864000
Aug 22 12:41:53 homematic-raspi user.info firewall: iptables v1.6.2: invalid port/service `310000' specified Try `iptables -h' or 'iptables --help' for more information.
Aug 22 12:41:53 homematic-raspi user.info firewall: ip6tables v1.6.2: invalid port/service `310000' specified Try `ip6tables -h' or 'ip6tables --help' for more information.
Aug 22 12:41:53 homematic-raspi user.info firewall: configuration set
Aug 22 12:41:53 homematic-raspi daemon.info ifplugd(eth0)[269]: ifplugd 0.28 initializing.
Aug 22 12:41:53 homematic-raspi daemon.info ifplugd(eth0)[269]: Using interface eth0/AA:2E:CF:16:C6:1A with driver <veth> (version: 1.0)
Aug 22 12:41:53 homematic-raspi daemon.info ifplugd(eth0)[269]: Using detection mode: SIOCETHTOOL
Aug 22 12:41:53 homematic-raspi daemon.info ifplugd(eth0)[269]: Initialization complete, link beat detected.
Aug 22 12:41:53 homematic-raspi daemon.warn ifplugd(eth0)[269]: Could not open /dev/tty, cannot beep.
Aug 22 12:41:53 homematic-raspi daemon.info ifplugd(eth0)[269]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Aug 22 12:41:53 homematic-raspi daemon.warn ifplugd(eth0)[269]: client: ifup: interface eth0 already configured
Aug 22 12:41:53 homematic-raspi daemon.info ifplugd(eth0)[269]: Program executed successfully.
Aug 22 12:42:05 homematic-raspi daemon.notice ntpdate[277]: step time server 192.171.1.150 offset -0.000508 sec
Aug 22 12:42:05 homematic-raspi daemon.notice ntpd[278]: ntpd 4.2.8p12@1.3728-o Wed Apr 12 13:16:53 CEST 2023 (1): Starting
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[278]: Command line: /usr/sbin/ntpd -g 0.de.pool.ntp.org 1.de.pool.ntp.org 2.de.pool.ntp.org 3.de.pool.ntp.org
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: proto: precision = 0.648 usec (-20)
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: Listen and drop on 0 v6wildcard [::]:123
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: Listen normally on 2 lo 127.0.0.1:123
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: Listen normally on 3 eth0 192.168.3.12:123
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: Listen normally on 4 lo [::1]:123
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: Listening on routing socket on fd #21 for interface updates
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Aug 22 12:42:05 homematic-raspi daemon.info ntpd[280]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Aug 22 12:42:05 homematic-raspi daemon.err xinetd[298]: Unable to read included directory: /etc/config/xinetd.d [file=/etc/xinetd.conf] [line=14]
Aug 22 12:42:05 homematic-raspi daemon.crit xinetd[298]: 298 {init_services} no services. Exiting...
Aug 22 12:42:13 homematic-raspi user.err setlgwkey: Could not find Lan Gateway using serial number 19738246
Aug 22 12:42:13 homematic-raspi user.err setlgwkey: Cannot determine IP address of gateway with serial 19738246
Aug 22 12:42:15 homematic-raspi user.err rfd: No BidCoS-Interface available
Aug 22 12:43:59 homematic-raspi local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Aug 22 12:43:59 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'init': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"xmlrpc_bin://127.0.0.1:31999","1007"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Aug 22 12:43:59 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'init' call failed (interface: 1007, params: {"xmlrpc_bin://127.0.0.1:31999","1007"}) [CallInit():iseXmlRpc.cpp:1204]
Aug 22 12:43:59 homematic-raspi local0.err ReGaHss: ERROR: failed CallInit() for interface=BidCos-RF [ThreadFunction():iseRTHss.cpp:163]
Aug 22 12:44:00 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"00115D899C7FF1:4","ACTIVITY_STATE"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ACTIVITY_STATE"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Aug 22 12:44:00 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1009, params: {"00115D899C7FF1:4","ACTIVITY_STATE"}) [CallGetValue():iseXmlRpc.cpp:1435]
Aug 22 12:44:00 homematic-raspi local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Aug 22 12:44:00 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"00109D89964645:1","STATE"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: STATE"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Aug 22 12:44:00 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1009, params: {"00109D89964645:1","STATE"}) [CallGetValue():iseXmlRpc.cpp:1435]
Aug 22 12:44:00 homematic-raspi local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Aug 22 12:49:31 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"00115D899C7FF1:5","LEVEL"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1009, params: {"00115D899C7FF1:5","LEVEL"}) [CallGetValue():iseXmlRpc.cpp:1435]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Aug 22 12:49:31 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"00115D899C7FF1:6","LEVEL"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1009, params: {"00115D899C7FF1:6","LEVEL"}) [CallGetValue():iseXmlRpc.cpp:1435]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Aug 22 12:49:31 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"00115D899C7FF1:4","LEVEL"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1009, params: {"00115D899C7FF1:4","LEVEL"}) [CallGetValue():iseXmlRpc.cpp:1435]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Aug 22 12:49:31 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"00115D899C7FF1:3","LEVEL"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1009, params: {"00115D899C7FF1:3","LEVEL"}) [CallGetValue():iseXmlRpc.cpp:1435]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Aug 22 12:49:31 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"00115D899C7FF1:3","LEVEL_STATUS"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL_STATUS"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1009, params: {"00115D899C7FF1:3","LEVEL_STATUS"}) [CallGetValue():iseXmlRpc.cpp:1435]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Aug 22 12:49:31 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"00115D899C7FF1:3","ACTIVITY_STATE"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ACTIVITY_STATE"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1009, params: {"00115D899C7FF1:3","ACTIVITY_STATE"}) [CallGetValue():iseXmlRpc.cpp:1435]
Aug 22 12:49:31 homematic-raspi local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Aug 22 12:49:41 homematic-raspi daemon.info ntpd[280]: Listen normally on 5 eth0 [2a02:778:145:e801:a82e:cfff:fe16:c61a]:123


***** hmserver.log *****
2023-08-22 12:43:37,529 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] @GenericFactory 
2023-08-22 12:43:37,542 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] created instance of HMServerConfiguration with parameter(s) 
2023-08-22 12:43:37,543 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] passed 1 parameter(s), in declarative order [String] 
2023-08-22 12:43:41,814 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [HMIPTRXWriterWorker] (1) *worker 
2023-08-22 12:43:41,814 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [KeyServerWorker] (1) *worker 
2023-08-22 12:43:41,815 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [KryoPersistenceWorker] (1) *worker 
2023-08-22 12:43:41,815 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [TransactionSubsystemHandler] (1) *worker 
2023-08-22 12:43:41,815 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [FirmwareLoaderFileSystem] (1) *worker 
2023-08-22 12:43:41,815 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LocalServerPersistentDataLoader] (1)  
2023-08-22 12:43:41,815 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LocalServerAdapterInitialization] (1)  
2023-08-22 12:43:41,815 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [TransactionManagementVerticle] (1)  
2023-08-22 12:43:41,816 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [BackendCommandHandler] (1)  
2023-08-22 12:43:41,816 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [StatemanagementResponseHandler] (1)  
2023-08-22 12:43:41,816 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [StatemanagementRequestHandler] (1)  
2023-08-22 12:43:41,816 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceInclusionAcceptHandler] (1)  
2023-08-22 12:43:41,817 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [CheckDeviceExistHandler] (1)  
2023-08-22 12:43:41,817 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [IncomingHMIPFrameHandler] (1)  
2023-08-22 12:43:41,817 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceBackgroundUpdateSubsystem] (1)  
2023-08-22 12:43:41,817 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceLiveUpdateSubsystem] (1)  
2023-08-22 12:43:41,817 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceDefaultConfigurationChanger] (1)  
2023-08-22 12:43:41,817 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [CyclicSmokeDetectorAwakening] (1)  
2023-08-22 12:43:41,818 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DisplayUpdateStatusHandler] (1)  
2023-08-22 12:43:41,818 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LocalServerFirmwareUpdateInitialization] (1)  
2023-08-22 12:43:41,824 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyNotificationHandler] (1) *worker 
2023-08-22 12:43:41,824 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyAPIWorker] (1) *worker 
2023-08-22 12:43:41,825 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyBackendNotificationHandler] (3) *worker 
2023-08-22 12:43:41,825 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyBlindLevelCorrectionHandler] (1) *worker 
2023-08-22 12:43:41,825 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyInitializion] (1)  
2023-08-22 12:43:41,833 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: deploying 25 classes to Vert.x 
2023-08-22 12:43:41,905 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: 25 VertxDeployers initialized 
2023-08-22 12:43:41,989 de.eq3.cbcs.server.core.vertx.CyclicSmokeDetectorAwakening INFO  [vert.x-eventloop-thread-5] SYSTEM: CyclicSmokeDetectorAwakening Verticle or Worker started 
2023-08-22 12:43:42,004 de.eq3.cbcs.server.core.vertx.HMIPAbstractWriterWorker INFO  [vert.x-worker-thread-3] SYSTEM: HMIPTRXWriterWorker Verticle or Worker started 
2023-08-22 12:43:42,005 de.eq3.cbcs.server.core.vertx.TransactionSubsystemHandler INFO  [vert.x-worker-thread-1] SYSTEM: TransactionSubsystemHandler Verticle or Worker started 
2023-08-22 12:43:42,007 de.eq3.cbcs.statemanagement.StatemanagementRequestHandler INFO  [vert.x-eventloop-thread-5] SYSTEM: StatemanagementRequestHandler Verticle or Worker started 
2023-08-22 12:43:42,008 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBlindLevelCorrectionHandler INFO  [vert.x-worker-thread-2] SYSTEM: LegacyBlindLevelCorrectionHandler Verticle or Worker started 
2023-08-22 12:43:42,011 de.eq3.cbcs.server.core.vertx.KeyServerWorker WARN  [vert.x-worker-thread-4] Missing or invalid key server configuration parameter (Network.Key / Network.Key.Base) for  mode: KEYSERVER_LOCAL 
2023-08-22 12:43:42,012 de.eq3.cbcs.server.core.vertx.KeyServerWorker INFO  [vert.x-worker-thread-4] SYSTEM: KeyServerWorker Verticle or Worker started 
2023-08-22 12:43:42,013 de.eq3.cbcs.server.core.vertx.DisplayUpdateStatusHandler INFO  [vert.x-eventloop-thread-1] SYSTEM: DisplayUpdateStatusHandler Verticle or Worker started 
2023-08-22 12:43:42,013 de.eq3.cbcs.server.core.vertx.CheckDeviceExistHandler INFO  [vert.x-eventloop-thread-4] SYSTEM: CheckDeviceExistHandler Verticle or Worker started 
2023-08-22 12:43:42,019 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of DisplayUpdateStatusHandler succeeded (2d277fc2-3627-4258-b705-48860fdc17d3) 
2023-08-22 12:43:42,019 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of CyclicSmokeDetectorAwakening succeeded (53ae9039-3066-43d0-aaff-a3fe4b8935bc) 
2023-08-22 12:43:42,020 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of KeyServerWorker succeeded (de2fb7b3-15d8-4526-b1af-11d4927a6f1e) 
2023-08-22 12:43:42,020 de.eq3.cbcs.server.core.vertx.DeviceDefaultConfigurationChanger INFO  [vert.x-eventloop-thread-1] SYSTEM: DeviceDefaultConfigurationChanger Verticle or Worker started 
2023-08-22 12:43:42,021 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of StatemanagementRequestHandler succeeded (42892718-a695-486f-9f2f-cfdd5f0218f0) 
2023-08-22 12:43:42,022 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of HMIPTRXWriterWorker succeeded (ed318b93-cb7a-4fb3-b5b2-b2ccf0cf82d4) 
2023-08-22 12:43:42,023 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of TransactionSubsystemHandler succeeded (7833d8e9-1110-4db0-870d-99063b846344) 
2023-08-22 12:43:42,021 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of CheckDeviceExistHandler succeeded (c4498450-eb01-4a0a-804d-ca8209a7bbe9) 
2023-08-22 12:43:42,098 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of KryoPersistenceWorker succeeded (46e4a016-1691-4e59-a492-1ed0332364c0) 
2023-08-22 12:43:42,114 de.eq3.cbcs.server.local.base.internal.LocalServerPersistentDataLoader INFO  [vert.x-eventloop-thread-6] SYSTEM: LocalServerPersistentDataLoader Verticle or Worker started 
2023-08-22 12:43:42,115 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of LocalServerPersistentDataLoader succeeded (1ade9a9a-ba61-4932-a2ab-f3101ae10e19) 
2023-08-22 12:43:42,483 de.eq3.cbcs.server.core.otau.AbstractUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: DeviceBackgroundUpdateSubsystem Verticle or Worker started 
2023-08-22 12:43:42,483 de.eq3.cbcs.server.core.otau.AbstractUpdateSubsystem INFO  [vert.x-eventloop-thread-0] SYSTEM: DeviceLiveUpdateSubsystem Verticle or Worker started 
2023-08-22 12:43:42,484 de.eq3.cbcs.server.core.live_otau.DeviceLiveUpdateSubsystem INFO  [vert.x-eventloop-thread-0] SYSTEM: DeviceLiveUpdateSubsystem started 
2023-08-22 12:43:42,500 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LegacyBlindLevelCorrectionHandler succeeded (f572f8b1-1466-4ac9-9cfa-bb406de180a2) 
2023-08-22 12:43:42,504 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of DeviceDefaultConfigurationChanger succeeded (d03aaf19-8861-46b6-9e19-31ec80139a6b) 
2023-08-22 12:43:42,506 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DeviceLiveUpdateSubsystem succeeded (6bdae2d5-7317-4f62-874f-6e779e848b2c) 
2023-08-22 12:43:42,506 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of DeviceBackgroundUpdateSubsystem succeeded (50f56809-cdea-49a0-8d5d-8546c47384db) 
2023-08-22 12:43:43,383 de.eq3.cbcs.server.core.vertx.DeviceInclusionAcceptHandler INFO  [vert.x-eventloop-thread-0] SYSTEM: DeviceInclusionAcceptHandler Verticle or Worker started 
2023-08-22 12:43:43,384 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of DeviceInclusionAcceptHandler succeeded (5c4f235d-cf92-4f6a-86d2-ffe75081f326) 
2023-08-22 12:43:43,416 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-4] SYSTEM: Firmware update directory is set to /etc/config/firmware 
2023-08-22 12:43:43,416 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-4] SYSTEM: FirmwareLoaderFileSystem Verticle or Worker started 
2023-08-22 12:43:43,420 de.eq3.cbcs.server.core.transaction.TransactionManagementVerticle INFO  [vert.x-eventloop-thread-3] SYSTEM: TransactionManagementVerticle Verticle or Worker started 
2023-08-22 12:43:43,420 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of TransactionManagementVerticle succeeded (78adba75-f259-46d2-90c9-29635e63e226) 
2023-08-22 12:43:43,421 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of FirmwareLoaderFileSystem succeeded (43adda42-47ae-46c0-af88-6edbb36982b4) 
2023-08-22 12:43:43,438 de.eq3.cbcs.server.core.vertx.IncomingHMIPFrameHandler INFO  [vert.x-eventloop-thread-1] SYSTEM: IncomingHMIPFrameHandler Verticle or Worker started 
2023-08-22 12:43:43,439 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of IncomingHMIPFrameHandler succeeded (ca3e7730-92eb-4492-b2ab-e40ccfbb1ef4) 
2023-08-22 12:43:43,499 de.eq3.cbcs.server.core.vertx.BackendCommandHandler INFO  [vert.x-eventloop-thread-5] SYSTEM: BackendCommandHandler Verticle or Worker started 
2023-08-22 12:43:43,501 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of BackendCommandHandler succeeded (cb7fa6f9-a06d-4777-b7a9-a305797e382d) 
2023-08-22 12:43:43,540 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [vert.x-eventloop-thread-4] SYSTEM: LocalServerAdapterInitialization Verticle or Worker started 
2023-08-22 12:43:43,541 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LocalServerAdapterInitialization succeeded (98f758e5-9c42-41fb-a8e3-3d098620bbc7) 
2023-08-22 12:43:43,566 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] TRX adapter state 1: HMIP_TRX_App 
2023-08-22 12:43:43,567 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] TRX adapter application is already running or started 
2023-08-22 12:43:43,567 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] No NWK, try to set address ... 
2023-08-22 12:43:43,567 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Try to set radio address 12215463... 
2023-08-22 12:43:43,588 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Set max send attempts for 3014F711A061A7DBE997522A to 3 
2023-08-22 12:43:43,609 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Try to get application version... 
2023-08-22 12:43:43,630 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Application version 2.8.6 
2023-08-22 12:43:43,630 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Bootloader version 1.0.3 
2023-08-22 12:43:43,630 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] hmos version 1.20.3 
2023-08-22 12:43:43,733 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] MCU type: Si1002_8051 
2023-08-22 12:43:43,754 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Duty Cycle: 2.5 
2023-08-22 12:43:43,754 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] set DutyCycle limit to ffffffc8 
2023-08-22 12:43:43,857 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Set Duty Cycle Limit 
2023-08-22 12:43:44,059 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Current Security Counter: 174789044 
2023-08-22 12:43:44,060 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Update security counter to calculation: 174817452 
2023-08-22 12:43:44,217 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] TRX adapter has 11 link partners 
2023-08-22 12:43:44,232 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Adapter with Access Point id 3014F711A061A7DBE997522A initialized 
2023-08-22 12:43:44,237 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [RXTXPortMonitor(/dev/mmd_hmip)] HMIPTRXInitialResponseListener said that Adapter was initialized 
2023-08-22 12:43:44,883 de.eq3.cbcs.server.core.vertx.StatemanagementResponseHandler INFO  [vert.x-eventloop-thread-7] SYSTEM: StatemanagementResponseHandler Verticle or Worker started 
2023-08-22 12:43:44,884 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of StatemanagementResponseHandler succeeded (76587e53-29d6-4b55-aa88-b0d70433e6ff) 
2023-08-22 12:43:44,928 de.eq3.cbcs.server.local.base.internal.LocalServerFirmwareUpdateInitialization INFO  [vert.x-eventloop-thread-2] SYSTEM: LocalServerFirmwareUpdateInitialization Verticle or Worker started 
2023-08-22 12:43:44,929 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LocalServerFirmwareUpdateInitialization succeeded (8f2b02eb-f9ed-4140-a5df-4db88d4dc005) 
2023-08-22 12:43:44,937 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyNotificationHandler INFO  [vert.x-worker-thread-1] SYSTEM: LegacyNotificationHandler Verticle or Worker started 
2023-08-22 12:43:44,940 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of LegacyNotificationHandler succeeded (ffebaa30-33c5-422c-8f59-681fbac8ae32) 
2023-08-22 12:43:44,941 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-3] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 12:43:44,942 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-3] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 12:43:44,943 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 12:43:44,945 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LegacyBackendNotificationHandler succeeded (2c02b8a9-5aaf-4d0e-ae5b-4840bba84e94) 
2023-08-22 12:43:45,000 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: Checking all devices on all accesspoints for updates 
2023-08-22 12:43:45,001 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyAPIWorker INFO  [vert.x-worker-thread-2] SYSTEM: LegacyAPIWorker Verticle or Worker started 
2023-08-22 12:43:45,002 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LegacyAPIWorker succeeded (f66fbd4f-3af1-4118-b09b-b848fea31121) 
2023-08-22 12:43:46,416 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyInitializion INFO  [vert.x-eventloop-thread-6] SYSTEM: LegacyInitializion Verticle or Worker started 
2023-08-22 12:43:46,417 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of LegacyInitializion succeeded (b063e371-0f6e-44f9-bac9-08cd844b32fe) 
2023-08-22 12:43:46,510 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: initial deployment complete _____________________________________________________ 
2023-08-22 12:43:46,544 de.eq3.cbcs.server.local.LocalServer INFO  [Thread-1] SYSTEM: Bind XML-RPC api to port 32010 
2023-08-22 12:43:47,554 de.eq3.cbcs.util.EQ3LoggerOutputStream INFO  [Thread-2] std.out and std.err redirection active 
2023-08-22 12:43:47,554 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Default MaxEventLoopExecuteTime: 2000000000 
2023-08-22 12:43:47,561 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Default BlockedThreadCheckInterval: 1000 
2023-08-22 12:43:47,561 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Default MaxWorkerExecuteTime: 60000000000 
2023-08-22 12:43:47,561 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Default EventLoopPoolSize: 8 
2023-08-22 12:43:47,567 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [BackendWorker] (1) *worker 
2023-08-22 12:43:47,568 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [GroupRequestWorker] (1) *worker 
2023-08-22 12:43:47,569 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [DiagramRequestWorker] (1) *worker 
2023-08-22 12:43:47,569 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [StorageRequestWorker] (1) *worker 
2023-08-22 12:43:47,570 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [DeviceFirmwareRequestWorker] (1) *worker 
2023-08-22 12:43:47,571 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [EnergyPriceRequestWorker] (1) *worker 
2023-08-22 12:43:47,572 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [CouplingRequestWorker] (1) *worker 
2023-08-22 12:43:47,573 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [RegaClientWorker] (1) *worker 
2023-08-22 12:43:47,574 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [GroupConfigurationPersistenceFileSystem] (1) *worker 
2023-08-22 12:43:47,584 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [AccessPointUpdateServerWorker] (1) *worker 
2023-08-22 12:43:47,584 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [AccessPointUpdateLoaderWorker] (1) *worker 
2023-08-22 12:43:47,588 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: deploying 11 classes to Vert.x 
2023-08-22 12:43:47,598 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: 11 VertxDeployers initialized 
2023-08-22 12:43:47,626 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of BackendWorker succeeded (f94f2faa-a629-45b5-a34a-14d9556264a3) 
2023-08-22 12:43:47,628 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of EnergyPriceRequestWorker succeeded (3ad31b0d-fd31-401c-bf90-908ba4424fd8) 
2023-08-22 12:43:47,630 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of CouplingRequestWorker succeeded (4c3da2b5-c1f4-42e3-950f-08eb1a6bb764) 
2023-08-22 12:43:47,633 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of GroupConfigurationPersistenceFileSystem succeeded (bba2fff3-0f48-4e8e-bbbe-0e7ceebe9a30) 
2023-08-22 12:43:47,633 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of StorageRequestWorker succeeded (4eeaef96-6dd4-4d97-9da2-79df1534a182) 
2023-08-22 12:43:47,643 de.eq3.ccu.hmip.accesspoint.update.AccessPointUpdateLoaderWorker INFO  [vert.x-worker-thread-9] SYSTEM: Firmware update directory is set to /etc/config/firmware 
2023-08-22 12:43:47,643 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of RegaClientWorker succeeded (219319f4-cca9-471d-b18c-dee46c4c9aa4) 
2023-08-22 12:43:47,645 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of AccessPointUpdateLoaderWorker succeeded (6f5b4a60-84d8-45ad-a748-c467d05b4062) 
2023-08-22 12:43:47,650 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of AccessPointUpdateServerWorker succeeded (80ea922d-bd90-479e-9883-b1837ef87a28) 
2023-08-22 12:43:47,693 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of GroupRequestWorker succeeded (64f6402f-297f-491e-a96c-09c31eb841a6) 
2023-08-22 12:43:47,693 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DiagramRequestWorker succeeded (8aca1334-aff4-470a-b183-a8accc7d0d62) 
2023-08-22 12:43:47,695 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (6a3e233a-a57a-42db-86b3-831d8b606615) 
2023-08-22 12:43:47,699 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: initial deployment complete _____________________________________________________ 
2023-08-22 12:43:47,700 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Starting HMServer at 127.0.0.1:39292 
2023-08-22 12:43:47,700 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Read Configuration 
2023-08-22 12:43:47,818 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create Bidcos Dispatcher 
2023-08-22 12:43:47,849 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] InitBidCosCache 
2023-08-22 12:43:48,964 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Thread-2] BidCosCache could not be initialized 
2023-08-22 12:43:48,964 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Thread-2] java.net.ConnectException: Connection refused (Connection refused) 
2023-08-22 12:43:48,964 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create groupDefinitionProvider 
2023-08-22 12:43:49,213 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create VirtualDeviceHolder 
2023-08-22 12:43:49,216 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create VirtualDeviceHandlerRega 
2023-08-22 12:43:49,222 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupAdministrationService 
2023-08-22 12:43:49,223 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupDeviceDispatcher 
2023-08-22 12:43:49,224 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupDeviceHandler 
2023-08-22 12:43:49,230 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] @GroupDeviceHandler - initializing... 
2023-08-22 12:43:49,230 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created groupDeviceDispatcher (GroupDeviceService to BidCoS (via Dispatcher)) 
2023-08-22 12:43:49,231 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created virtualDeviceHandler (GroupDeviceService to ReGa) 
2023-08-22 12:43:49,231 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> got groupDefinitionProvider 
2023-08-22 12:43:49,231 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create BidCosGroupMemberProvider 
2023-08-22 12:43:49,290 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init groupAdministrationService 
2023-08-22 12:43:49,294 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init Virtual OS Device 
2023-08-22 12:43:49,298 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init ESHLight Bridge 
2023-08-22 12:43:49,773 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create RrdDatalogging 
2023-08-22 12:43:49,777 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create MeasurementService 
2023-08-22 12:43:49,782 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init MeasurementService 
2023-08-22 12:43:49,840 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create HTTP Server 
2023-08-22 12:43:49,849 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create BidCos context and start handler 
2023-08-22 12:43:49,854 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create group context and start handler 
2023-08-22 12:43:49,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:43:49,870 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-1] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:39292/bidcos 
2023-08-22 12:43:49,876 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [HmIP-RF_java_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 12:43:49,878 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [HmIP-RF_java_WorkerPool-0] init finished 
2023-08-22 12:43:49,885 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: Checking all devices on all accesspoints for updates 
2023-08-22 12:43:49,886 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-3] Added InterfaceId: HmIP-RF_java 
2023-08-22 12:43:49,927 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-3] updateDevicesForClient HmIP-RF_java -> 122 device addresses will be added 
2023-08-22 12:43:50,864 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Starting HMServer done 
2023-08-22 12:43:54,859 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:43:59,860 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:43:59,997 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] (un)registerCallback on VirtualDeviceHandlerRega called from url: xmlrpc_bin://127.0.0.1:31999 
2023-08-22 12:44:00,002 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] Added InterfaceId: 1008 
2023-08-22 12:44:00,010 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-12] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
2023-08-22 12:44:02,568 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 2568 ms, time limit is 2000 ms 
2023-08-22 12:44:03,564 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 3568 ms, time limit is 2000 ms 
2023-08-22 12:44:04,564 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 4568 ms, time limit is 2000 ms 
2023-08-22 12:44:04,860 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:05,565 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 5568 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$57/8906847.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$56/17117216.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 12:44:06,565 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 6568 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$57/8906847.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$56/17117216.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 12:44:07,565 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 7568 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$57/8906847.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$56/17117216.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 12:44:08,565 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 8568 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$57/8906847.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$56/17117216.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 12:44:09,565 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 9568 ms, time limit is 2000 ms 
io.vertx.core.VertxException: Thread blocked
	at sun.misc.Unsafe.park(Native Method) ~[?:1.8.0_202]
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) ~[?:1.8.0_202]
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) ~[?:1.8.0_202]
	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467) ~[?:1.8.0_202]
	at de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega.registerCallback(VirtualDeviceHandlerRega.java:99) ~[HMIPServer.jar:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_202]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_202]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_202]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_202]
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.AnnotationAwareRpcHandler.execute(AnnotationAwareRpcHandler.java:80) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:70) ~[HMIPServer.jar:?]
	at de.eq3.ccu.server.internal.RpcMessageHandler.handle(RpcMessageHandler.java:24) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:50) ~[HMIPServer.jar:?]
	at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:168) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.dispatch(MessageConsumerImpl.java:187) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.next(HandlerRegistration.java:162) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$InboundDeliveryContext.dispatch(HandlerRegistration.java:127) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$57/8906847.run(Unknown Source) ~[?:?]
	at io.vertx.core.impl.AbstractContext.dispatch(AbstractContext.java:111) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.dispatch(HandlerRegistration.java:103) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.deliver(MessageConsumerImpl.java:193) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.MessageConsumerImpl.doReceive(MessageConsumerImpl.java:178) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration.lambda$receive$0(HandlerRegistration.java:54) ~[HMIPServer.jar:?]
	at io.vertx.core.eventbus.impl.HandlerRegistration$$Lambda$56/17117216.run(Unknown Source) ~[?:?]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:164) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:469) ~[HMIPServer.jar:?]
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:497) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:986) ~[HMIPServer.jar:?]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[HMIPServer.jar:?]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[HMIPServer.jar:?]
	at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_202]
2023-08-22 12:44:09,860 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:10,015 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-2] (un)registerCallback on LegacyServiceHandler called from url: xmlrpc_bin://127.0.0.1:31999 
2023-08-22 12:44:10,017 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [1009_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2023-08-22 12:44:10,019 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [1009_WorkerPool-0] init finished 
2023-08-22 12:44:10,019 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-1] Added InterfaceId: 1009 
2023-08-22 12:44:14,860 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:19,861 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:24,861 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:29,861 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:34,861 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:39,861 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:44,861 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:49,861 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:54,862 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:44:59,861 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:04,862 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:09,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:14,862 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:19,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:24,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:29,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:34,864 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:39,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:44,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:49,864 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:54,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:45:59,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:04,864 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:09,863 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:14,864 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:19,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:24,864 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:29,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:34,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:39,864 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:44,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:49,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:54,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:46:59,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:04,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:09,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:14,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:19,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:24,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:29,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:34,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:39,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:44,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:49,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:54,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:47:59,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:04,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:09,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:14,865 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:19,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:24,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:29,866 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:34,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:39,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:42,486 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: 0 Accesspoints in Queue 
2023-08-22 12:48:42,486 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2023-08-22 12:48:42,486 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2023-08-22 12:48:44,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:49,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:54,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:48:59,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:04,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:09,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:14,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:19,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:24,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:29,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:34,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:39,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:44,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:49,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:54,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:49:59,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:04,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:09,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:14,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:19,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:24,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:29,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:34,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:39,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:44,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:49,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:54,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:50:59,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:04,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:09,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:14,867 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:19,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:24,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:29,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:34,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:39,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:44,869 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:49,868 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:54,869 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:51:59,869 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:04,870 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:09,870 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:14,871 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:19,870 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:24,871 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:29,870 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:34,871 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:39,871 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:44,872 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:49,872 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:54,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:52:59,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:04,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:09,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:14,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:19,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:24,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:29,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:34,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:39,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:42,486 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: 0 Accesspoints in Queue 
2023-08-22 12:53:42,486 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2023-08-22 12:53:42,486 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2023-08-22 12:53:44,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:49,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:54,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:53:59,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:04,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:09,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:14,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:19,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:24,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:29,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:34,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:39,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:44,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:49,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:54,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:54:59,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:04,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:09,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:14,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:19,873 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:24,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:29,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:34,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:39,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:44,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:49,875 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:54,875 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:55:59,874 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:04,875 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:09,875 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:14,875 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:19,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:24,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:29,877 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:34,877 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:39,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:44,877 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:49,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:54,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:56:59,877 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:04,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:09,877 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:14,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:19,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:24,876 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:29,877 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:34,877 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:39,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:44,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:49,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:54,880 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:57:59,880 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:04,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:09,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:14,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:19,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:24,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:29,880 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:34,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:39,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:42,486 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: 0 Accesspoints in Queue 
2023-08-22 12:58:42,486 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2023-08-22 12:58:42,487 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-3] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2023-08-22 12:58:44,880 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:49,879 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:54,880 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:58:59,880 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:04,881 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:09,881 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:14,881 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:19,881 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:24,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:29,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:34,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:39,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:44,883 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:49,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:54,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 12:59:59,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:04,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:09,883 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:14,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:19,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:24,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:29,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:34,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:39,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:44,883 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:49,882 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 
2023-08-22 13:00:54,883 de.eq3.ccu.bidcos.dispatcher.BidCosRpcDispatcher ERROR [Timer-2] Could not register BidCos-RF_java 

Wie prüfe ich ob "rfcd überhaupt läuft"?

Vielen Dank!

Gruß
Stefan

Antworten

Zurück zu „piVCCU“