Absturz ReGa ab 3.53.30 bei hoher Belastung nach längerer Zeit: Could not create socket (error 24)

Einrichtung, Nutzung und Hilfe zu RaspberryMatic (OCCU auf Raspberry Pi)

Moderatoren: jmaus, Co-Administratoren

Antworten
Benutzeravatar
jmaus
Beiträge: 9848
Registriert: 17.02.2015, 14:45
System: Alternative CCU (auf Basis OCCU)
Wohnort: Dresden
Hat sich bedankt: 462 Mal
Danksagung erhalten: 1863 Mal
Kontaktdaten:
Kontaktdaten von jmaus

Re: Absturz ReGa ab 3.53.30 bei hoher Belastung nach längerer Zeit: Could not create socket (error 24)

Beitrag von jmaus » 02.11.2020, 11:50

roe1974 hat geschrieben: ↑
02.11.2020, 11:42
 Ich verwende das timeout derzeit so .....

Code: Alles auswählen

system.Exec("wget --no-check-certificate --timeout=10 -O - '"#url#"'" , &srueck, &error);
d.h. das ist falsch ?
falsch ist das nicht, nur muss dir bewusst sein das die 10 sekunden timeout nicht max. 10 Sekunden wget ausführungszeit entsprechen, denn wget macht standardmäßig 10 retries. D.h. wenn du mal ein wget auf eine unbekannte IP z.B. machst dann bedeutet das, das er nach 10 sekunden das connect abbricht, dann aber 10 mal nacheinander weiterhin probiert die verbindung aufzubauen. Und das endet dann eben in 10*10 = 100 sekunden maximaler Ausführungszeit. D.h. erst nach ca. 2 Minuten wird wget sich dann verabschieden. Wenn du das nicht willst und sicherstellen willst das wget nur maximal 10 sekunden überhaupt dauern soll ist das "timeout 10" am Anfang ein profunder Weg. Oder aber du fügst noch die Option "-t 1" hinzu um wget auch noch zu sagen er soll maximal eine wiederholung ausführen. Also dann so:

Code: Alles auswählen

system.Exec("wget --no-check-certificate --timeout=10 --tries=1 -O - '"#url#"'" , &srueck, &error);
Ihr seht also, viele Wege führen nach Rom :D
RaspberryMatic 3.75.6.20240316 @ ProxmoxVE – ~200 Hm-RF/HmIP-RF/HmIPW Geräte + ioBroker + HomeAssistant – GitHub / Sponsors / PayPal / ☕️
Nach oben
Benutzeravatar
roe1974
Beiträge: 746
Registriert: 17.10.2017, 16:15
System: Alternative CCU (auf Basis OCCU)
Wohnort: Wien
Hat sich bedankt: 52 Mal
Danksagung erhalten: 13 Mal

Re: Absturz ReGa ab 3.53.30 bei hoher Belastung nach längerer Zeit: Could not create socket (error 24)

Beitrag von roe1974 » 02.11.2020, 12:01

Super !

Vielen Dank für die Info ... wird gleich ergänzt :-)
Das ist halt mal mein Weg nach Rom *ggggg*

lg Richard
Nach oben
Benutzeravatar
jmaus
Beiträge: 9848
Registriert: 17.02.2015, 14:45
System: Alternative CCU (auf Basis OCCU)
Wohnort: Dresden
Hat sich bedankt: 462 Mal
Danksagung erhalten: 1863 Mal
Kontaktdaten:
Kontaktdaten von jmaus

Re: Absturz ReGa ab 3.53.30 bei hoher Belastung nach längerer Zeit: Could not create socket (error 24)

Beitrag von jmaus » 03.11.2020, 08:24

jmaus hat geschrieben: ↑
02.11.2020, 08:39
Michael K. hat geschrieben: ↑
01.11.2020, 15:06
 Snapshot 3.53.34.20201101 installiert. Es ist leider keine Verbesserung.

Jede Ausführung von

Code: Alles auswählen

system.Exec("wget -q -O -T 2 /dev/null http://192.168.1.9:8080/refresh &", &stdout, &stderr);
erzeugt zwei zusätzliche Einträge bei

Code: Alles auswählen

lsof | grep ReGa
[...]
902     /bin/ReGaHss    pipe:[214328]
902     /bin/ReGaHss    pipe:[214328]
wohingegen ohne &

Code: Alles auswählen

system.Exec("wget -q -O -T 2 /dev/null http://192.168.1.9:8080/refresh", &stdout, &stderr);
keine neue Einträge erzeugt werden.
So, nun habe ich mir das ganze nochmal etwas näher angeschaut und konnte es in der Tat selbst reproduzieren. Sehr guter Hinweis und Auswertung mit der "lsof" Ausgabe. Das hatte ich ganz übersehen gehabt das unter gewissen bedingungen diese Pipes zwar generiert, aber nicht geschlossen werden. Das könnte in der Tat die Probleme in der Langzeitstabilität erklären, weil dann ReGaHss ggf. über einen längeren Zeitraum die File Descriptoren ausgehen. Hab das Problem auch schon bereits intern hier korrigiert und die nächste ReGaHss (R1.00.0388.0226) sollte es beheben.
Nun gibt es inzwischen ein neues nightly build snapshot (3.53.34.20201103-1826d3) das unter anderem die aktuelle ReGaHss version beinhaltet die dieses Problem final beheben sollte. Wäre also gut wenn du mit dem aktuellsten Snapshot das ganze nochmal testen könntest ud entsprechend Feedback gibst ob es nun hoffentlich final behoben ist und dann wird nur die Zeit zeigen das das hoffentlich auch die Abstürze beseitigen sollte die bei dir nach einer gewissen Zeit aufgetreten sind.
RaspberryMatic 3.75.6.20240316 @ ProxmoxVE – ~200 Hm-RF/HmIP-RF/HmIPW Geräte + ioBroker + HomeAssistant – GitHub / Sponsors / PayPal / ☕️
Nach oben
Michael K.
Beiträge: 38
Registriert: 05.02.2014, 22:10
Hat sich bedankt: 1 Mal
Danksagung erhalten: 4 Mal

Re: Absturz ReGa ab 3.53.30 bei hoher Belastung nach längerer Zeit: Could not create socket (error 24)

Beitrag von Michael K. » 03.11.2020, 19:02

Ist installiert. Anzahl der lsof Ergebnisse bleibt konstant, in jeder Variante des system.Exec Aufrufs (mit und ohne &, und auch mit und ohne meinem Tippfehler).

Werde es jetzt produktiv laufen lassen und beobachten.
Nach oben
Michael K.
Beiträge: 38
Registriert: 05.02.2014, 22:10
Hat sich bedankt: 1 Mal
Danksagung erhalten: 4 Mal

Re: Absturz ReGa ab 3.53.30 bei hoher Belastung nach längerer Zeit: Could not create socket (error 24)

Beitrag von Michael K. » 03.11.2020, 19:21

Gerade ist mir aufgefallen, dass mit dem nightly ein NullPointerException im hmserver log aufgetaucht ist (Nov 3 18:54:13)

Mit dem nightly

Code: Alles auswählen

***** hmserver.log *****
Nov 3 18:53:58 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] @GenericFactory 
Nov 3 18:53:58 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] created instance of HMServerConfiguration with parameter(s) 
Nov 3 18:53:58 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] passed 1 parameter(s), in declarative order [String] 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [HMIPTRXWriterWorker] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KeyServerWorker] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KryoPersistenceWorker] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [TransactionSubsystemHandler] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [FirmwareLoaderFileSystem] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerPersistentDataLoader] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerAdapterInitialization] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [TransactionManagementVerticle] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [BackendCommandHandler] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionAcceptHandler] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CheckDeviceExistHandler] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [IncomingHMIPFrameHandler] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceBackgroundUpdateSubsystem] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceLiveUpdateSubsystem] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionDefaultConfigurationChanger] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CyclicSmokeDetectorAwakening] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerFirmwareUpdateInitialization] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [RoutingNotificationHandler] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [BackboneWorker] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [RouteManagementWorker] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyNotificationHandler] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyAPIWorker] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBackendNotificationHandler] (3) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBlindLevelCorrectionHandler] (1) *worker 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyInitializion] (1)  
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: deploying 25 classes to Vert.x 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: 25 VertxDeployers initialized 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of TransactionSubsystemHandler succeeded (7bdb9e1b-d4c0-48c6-9d32-7bb9fce4fb31) 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of CyclicSmokeDetectorAwakening succeeded (093e1712-2911-42b6-ba58-bc135c07f916) 
Nov 3 18:54:05 de.eq3.cbcs.server.core.vertx.KeyServerWorker ERROR [vert.x-worker-thread-0] Missing key server configuration parameter (Network.Key) for  mode: KEYSERVER_LOCAL 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of CheckDeviceExistHandler succeeded (a5700392-ccc1-4bca-822a-204818e88405) 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of DeviceInclusionDefaultConfigurationChanger succeeded (82aa5cbb-2e28-4ebb-8f87-7f8fe4a51d79) 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of HMIPTRXWriterWorker succeeded (f4364b5c-873e-44d4-bef4-34a1cdc6763d) 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of RoutingNotificationHandler succeeded (eaa49122-ee5c-469f-bd8b-05d9da1bc1a3) 
Nov 3 18:54:05 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LegacyBlindLevelCorrectionHandler succeeded (2ccffc14-2976-4dc9-ab5a-ab697e9d7c43) 
Nov 3 18:54:06 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of KryoPersistenceWorker succeeded (14982441-5dbe-4de0-aeac-9ab1d40a5245) 
Nov 3 18:54:06 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LocalServerPersistentDataLoader succeeded (2fe2fd16-ee5e-477d-8ff1-90cefbd1da40) 
Nov 3 18:54:06 de.eq3.cbcs.server.core.live_otau.DeviceLiveUpdateSubsystem INFO  [vert.x-eventloop-thread-4] SYSTEM: DeviceLiveUpdateSubsystem started 
Nov 3 18:54:06 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of KeyServerWorker succeeded (de8388bb-7494-4f23-a282-39a2554a5232) 
Nov 3 18:54:06 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of DeviceLiveUpdateSubsystem succeeded (88ce5b56-377b-41ba-83cf-cdf6fb45283a) 
Nov 3 18:54:06 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of DeviceBackgroundUpdateSubsystem succeeded (c276c5d3-767b-4f8e-a93d-63b1901c53dd) 
Nov 3 18:54:06 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of DeviceInclusionAcceptHandler succeeded (1ea8696f-d0fe-42bb-87cf-472dc1ab0f27) 
Nov 3 18:54:07 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of IncomingHMIPFrameHandler succeeded (d77b8c15-359f-4507-a877-457658345c71) 
Nov 3 18:54:07 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-3] SYSTEM: Firmware update directory is set to /etc/config/firmware 
Nov 3 18:54:07 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of FirmwareLoaderFileSystem succeeded (03233da6-73b1-4260-9890-b0e1b994444e) 
Nov 3 18:54:07 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of TransactionManagementVerticle succeeded (e0bb0722-c93c-427f-be61-5d714fcdb26b) 
Nov 3 18:54:07 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of LocalServerAdapterInitialization succeeded (4042996c-0949-4eba-8cee-e429048bfea8) 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter state 1: HMIP_TRX_App 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter application is already running or started 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] No NWK, try to set address ... 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Try to set radio address 12230143... 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Set max send attempts for 3014F711A0001F58A992F4F1 to 3 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Try to get application version... 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Application version 4.2.6 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Bootloader version 1.0.1 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] hmos version 1.46.4 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] MCU type: CC1310 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Duty Cycle: 0.0 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] set DutyCycle limit to ffffffc8 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Set Duty Cycle Limit 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Current Security Counter: 433583104 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Update security counter to calculation: 434214933 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter has no linkpartner 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Adapter with Access Point id 3014F711A0001F58A992F4F1 initialized 
Nov 3 18:54:07 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [Thread-6] HMIPTRXInitialResponseListener said that Adapter was initialized 
Nov 3 18:54:08 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of LocalServerFirmwareUpdateInitialization succeeded (8d02969a-5b38-42c4-9f3d-923b5e2ffe26) 
Nov 3 18:54:08 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-6] SYSTEM: Checking all devices on all accesspoints for updates 
Nov 3 18:54:08 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-6] SYSTEM: There are 0 APs queued with updatable devices (RF) 
Nov 3 18:54:08 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-6] SYSTEM: There are 0 APs queued with updatable devices (WIRED) 
Nov 3 18:54:08 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of RouteManagementWorker succeeded (a792613f-c736-4215-8f13-dc48967663d9) 
Nov 3 18:54:08 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of BackendCommandHandler succeeded (097554a8-0d0d-4326-a000-572c8968bef5) 
Nov 3 18:54:08 de.eq3.cbcs.lib.backbone.lanrouting.UdpServer INFO  [vert.x-worker-thread-0] UDP Routing configuration: trying to bind port 43438 on eth0 0.0.0.0 -> 192.168.1.8 
Nov 3 18:54:08 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LegacyNotificationHandler succeeded (6b13d571-b41c-4c43-ac66-9fe169754ab9) 
Nov 3 18:54:08 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LegacyBackendNotificationHandler succeeded (d5ee0d7a-a2fb-450d-9b9b-7e7ae0283c9a) 
Nov 3 18:54:08 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of LegacyAPIWorker succeeded (1367daf4-62f4-4f1f-b7e0-fd098b74c7a6) 
Nov 3 18:54:09 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of BackboneWorker succeeded (79cf6e29-9b2f-48bb-9e33-2c17839ef0f3) 
Nov 3 18:54:09 de.eq3.cbcs.lib.backbone.lanrouting.UdpServer INFO  [vert.x-worker-thread-3] UDP Routing established on network interface eth0 : 0.0.0.0 (192.168.1.8) 
Nov 3 18:54:09 de.eq3.cbcs.lib.backbone.lanrouting.UdpServer INFO  [vert.x-worker-thread-1] UDP Routing multi cast 'DEFAULT_MULTICAST_ADDRESS' established on network interface eth0 : 192.168.1.8 
Nov 3 18:54:10 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of LegacyInitializion succeeded (39612990-a1b8-45a2-a8ca-f5e2c7f4b378) 
Nov 3 18:54:10 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: initial deployment complete _____________________________________________________ 
Nov 3 18:54:10 de.eq3.cbcs.server.local.LocalServer INFO  [Thread-0] SYSTEM: Bind XML-RPC api to port 32010 
Nov 3 18:54:13 de.eq3.cbcs.server.core.transaction.TransactionManagementVerticle ERROR [vert.x-eventloop-thread-3] AP 3014F711A0001F58A992F4F1: Error while queueing transaction: 
java.lang.NullPointerException
	at de.eq3.cbcs.server.core.task.protocol.SendFrameTask.determineActualTargetInterface(SendFrameTask.java:420)
	at de.eq3.cbcs.server.core.task.protocol.SendFrameTask.getTargetIdentifier(SendFrameTask.java:191)
	at de.eq3.cbcs.server.core.task.constraint.TargetInterfaceTaskConstraint.evaluateExecution(TargetInterfaceTaskConstraint.java:42)
	at de.eq3.cbcs.transaction.management.TransactionManager.isExecutionPossible(TransactionManager.java:577)
	at de.eq3.cbcs.transaction.management.TransactionManager.executeNextTasks(TransactionManager.java:501)
	at de.eq3.cbcs.transaction.management.TransactionManager.queueTransaction(TransactionManager.java:219)
	at de.eq3.cbcs.transaction.hmip.management.HmipTransactionManager.queueTransaction(HmipTransactionManager.java:102)
	at de.eq3.cbcs.server.core.transaction.TransactionManagementVerticle$4.handle(TransactionManagementVerticle.java:246)
	at de.eq3.cbcs.server.core.transaction.TransactionManagementVerticle$4.handle(TransactionManagementVerticle.java:216)
	at io.vertx.core.eventbus.impl.HandlerRegistration.deliver(HandlerRegistration.java:212)
	at io.vertx.core.eventbus.impl.HandlerRegistration.handle(HandlerRegistration.java:191)
	at io.vertx.core.eventbus.impl.EventBusImpl.lambda$deliverToHandler$3(EventBusImpl.java:505)
	at io.vertx.core.impl.ContextImpl.lambda$wrapTask$2(ContextImpl.java:337)
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:163)
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:403)
	at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:445)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:858)
	at java.lang.Thread.run(Thread.java:748)
Nov 3 18:54:13 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default MaxEventLoopExecuteTime: 2000000000 
Nov 3 18:54:13 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default BlockedThreadCheckInterval: 1000 
Nov 3 18:54:13 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default MaxWorkerExecuteTime: 60000000000 
Nov 3 18:54:13 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default EventLoopPoolSize: 8 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [BackendWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [GroupRequestWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DiagramRequestWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [StorageRequestWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceFirmwareRequestWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [EnergyPriceRequestWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [CouplingRequestWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [RegaClientWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [GroupConfigurationPersistenceFileSystem] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [HmIPGatewayManagementRequestWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [AccessPointUpdateServerWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [AccessPointUpdateLoaderWorker] (1) *worker 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: deploying 12 classes to Vert.x 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: 12 VertxDeployers initialized 
Nov 3 18:54:13 de.eq3.ccu.hmip.accesspoint.update.AccessPointUpdateLoaderWorker INFO  [vert.x-worker-thread-7] SYSTEM: Firmware update directory is set to /etc/config/firmware 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of AccessPointUpdateLoaderWorker succeeded (5a179118-dbd2-47b4-8232-9b9a887bf8a8) 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of BackendWorker succeeded (f5ec67df-ac69-4895-8e16-469f5a305e78) 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of CouplingRequestWorker succeeded (2ebd17cb-674f-41e7-8cfb-bf80f3a92249) 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of EnergyPriceRequestWorker succeeded (bb18d707-25d0-48a4-92c3-868eb32a7ddd) 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of GroupConfigurationPersistenceFileSystem succeeded (cac5a870-c580-453b-954d-54233575aa1d) 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of AccessPointUpdateServerWorker succeeded (05f3a9d0-6d68-4cac-88e8-3ce8ffca9fea) 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of StorageRequestWorker succeeded (8b56402c-f1b4-4fe2-bf27-7ea65d05ce84) 
Nov 3 18:54:13 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of RegaClientWorker succeeded (344e2241-69cc-4678-8755-086cd9cee66a) 
Nov 3 18:54:14 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of GroupRequestWorker succeeded (0123dcde-cbbb-4591-9bd3-b08f80e5e0c2) 
Nov 3 18:54:14 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of DiagramRequestWorker succeeded (7540e700-d803-47e5-9e22-b5b4d9dbccac) 
Nov 3 18:54:14 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (db3ee51f-afa2-4ee4-905e-817f5bbb0bf5) 
Nov 3 18:54:14 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of HmIPGatewayManagementRequestWorker succeeded (27055ada-67d0-4eae-ade2-de18feee0082) 
Nov 3 18:54:14 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: initial deployment complete _____________________________________________________ 
Nov 3 18:54:14 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Starting HMServer at 127.0.0.1:39292 
Nov 3 18:54:14 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Read Configuration 
Nov 3 18:54:14 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create Bidcos Dispatcher 
Nov 3 18:54:14 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] InitBidCosCache 
Nov 3 18:54:15 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create groupDefinitionProvider 
Nov 3 18:54:16 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create VirtualDeviceHolder 
Nov 3 18:54:16 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create VirtualDeviceHandlerRega 
Nov 3 18:54:16 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupAdministrationService 
Nov 3 18:54:16 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupDeviceDispatcher 
...
messages im Fehlerzeitraum sind unauffällig

Code: Alles auswählen

Nov  3 18:53:49 homematic-ccu2 user.info kernel: [   39.900503] eq3loop: created slave mmd_hmip
Nov  3 18:53:49 homematic-ccu2 user.info kernel: [   39.900883] eq3loop: created slave mmd_bidcos
Nov  3 18:53:52 homematic-ccu2 user.info kernel: [   42.075797] eq3loop: eq3loop_open_slave() mmd_bidcos
Nov  3 18:54:07 homematic-ccu2 user.info kernel: [   57.205773] eq3loop: eq3loop_open_slave() mmd_hmip
Nov  3 18:54:07 homematic-ccu2 user.info kernel: [   57.205969] eq3loop: eq3loop_close_slave() mmd_hmip
Nov  3 18:54:07 homematic-ccu2 user.info kernel: [   57.209281] eq3loop: eq3loop_open_slave() mmd_hmip
Nov  3 18:54:07 homematic-ccu2 user.info kernel: [   57.209441] eq3loop: eq3loop_close_slave() mmd_hmip
Nov  3 18:54:07 homematic-ccu2 user.info kernel: [   57.220103] eq3loop: eq3loop_open_slave() mmd_hmip
Nov  3 18:54:22 homematic-ccu2 user.info kernel: [   72.598536] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Nov  3 18:54:22 homematic-ccu2 user.info kernel: [   72.667248] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Nov  3 17:54:22 homematic-ccu2 daemon.info : starting pid 964, tty '/dev/null': '/usr/bin/monit -Ic /etc/monitrc'
Nov  3 18:54:22 homematic-ccu2 user.info monit[964]: Starting Monit 5.26.0 daemon with http interface at /var/run/monit.sock
Nov  3 18:54:22 homematic-ccu2 user.info monit[964]: 'homematic-ccu2' Monit 5.26.0 started
Zum Vergleich: hmserver.log der Vorversion.

Code: Alles auswählen

***** hmserver.log *****
Oct 29 11:08:13 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] @GenericFactory 
Oct 29 11:08:13 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] created instance of HMServerConfiguration with parameter(s) 
Oct 29 11:08:13 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] passed 1 parameter(s), in declarative order [String] 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [HMIPTRXWriterWorker] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KeyServerWorker] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KryoPersistenceWorker] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [TransactionSubsystemHandler] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [FirmwareLoaderFileSystem] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerPersistentDataLoader] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerAdapterInitialization] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [TransactionManagementVerticle] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [BackendCommandHandler] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionAcceptHandler] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CheckDeviceExistHandler] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [IncomingHMIPFrameHandler] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceBackgroundUpdateSubsystem] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceLiveUpdateSubsystem] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionDefaultConfigurationChanger] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CyclicSmokeDetectorAwakening] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerFirmwareUpdateInitialization] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [RoutingNotificationHandler] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [BackboneWorker] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [RouteManagementWorker] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyNotificationHandler] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyAPIWorker] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBackendNotificationHandler] (3) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBlindLevelCorrectionHandler] (1) *worker 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyInitializion] (1)  
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: deploying 25 classes to Vert.x 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: 25 VertxDeployers initialized 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of CyclicSmokeDetectorAwakening succeeded (36f99c67-dbc1-4b0a-b082-529a5be060be) 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of DeviceInclusionDefaultConfigurationChanger succeeded (0ee52f38-aab5-43b7-a3d0-f3fa6bb88717) 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of TransactionSubsystemHandler succeeded (fbfb7fa4-5acc-4ee0-b31a-16d06d38c3e0) 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of RoutingNotificationHandler succeeded (3fb477c5-50d2-4efc-a9da-98112ed8ae90) 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of HMIPTRXWriterWorker succeeded (785f7130-fede-4a95-bc3c-085788f35d9b) 
Oct 29 11:08:21 de.eq3.cbcs.server.core.vertx.KeyServerWorker ERROR [vert.x-worker-thread-0] Missing key server configuration parameter (Network.Key) for  mode: KEYSERVER_LOCAL 
Oct 29 11:08:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of KeyServerWorker succeeded (75013897-5cd9-42e1-a9c1-1bcb2afa622d) 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of KryoPersistenceWorker succeeded (21766352-21cb-4a5f-9dc1-9d9f3a896148) 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LocalServerPersistentDataLoader succeeded (9d168704-30bf-4426-9ccd-ae185e5a67d6) 
Oct 29 11:08:22 de.eq3.cbcs.server.core.live_otau.DeviceLiveUpdateSubsystem INFO  [vert.x-eventloop-thread-4] SYSTEM: DeviceLiveUpdateSubsystem started 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of DeviceLiveUpdateSubsystem succeeded (440cf875-8776-45e1-8521-7054ac79ef08) 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of CheckDeviceExistHandler succeeded (6d4887e4-6f8b-4dd4-b62c-e90ce789b205) 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LegacyBlindLevelCorrectionHandler succeeded (d7029a50-9cea-47ae-9a90-c2e974c6a35e) 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DeviceBackgroundUpdateSubsystem succeeded (b8281080-73af-4886-b472-676972124085) 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of DeviceInclusionAcceptHandler succeeded (4c7f9908-5588-460e-84f6-81f411fe2388) 
Oct 29 11:08:22 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-3] SYSTEM: Firmware update directory is set to /etc/config/firmware 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of FirmwareLoaderFileSystem succeeded (2c5d51a9-caf6-4926-87bc-2f4242461bc6) 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of IncomingHMIPFrameHandler succeeded (540c495f-b9f2-458d-ae2a-62a457cef227) 
Oct 29 11:08:22 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of TransactionManagementVerticle succeeded (7cc3d861-0b8d-4714-8e87-67cfa391f6f4) 
Oct 29 11:08:23 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of LocalServerAdapterInitialization succeeded (f7e5d173-9a3c-4e09-b20a-a2140ce1df0b) 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter state 1: HMIP_TRX_App 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter application is already running or started 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] No NWK, try to set address ... 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Try to set radio address 12230143... 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Set max send attempts for 3014F711A0001F58A992F4F1 to 3 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Try to get application version... 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Application version 4.2.6 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Bootloader version 1.0.1 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] hmos version 1.46.4 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] MCU type: CC1310 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Duty Cycle: 0.0 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] set DutyCycle limit to ffffffc8 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Set Duty Cycle Limit 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Current Security Counter: 432679936 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Update security counter to calculation: 432681786 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter has no linkpartner 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Adapter with Access Point id 3014F711A0001F58A992F4F1 initialized 
Oct 29 11:08:23 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [Thread-6] HMIPTRXInitialResponseListener said that Adapter was initialized 
Oct 29 11:08:24 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LegacyNotificationHandler succeeded (7d58b6cb-0e7d-4555-b843-4180c8802b32) 
Oct 29 11:08:24 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LocalServerFirmwareUpdateInitialization succeeded (77adb6d3-cacd-4ef5-ac63-a6bacbfacd67) 
Oct 29 11:08:24 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-6] SYSTEM: Checking all devices on all accesspoints for updates 
Oct 29 11:08:24 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-6] SYSTEM: There are 0 APs queued with updatable devices (RF) 
Oct 29 11:08:24 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-6] SYSTEM: There are 0 APs queued with updatable devices (WIRED) 
Oct 29 11:08:24 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of RouteManagementWorker succeeded (bf4c4795-8cb5-4c07-8016-47b2e243fdc3) 
Oct 29 11:08:24 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of BackendCommandHandler succeeded (0fd12a34-e7b4-4582-95c2-819fd52e8708) 
Oct 29 11:08:24 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LegacyBackendNotificationHandler succeeded (8b241c80-6f30-4583-b199-4aa8b7c8c090) 
Oct 29 11:08:24 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LegacyAPIWorker succeeded (6c9253ba-bc2f-41f5-ba23-87f410d15442) 
Oct 29 11:08:24 de.eq3.cbcs.lib.backbone.lanrouting.UdpServer INFO  [vert.x-worker-thread-2] UDP Routing configuration: trying to bind port 43438 on eth0 0.0.0.0 -> 192.168.1.8 
Oct 29 11:08:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of BackboneWorker succeeded (3ca2e296-b3b6-43e9-ba0d-59bac74668e0) 
Oct 29 11:08:25 de.eq3.cbcs.lib.backbone.lanrouting.UdpServer INFO  [vert.x-worker-thread-4] UDP Routing established on network interface eth0 : 0.0.0.0 (192.168.1.8) 
Oct 29 11:08:25 de.eq3.cbcs.lib.backbone.lanrouting.UdpServer INFO  [vert.x-worker-thread-3] UDP Routing multi cast 'DEFAULT_MULTICAST_ADDRESS' established on network interface eth0 : 192.168.1.8 
Oct 29 11:08:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LegacyInitializion succeeded (05ea1317-7797-45e1-9ae6-ce82107d34fd) 
Oct 29 11:08:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: initial deployment complete _____________________________________________________ 
Oct 29 11:08:26 de.eq3.cbcs.server.local.LocalServer INFO  [Thread-0] SYSTEM: Bind XML-RPC api to port 32010 
Oct 29 11:08:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default MaxEventLoopExecuteTime: 2000000000 
Oct 29 11:08:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default BlockedThreadCheckInterval: 1000 
Oct 29 11:08:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default MaxWorkerExecuteTime: 60000000000 
Oct 29 11:08:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default EventLoopPoolSize: 8 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [BackendWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [GroupRequestWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DiagramRequestWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [StorageRequestWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceFirmwareRequestWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [EnergyPriceRequestWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [CouplingRequestWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [RegaClientWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [GroupConfigurationPersistenceFileSystem] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [HmIPGatewayManagementRequestWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [AccessPointUpdateServerWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [AccessPointUpdateLoaderWorker] (1) *worker 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: deploying 12 classes to Vert.x 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of BackendWorker succeeded (07fbff65-2e9d-401f-a9bb-e7deff20f863) 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: 12 VertxDeployers initialized 
Oct 29 11:08:28 de.eq3.ccu.hmip.accesspoint.update.AccessPointUpdateLoaderWorker INFO  [vert.x-worker-thread-9] SYSTEM: Firmware update directory is set to /etc/config/firmware 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of AccessPointUpdateLoaderWorker succeeded (bad08d70-f6f3-4914-953e-b127957ee065) 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of GroupConfigurationPersistenceFileSystem succeeded (761d9b87-6f47-4871-9110-85a58b69a42a) 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of StorageRequestWorker succeeded (c7880f13-6ff3-4592-89b0-3a0f2ea46f3c) 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of EnergyPriceRequestWorker succeeded (627057e1-1db7-4ace-a628-9d83a1fa2a8a) 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of RegaClientWorker succeeded (0a2cdcbc-79c1-4300-8f73-534e30328d0c) 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of CouplingRequestWorker succeeded (e93430ad-e907-49dd-8fbc-a9b1c7f0f985) 
Oct 29 11:08:28 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of AccessPointUpdateServerWorker succeeded (4a583115-a4a5-4fe8-89b5-37f57fb5e898) 
Oct 29 11:08:29 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DiagramRequestWorker succeeded (6fb21dac-8547-4b54-8995-34c6bd4d6485) 
Oct 29 11:08:29 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of GroupRequestWorker succeeded (72ca423b-1b5b-4012-9699-aab892c881d1) 
Oct 29 11:08:29 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (9d769070-f29b-485e-ae6d-76f3c15bd816) 
Oct 29 11:08:29 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of HmIPGatewayManagementRequestWorker succeeded (8b46b9ef-dd69-42c8-8048-ba5902a16e3e) 
Oct 29 11:08:29 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: initial deployment complete _____________________________________________________ 
Oct 29 11:08:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Starting HMServer at 127.0.0.1:39292 
Oct 29 11:08:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Read Configuration 
Oct 29 11:08:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create Bidcos Dispatcher 
Oct 29 11:08:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] InitBidCosCache 
Oct 29 11:08:30 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create groupDefinitionProvider 
Oct 29 11:08:31 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create VirtualDeviceHolder 
Oct 29 11:08:31 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create VirtualDeviceHandlerRega 
Oct 29 11:08:31 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupAdministrationService 
...
Es scheint aber alles zu funktionieren....
Nach oben
Benutzeravatar
jmaus
Beiträge: 9848
Registriert: 17.02.2015, 14:45
System: Alternative CCU (auf Basis OCCU)
Wohnort: Dresden
Hat sich bedankt: 462 Mal
Danksagung erhalten: 1863 Mal
Kontaktdaten:
Kontaktdaten von jmaus

Re: Absturz ReGa ab 3.53.30 bei hoher Belastung nach längerer Zeit: Could not create socket (error 24)

Beitrag von jmaus » 03.11.2020, 20:18

Michael K. hat geschrieben: ↑
03.11.2020, 19:21
 Gerade ist mir aufgefallen, dass mit dem nightly ein NullPointerException im hmserver log aufgetaucht ist (Nov 3 18:54:13)
Kann schon passieren, ist halt Java :lol:

Aber bitte jetzt hier nicht diesen Beitrag für alle möglichen Dinge wiederverwenden. Hier gehts nur um die vermeintlichen Abstürze.
RaspberryMatic 3.75.6.20240316 @ ProxmoxVE – ~200 Hm-RF/HmIP-RF/HmIPW Geräte + ioBroker + HomeAssistant – GitHub / Sponsors / PayPal / ☕️
Nach oben
Hackertomm
Beiträge: 680
Registriert: 18.04.2018, 12:32
System: Alternative CCU (auf Basis OCCU)
Wohnort: Neuhausen auf den Fildern
Hat sich bedankt: 15 Mal
Danksagung erhalten: 19 Mal

Re: Absturz ReGa ab 3.53.30 bei hoher Belastung nach längerer Zeit: Could not create socket (error 24)

Beitrag von Hackertomm » 04.11.2020, 11:38

jmaus hat geschrieben: ↑
02.11.2020, 10:18
 In der Tat sollte folgender Aufruf in diesem Falle besser sein:

Code: Alles auswählen

system.Exec("timeout 2 wget -q -O /dev/null -T 2 '" # clear # "' &");
D.h. man schmeisst die Ausgabe die das wget ggf. erzeugt nach /dev/null, also auf den Müll. Das erscheint mir aktuell die performanteste und sicherste Methode zu sein ein wget das keinerlei Rückgabedaten liefern soll aufzurufen und mittels "timeout" befehl sicherzustellen das dieser befehl auf der einen seite die ReGaHss nicht unnötig blockiert, sondern auch nicht für lange zeit hintergrundprozesse anlegt die auf etwas warte was nicht mehr kommen wird.
Das werde ich auch mal in meinem Script ausprobieren, das Wetterdaten an das DIY LCD-Display von Sebastian Gehmlich Sendet.
Ich habe damit zwar kein Problem, das läuft klaglos, aber ich bin da für Verbesserungen offen.
Ich habe da ein I2C 20x4 Display dran und brauche pro Zeile einen System.exec, da es pro Zeile jeweils andere Daten ausgibt.
Die von 3 Wettersensoren und einen Systemzustand.
Wobei einer der 3 selbergebauten DIY Wettersensoren, die mit einem BME280 laufen, mit einem anderen Sketch versehen wurde, der zusätzlich, neben Temperatur und Luftfeuchtigkeit, auch den Luftdruck ausgibt.

Ist zwar nur eine Spielerei, die so quasi nebenher läuft, aber trotzdem bin ich an Verbesserungen interessiert.
Gruß
Hackertomm

Virtual Image auf einer Qnap TS-451D2, 2GHZ Celeron u. 8GB RAM, aktuell Raspberry OVA, Vers. 3.71.12.20231020
Nach oben
Antworten

Zurück zu „RaspberryMatic“