piVCCu reagiert nicht.

Virtualisierte CCU für Raspberry Pi und Clones

Moderator: Co-Administratoren

Antworten
fab_joe
Beiträge: 7
Registriert: 02.04.2018, 17:23

piVCCu reagiert nicht.

Beitrag von fab_joe » 15.09.2022, 17:05

Hallo,
nach einem Update (vor ca.6 Wochen?) reagiert meine piVCCU nicht mehr, es kommt aus dem nichts und ist nach einem neustart weg, mal hält es eine Woche, mal nur ein paar Stunden wie heute. Anbei der Log.

Kann man daran erkennen was los ist ? um 08:29 Uhr scheint etwas zu passieren...:

2022-09-15 08:29:00,536 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 8:29:00 AM org.apache.http.impl.client.DefaultHttpClient tryExecute
2022-09-15 08:29:00,537 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:39292: Broken pipe (Write failed)
2022-09-15 08:29:00,539 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 8:29:00 AM org.apache.http.impl.client.DefaultHttpClient tryExecute
2022-09-15 08:29:00,539 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: Retrying request to {}->http://127.0.0.1:39292

Ich Danke vorab für die liebe Unterstützung.

Grüße
Fabian

ganzer Log:

Code: Alles auswählen

2022-09-15 06:57:16,840 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] @GenericFactory 
2022-09-15 06:57:16,873 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] created instance of HMServerConfiguration with parameter(s) 
2022-09-15 06:57:16,873 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] passed 1 parameter(s), in declarative order [String] 
2022-09-15 06:57:24,394 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [HMIPTRXWriterWorker] (1) *worker 
2022-09-15 06:57:24,396 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [KeyServerWorker] (1) *worker 
2022-09-15 06:57:24,396 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [KryoPersistenceWorker] (1) *worker 
2022-09-15 06:57:24,397 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [TransactionSubsystemHandler] (1) *worker 
2022-09-15 06:57:24,397 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [FirmwareLoaderFileSystem] (1) *worker 
2022-09-15 06:57:24,397 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LocalServerPersistentDataLoader] (1)  
2022-09-15 06:57:24,398 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LocalServerAdapterInitialization] (1)  
2022-09-15 06:57:24,398 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [TransactionManagementVerticle] (1)  
2022-09-15 06:57:24,398 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [BackendCommandHandler] (1)  
2022-09-15 06:57:24,399 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [StatemanagementResponseHandler] (1)  
2022-09-15 06:57:24,399 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [StatemanagementRequestHandler] (1)  
2022-09-15 06:57:24,399 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceInclusionAcceptHandler] (1)  
2022-09-15 06:57:24,400 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [CheckDeviceExistHandler] (1)  
2022-09-15 06:57:24,400 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [IncomingHMIPFrameHandler] (1)  
2022-09-15 06:57:24,400 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceBackgroundUpdateSubsystem] (1)  
2022-09-15 06:57:24,401 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceLiveUpdateSubsystem] (1)  
2022-09-15 06:57:24,401 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceDefaultConfigurationChanger] (1)  
2022-09-15 06:57:24,401 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [CyclicSmokeDetectorAwakening] (1)  
2022-09-15 06:57:24,402 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DisplayUpdateStatusHandler] (1)  
2022-09-15 06:57:24,402 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LocalServerFirmwareUpdateInitialization] (1)  
2022-09-15 06:57:24,411 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyNotificationHandler] (1) *worker 
2022-09-15 06:57:24,412 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyAPIWorker] (1) *worker 
2022-09-15 06:57:24,412 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyBackendNotificationHandler] (3) *worker 
2022-09-15 06:57:24,412 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyBlindLevelCorrectionHandler] (1) *worker 
2022-09-15 06:57:24,413 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [LegacyInitializion] (1)  
2022-09-15 06:57:24,436 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: deploying 25 classes to Vert.x 
2022-09-15 06:57:24,523 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: 25 VertxDeployers initialized 
2022-09-15 06:57:24,713 de.eq3.cbcs.server.core.vertx.CyclicSmokeDetectorAwakening INFO  [vert.x-eventloop-thread-1] SYSTEM: CyclicSmokeDetectorAwakening Verticle or Worker started 
2022-09-15 06:57:24,735 de.eq3.cbcs.server.core.vertx.DisplayUpdateStatusHandler INFO  [vert.x-eventloop-thread-5] SYSTEM: DisplayUpdateStatusHandler Verticle or Worker started 
2022-09-15 06:57:24,735 de.eq3.cbcs.statemanagement.StatemanagementRequestHandler INFO  [vert.x-eventloop-thread-4] SYSTEM: StatemanagementRequestHandler Verticle or Worker started 
2022-09-15 06:57:24,736 de.eq3.cbcs.server.core.vertx.HMIPAbstractWriterWorker INFO  [vert.x-worker-thread-0] SYSTEM: HMIPTRXWriterWorker Verticle or Worker started 
2022-09-15 06:57:24,741 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBlindLevelCorrectionHandler INFO  [vert.x-worker-thread-1] SYSTEM: LegacyBlindLevelCorrectionHandler Verticle or Worker started 
2022-09-15 06:57:24,744 de.eq3.cbcs.server.core.vertx.TransactionSubsystemHandler INFO  [vert.x-worker-thread-3] SYSTEM: TransactionSubsystemHandler Verticle or Worker started 
2022-09-15 06:57:24,747 de.eq3.cbcs.server.core.vertx.DeviceDefaultConfigurationChanger INFO  [vert.x-eventloop-thread-2] SYSTEM: DeviceDefaultConfigurationChanger Verticle or Worker started 
2022-09-15 06:57:24,751 de.eq3.cbcs.server.core.vertx.KeyServerWorker ERROR [vert.x-worker-thread-2] Missing key server configuration parameter (Network.Key) for  mode: KEYSERVER_LOCAL 
2022-09-15 06:57:24,753 de.eq3.cbcs.server.core.vertx.CheckDeviceExistHandler INFO  [vert.x-eventloop-thread-2] SYSTEM: CheckDeviceExistHandler Verticle or Worker started 
2022-09-15 06:57:24,755 de.eq3.cbcs.server.core.vertx.KeyServerWorker INFO  [vert.x-worker-thread-2] SYSTEM: KeyServerWorker Verticle or Worker started 
2022-09-15 06:57:24,759 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of CyclicSmokeDetectorAwakening succeeded (8f84dcc8-2605-4f21-95fa-3c3fd3dec9dd) 
2022-09-15 06:57:24,761 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of TransactionSubsystemHandler succeeded (5af5053f-0ee3-4016-8fe3-eed5df88d2a4) 
2022-09-15 06:57:24,761 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of DeviceDefaultConfigurationChanger succeeded (3d55328c-e62c-4603-b09c-5cd5ed199f98) 
2022-09-15 06:57:24,766 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of CheckDeviceExistHandler succeeded (d417a145-a06b-48bf-a969-25de0b8c3bdb) 
2022-09-15 06:57:24,766 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of DisplayUpdateStatusHandler succeeded (71594d28-9016-4707-a3e1-6d9833868bf9) 
2022-09-15 06:57:24,770 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of StatemanagementRequestHandler succeeded (4aded8f8-4b43-4cd3-848b-fedac9c257bd) 
2022-09-15 06:57:24,772 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of HMIPTRXWriterWorker succeeded (b00429a6-47e1-4f0b-9a2f-4c7b9b84607e) 
2022-09-15 06:57:24,929 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of KryoPersistenceWorker succeeded (c53abae7-b7f6-47ae-8afb-3497d36a498b) 
2022-09-15 06:57:24,954 de.eq3.cbcs.server.local.base.internal.LocalServerPersistentDataLoader INFO  [vert.x-eventloop-thread-6] SYSTEM: LocalServerPersistentDataLoader Verticle or Worker started 
2022-09-15 06:57:24,959 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of LocalServerPersistentDataLoader succeeded (fd173738-d998-41ce-a797-0a59bff34e53) 
2022-09-15 06:57:25,698 de.eq3.cbcs.server.core.otau.AbstractUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: DeviceBackgroundUpdateSubsystem Verticle or Worker started 
2022-09-15 06:57:25,698 de.eq3.cbcs.server.core.otau.AbstractUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: DeviceLiveUpdateSubsystem Verticle or Worker started 
2022-09-15 06:57:25,699 de.eq3.cbcs.server.core.live_otau.DeviceLiveUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: DeviceLiveUpdateSubsystem started 
2022-09-15 06:57:25,713 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of DeviceLiveUpdateSubsystem succeeded (f712b4e4-629d-4fc4-a90b-4a658ddbbb5d) 
2022-09-15 06:57:25,714 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LegacyBlindLevelCorrectionHandler succeeded (3af7f5c9-9e74-4e3a-bb70-a65f1acca65c) 
2022-09-15 06:57:25,720 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of DeviceBackgroundUpdateSubsystem succeeded (48b0e9bb-fdbb-4ec6-b050-882c2b917580) 
2022-09-15 06:57:25,720 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of KeyServerWorker succeeded (a8b0a324-ca67-4caf-ac1b-7b01e6272344) 
2022-09-15 06:57:26,068 de.eq3.cbcs.server.core.vertx.DeviceInclusionAcceptHandler INFO  [vert.x-eventloop-thread-7] SYSTEM: DeviceInclusionAcceptHandler Verticle or Worker started 
2022-09-15 06:57:26,071 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of DeviceInclusionAcceptHandler succeeded (dfd5f48d-1844-4673-a268-4afad6902153) 
2022-09-15 06:57:26,096 de.eq3.cbcs.server.core.vertx.IncomingHMIPFrameHandler INFO  [vert.x-eventloop-thread-0] SYSTEM: IncomingHMIPFrameHandler Verticle or Worker started 
2022-09-15 06:57:26,098 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of IncomingHMIPFrameHandler succeeded (de355c92-d39d-4c8b-9f6f-37cdb04572bd) 
2022-09-15 06:57:26,337 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [vert.x-eventloop-thread-3] SYSTEM: LocalServerAdapterInitialization Verticle or Worker started 
2022-09-15 06:57:26,340 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LocalServerAdapterInitialization succeeded (586e0c86-509a-49f2-bf25-cd820e927ac8) 
2022-09-15 06:57:26,379 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] TRX adapter state 1: HMIP_TRX_App 
2022-09-15 06:57:26,380 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] TRX adapter application is already running or started 
2022-09-15 06:57:26,380 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] No NWK, try to set address ... 
2022-09-15 06:57:26,381 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Try to set radio address 12535955... 
2022-09-15 06:57:26,403 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Set max send attempts for 3014F711A061A7D7098E0CD9 to 3 
2022-09-15 06:57:26,424 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Try to get application version... 
2022-09-15 06:57:26,446 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Application version 2.8.6 
2022-09-15 06:57:26,446 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Bootloader version 1.0.3 
2022-09-15 06:57:26,447 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] hmos version 1.20.3 
2022-09-15 06:57:27,480 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-1] SYSTEM: Firmware update directory is set to /etc/config/firmware 
2022-09-15 06:57:27,481 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-1] SYSTEM: FirmwareLoaderFileSystem Verticle or Worker started 
2022-09-15 06:57:27,483 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of FirmwareLoaderFileSystem succeeded (3d8980dd-7442-4e5e-b49e-863b430d23b5) 
2022-09-15 06:57:27,506 de.eq3.cbcs.server.core.transaction.TransactionManagementVerticle INFO  [vert.x-eventloop-thread-1] SYSTEM: TransactionManagementVerticle Verticle or Worker started 
2022-09-15 06:57:27,508 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of TransactionManagementVerticle succeeded (9c01ecca-2851-4daf-a522-9624e17a0dbf) 
2022-09-15 06:57:27,534 de.eq3.cbcs.server.core.vertx.StatemanagementResponseHandler INFO  [vert.x-eventloop-thread-4] SYSTEM: StatemanagementResponseHandler Verticle or Worker started 
2022-09-15 06:57:27,535 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of StatemanagementResponseHandler succeeded (09e0c367-5f31-46cc-97e5-7792513bd087) 
2022-09-15 06:57:27,585 de.eq3.cbcs.server.core.vertx.BackendCommandHandler INFO  [vert.x-eventloop-thread-5] SYSTEM: BackendCommandHandler Verticle or Worker started 
2022-09-15 06:57:27,588 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of BackendCommandHandler succeeded (b36af76b-273c-4c33-8d57-0ad3177e9a04) 
2022-09-15 06:57:30,635 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] MCU type: Si1002_8051 
2022-09-15 06:57:30,657 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Duty Cycle: 1.0 
2022-09-15 06:57:30,657 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] set DutyCycle limit to ffffffc8 
2022-09-15 06:57:30,678 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Set Duty Cycle Limit 
2022-09-15 06:57:30,699 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Current Security Counter: 860556035 
2022-09-15 06:57:30,700 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Update security counter to calculation: 861028660 
2022-09-15 06:57:30,792 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] TRX adapter has 21 link partners 
2022-09-15 06:57:30,834 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/mmd_hmip)] Adapter with Access Point id 3014F711A061A7D7098E0CD9 initialized 
2022-09-15 06:57:30,840 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [RXTXPortMonitor(/dev/mmd_hmip)] HMIPTRXInitialResponseListener said that Adapter was initialized 
2022-09-15 06:57:31,516 de.eq3.vertx.manager.management.VertxManager WARN  [vert.x-eventloop-thread-1] SYSTEM ADVICE: pre-conditions for deployment of LocalServerFirmwareUpdateInitialization still not met - check deployment configuration  (still unfulfilled: [connector.open]) 
2022-09-15 06:57:31,522 de.eq3.vertx.manager.management.VertxManager WARN  [vert.x-eventloop-thread-5] SYSTEM ADVICE: pre-conditions for deployment of LegacyAPIWorker still not met - check deployment configuration  (still unfulfilled: [connector.open]) 
2022-09-15 06:57:31,523 de.eq3.vertx.manager.management.VertxManager WARN  [vert.x-eventloop-thread-4] SYSTEM ADVICE: pre-conditions for deployment of LegacyNotificationHandler still not met - check deployment configuration  (still unfulfilled: [connector.open]) 
2022-09-15 06:57:31,524 de.eq3.vertx.manager.management.VertxManager WARN  [vert.x-eventloop-thread-6] SYSTEM ADVICE: pre-conditions for deployment of LegacyBackendNotificationHandler still not met - check deployment configuration  (still unfulfilled: [connector.open]) 
2022-09-15 06:57:31,527 de.eq3.vertx.manager.management.VertxManager WARN  [vert.x-eventloop-thread-3] SYSTEM ADVICE: pre-conditions for deployment of LegacyInitializion still not met - check deployment configuration  (still unfulfilled: [legacy.api.worker][connector.open]) 
2022-09-15 06:57:32,049 de.eq3.cbcs.server.local.base.internal.LocalServerFirmwareUpdateInitialization INFO  [vert.x-eventloop-thread-7] SYSTEM: LocalServerFirmwareUpdateInitialization Verticle or Worker started 
2022-09-15 06:57:32,052 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of LocalServerFirmwareUpdateInitialization succeeded (e7f16ee5-d6b2-41f4-9dec-f4f59b0adfb8) 
2022-09-15 06:57:32,106 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-2] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2022-09-15 06:57:32,106 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-4] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2022-09-15 06:57:32,110 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-2] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2022-09-15 06:57:32,112 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of LegacyBackendNotificationHandler succeeded (fe074d83-b6fd-404c-a8ab-a52df7a2b52b) 
2022-09-15 06:57:32,165 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyNotificationHandler INFO  [vert.x-worker-thread-3] SYSTEM: LegacyNotificationHandler Verticle or Worker started 
2022-09-15 06:57:32,176 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LegacyNotificationHandler succeeded (1512fd52-1c47-4f64-9c93-ceadf54d41fc) 
2022-09-15 06:57:32,222 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Checking all devices on all accesspoints for updates 
2022-09-15 06:57:32,243 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyAPIWorker INFO  [vert.x-worker-thread-1] SYSTEM: LegacyAPIWorker Verticle or Worker started 
2022-09-15 06:57:32,246 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LegacyAPIWorker succeeded (775d3c42-c25e-48f9-9e6c-fd51af70fd59) 
2022-09-15 06:57:33,550 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyInitializion INFO  [vert.x-eventloop-thread-5] SYSTEM: LegacyInitializion Verticle or Worker started 
2022-09-15 06:57:33,552 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of LegacyInitializion succeeded (e7cc7a45-5eb6-4f2f-a4d9-0e82d5cc9bdd) 
2022-09-15 06:57:33,636 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-1] SYSTEM: initial deployment complete _____________________________________________________ 
2022-09-15 06:57:33,705 de.eq3.cbcs.server.local.LocalServer INFO  [Thread-1] SYSTEM: Bind XML-RPC api to port 32010 
2022-09-15 06:57:36,881 de.eq3.cbcs.util.EQ3LoggerOutputStream INFO  [Thread-2] std.out and std.err redirection active 
2022-09-15 06:57:36,883 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Default MaxEventLoopExecuteTime: 2000000000 
2022-09-15 06:57:36,883 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Default BlockedThreadCheckInterval: 1000 
2022-09-15 06:57:36,883 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Default MaxWorkerExecuteTime: 60000000000 
2022-09-15 06:57:36,883 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Default EventLoopPoolSize: 8 
2022-09-15 06:57:36,895 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [BackendWorker] (1) *worker 
2022-09-15 06:57:36,897 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [GroupRequestWorker] (1) *worker 
2022-09-15 06:57:36,899 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [DiagramRequestWorker] (1) *worker 
2022-09-15 06:57:36,900 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [StorageRequestWorker] (1) *worker 
2022-09-15 06:57:36,902 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [DeviceFirmwareRequestWorker] (1) *worker 
2022-09-15 06:57:36,903 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [EnergyPriceRequestWorker] (1) *worker 
2022-09-15 06:57:36,905 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [CouplingRequestWorker] (1) *worker 
2022-09-15 06:57:36,910 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [RegaClientWorker] (1) *worker 
2022-09-15 06:57:36,913 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [GroupConfigurationPersistenceFileSystem] (1) *worker 
2022-09-15 06:57:36,916 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [HmIPGatewayManagementRequestWorker] (1) *worker 
2022-09-15 06:57:36,934 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [AccessPointUpdateServerWorker] (1) *worker 
2022-09-15 06:57:36,935 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [AccessPointUpdateLoaderWorker] (1) *worker 
2022-09-15 06:57:36,941 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: deploying 12 classes to Vert.x 
2022-09-15 06:57:36,957 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: 12 VertxDeployers initialized 
2022-09-15 06:57:36,972 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of BackendWorker succeeded (d1539119-9bd0-4de7-bfba-eb976e1ed0c1) 
2022-09-15 06:57:36,973 de.eq3.ccu.hmip.accesspoint.update.AccessPointUpdateLoaderWorker INFO  [vert.x-worker-thread-10] SYSTEM: Firmware update directory is set to /etc/config/firmware 
2022-09-15 06:57:36,978 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of AccessPointUpdateLoaderWorker succeeded (d9152076-1393-40b3-8623-1a1d80708580) 
2022-09-15 06:57:36,981 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of GroupConfigurationPersistenceFileSystem succeeded (5d57cfb2-6347-486c-bec7-f35d608bb918) 
2022-09-15 06:57:36,986 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of CouplingRequestWorker succeeded (b832c5d6-60a2-4d92-8d96-a848c5c8ee85) 
2022-09-15 06:57:36,993 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of RegaClientWorker succeeded (07d85950-2122-49a5-a251-b4df3facb5ba) 
2022-09-15 06:57:36,996 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of EnergyPriceRequestWorker succeeded (1ae01606-95d6-4342-b8b3-7dcf598476e1) 
2022-09-15 06:57:37,008 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of StorageRequestWorker succeeded (9c37b8f2-f33b-458f-ae2d-d0ea92dd7d14) 
2022-09-15 06:57:37,023 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of AccessPointUpdateServerWorker succeeded (557e371a-f135-4c75-b015-e0b8fc1fcbfe) 
2022-09-15 06:57:37,113 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of GroupRequestWorker succeeded (b2997711-5871-48a4-bfb5-c84146bef3ca) 
2022-09-15 06:57:37,116 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DiagramRequestWorker succeeded (8eb6bed3-a465-4ae8-83d2-6ca89cb0263d) 
2022-09-15 06:57:37,122 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (e4d9e105-bdd8-48d4-99ef-d06f01ebcf24) 
2022-09-15 06:57:37,128 de.eq3.vertx.manager.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of HmIPGatewayManagementRequestWorker succeeded (ff719e8b-1f26-452b-a786-417576d119a9) 
2022-09-15 06:57:37,158 de.eq3.vertx.manager.management.VertxManager INFO  [Thread-2] SYSTEM: initial deployment complete _____________________________________________________ 
2022-09-15 06:57:37,158 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Starting HMServer at 127.0.0.1:39292 
2022-09-15 06:57:37,160 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Read Configuration 
2022-09-15 06:57:37,427 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create Bidcos Dispatcher 
2022-09-15 06:57:37,488 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] InitBidCosCache 
2022-09-15 06:57:39,919 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create groupDefinitionProvider 
2022-09-15 06:57:40,391 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create VirtualDeviceHolder 
2022-09-15 06:57:40,397 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create VirtualDeviceHandlerRega 
2022-09-15 06:57:40,406 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupAdministrationService 
2022-09-15 06:57:40,406 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupDeviceDispatcher 
2022-09-15 06:57:40,408 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create GroupDeviceHandler 
2022-09-15 06:57:40,454 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] @GroupDeviceHandler - initializing... 
2022-09-15 06:57:40,455 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created groupDeviceDispatcher (GroupDeviceService to BidCoS (via Dispatcher)) 
2022-09-15 06:57:40,455 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created virtualDeviceHandler (GroupDeviceService to ReGa) 
2022-09-15 06:57:40,455 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> got groupDefinitionProvider 
2022-09-15 06:57:40,455 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create BidCosGroupMemberProvider 
2022-09-15 06:57:40,540 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init groupAdministrationService 
2022-09-15 06:57:40,545 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init Virtual OS Device 
2022-09-15 06:57:40,556 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init ESHLight Bridge 
2022-09-15 06:57:41,464 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create RrdDatalogging 
2022-09-15 06:57:41,471 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create MeasurementService 
2022-09-15 06:57:41,479 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Init MeasurementService 
2022-09-15 06:57:41,613 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create HTTP Server 
2022-09-15 06:57:41,632 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create BidCos context and start handler 
2022-09-15 06:57:41,639 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Create group context and start handler 
2022-09-15 06:57:41,669 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:39292/bidcos 
2022-09-15 06:57:41,679 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [HmIP-RF_java_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2022-09-15 06:57:41,689 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [HmIP-RF_java_WorkerPool-0] init finished 
2022-09-15 06:57:41,704 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-0] Added InterfaceId: HmIP-RF_java 
2022-09-15 06:57:41,824 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-0] updateDevicesForClient HmIP-RF_java -> 239 device addresses will be added 
2022-09-15 06:57:42,031 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Checking all devices on all accesspoints for updates 
2022-09-15 06:57:42,657 de.eq3.ccu.server.BaseHMServer INFO  [Thread-2] Starting HMServer done 
2022-09-15 06:57:58,901 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 
2022-09-15 06:57:58,951 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] Added InterfaceId: 1008 
2022-09-15 06:58:01,152 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 2246 ms, time limit is 2000 ms 
2022-09-15 06:58:02,145 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 3246 ms, time limit is 2000 ms 
2022-09-15 06:58:03,145 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 4246 ms, time limit is 2000 ms 
2022-09-15 06:58:04,148 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 5247 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$81/2338110.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$80/31944889.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]
2022-09-15 06:58:05,148 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 6247 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$81/2338110.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$80/31944889.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]
2022-09-15 06:58:06,148 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 7247 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$81/2338110.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$80/31944889.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]
2022-09-15 06:58:07,148 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 8247 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$81/2338110.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$80/31944889.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]
2022-09-15 06:58:08,147 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 9247 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$81/2338110.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$80/31944889.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]
2022-09-15 06:58:08,956 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-13] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
2022-09-15 06:58:08,964 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] (un)registerCallback on LegacyServiceHandler called from url: xmlrpc_bin://127.0.0.1:31999 
2022-09-15 06:58:08,967 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [1011_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2022-09-15 06:58:08,971 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [1011_WorkerPool-0] init finished 
2022-09-15 06:58:08,972 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-4] Added InterfaceId: 1011 
2022-09-15 06:59:26,508 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] (un)registerCallback on VirtualDeviceHandlerRega called from url: http://192.168.178.10:14702/fh9292 
2022-09-15 06:59:26,509 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-0] Added InterfaceId: CB9292178010178011 
2022-09-15 06:59:29,157 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 2649 ms, time limit is 2000 ms 
2022-09-15 06:59:30,157 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 3649 ms, time limit is 2000 ms 
2022-09-15 06:59:31,156 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 4649 ms, time limit is 2000 ms 
2022-09-15 06:59:32,157 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 5648 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$81/2338110.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$80/31944889.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]
2022-09-15 06:59:33,158 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 6649 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$81/2338110.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$80/31944889.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]
2022-09-15 06:59:34,157 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 7648 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$81/2338110.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$80/31944889.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]
2022-09-15 06:59:35,158 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 8649 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$81/2338110.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$80/31944889.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]
2022-09-15 06:59:36,157 io.vertx.core.impl.BlockedThreadChecker WARN  [vertx-blocked-thread-checker] Thread Thread[vert.x-eventloop-thread-0,5,main] has been blocked for 9648 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$81/2338110.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$80/31944889.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]
2022-09-15 06:59:36,513 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-14] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
2022-09-15 06:59:36,629 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-2] (un)registerCallback on LegacyServiceHandler called from url: http://192.168.178.10:7420/fh2010 
2022-09-15 06:59:36,632 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [CB2010178010178011_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started 
2022-09-15 06:59:36,634 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [CB2010178010178011_WorkerPool-0] init finished 
2022-09-15 06:59:36,636 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-3] Added InterfaceId: CB2010178010178011 
2022-09-15 06:59:36,689 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-3] updateDevicesForClient CB2010178010178011 -> 239 device addresses will be added 
2022-09-15 07:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:07:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:12:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:22:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:27:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:27:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:32:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:42:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:52:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:52:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 07:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 07:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 07:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:02:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:07:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:07:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:12:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:27:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:27:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:29:00,536 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 8:29:00 AM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 08:29:00,537 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:39292: Broken pipe (Write failed) 
2022-09-15 08:29:00,539 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 8:29:00 AM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 08:29:00,539 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: Retrying request to {}->http://127.0.0.1:39292 
2022-09-15 08:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:32:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:32:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:37:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:37:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:52:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 08:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 08:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 08:57:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:02:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:07:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:12:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:12:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:32:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:37:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:42:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:42:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:52:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:52:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 09:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 09:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 09:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:07:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:07:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:18:46,803 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 10:18:46 AM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 10:18:46,805 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:39292: Broken pipe (Write failed) 
2022-09-15 10:18:46,807 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 10:18:46 AM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 10:18:46,807 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: Retrying request to {}->http://127.0.0.1:39292 
2022-09-15 10:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:27:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:27:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:32:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:42:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 10:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 10:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 10:57:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:07:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:12:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:32:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:42:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:52:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:52:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 11:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 11:57:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 11:57:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:02:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:02:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:07:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:27:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:32:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:37:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 12:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 12:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 12:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:02:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:07:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:12:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:17:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:27:25,706 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:27:25,707 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:37:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 13:57:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 13:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 13:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:00:00,692 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-0] Sep 15, 2022 2:00:00 PM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 14:00:00,700 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-0] INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:39292: Broken pipe (Write failed) 
2022-09-15 14:00:00,702 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-0] Sep 15, 2022 2:00:00 PM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 14:00:00,703 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-0] INFO: Retrying request to {}->http://127.0.0.1:39292 
2022-09-15 14:02:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:22:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:27:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:37:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:42:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:42:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:52:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 14:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 14:57:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 14:57:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:02:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:02:25,705 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:02:25,706 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:07:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:12:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:14:09,415 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 3:14:09 PM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 15:14:09,416 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:39292: Broken pipe (Write failed) 
2022-09-15 15:14:09,418 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 3:14:09 PM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 15:14:09,418 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: Retrying request to {}->http://127.0.0.1:39292 
2022-09-15 15:16:04,080 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 3:16:04 PM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 15:16:04,080 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:39292: Broken pipe (Write failed) 
2022-09-15 15:16:04,086 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 3:16:04 PM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 15:16:04,086 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: Retrying request to {}->http://127.0.0.1:39292 
2022-09-15 15:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:37:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:42:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:42:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:42:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:47:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:47:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:52:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:52:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 15:55:02,708 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 3:55:02 PM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 15:55:02,709 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:39292: Broken pipe (Write failed) 
2022-09-15 15:55:02,711 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] Sep 15, 2022 3:55:02 PM org.apache.http.impl.client.DefaultHttpClient tryExecute 
2022-09-15 15:55:02,711 de.eq3.cbcs.util.EQ3LoggerOutputStream ERROR [HmIP-RF_java_WorkerPool-1] INFO: Retrying request to {}->http://127.0.0.1:39292 
2022-09-15 15:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 15:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 15:57:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 16:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 16:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 16:02:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 16:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 16:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 16:07:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 16:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 16:12:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 16:12:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 16:17:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 16:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 16:17:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 16:22:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 16:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 16:22:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 16:27:25,701 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 16:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 16:27:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 
2022-09-15 16:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: 0 Accesspoints in Queue 
2022-09-15 16:32:25,702 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
2022-09-15 16:32:25,703 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-1] SYSTEM: Eventlistener Handler utilization: 0/50 used 

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

Re: piVCCu reagiert nicht.

Beitrag von deimos » 15.09.2022, 17:25

Hi,

was genau verstehst du unter "reagiert nicht mehr"? Mindestens mal per SSH kommst du ja scheinbar noch drauf.
Das Log sieht nur nach dem hmserver.log aus. /var/log/messages könnte auch noch interessant sein. Und ebenfalls wären ein paar Worte zu deinen restlichen Hard- und Software-Setup ganz nett.

Viele Grüße
Alex

fab_joe
Beiträge: 7
Registriert: 02.04.2018, 17:23

Re: piVCCu reagiert nicht.

Beitrag von fab_joe » 15.09.2022, 17:41

Hi Alex,

Danke für die schnelle Antwort.

"Reagiert niccht" bedeutet: FHEM Erreichbar und in Funktion, Steuerung der Geräte über CCU ohne Reaktion. Andere Geräte, z.B. Hue (eingebunden in FHEM) gehen, alles soweit ok, außer das die an der CCU angelernten Geräte nicht reagieren.CCU Über Web erreichbar. Allerdings sind keine Geräte mehr unter Status und Bedienung vorhanden. Erst nach dem Neustart sind alle Geräte wieder da.

Hier die Details:
Hardware: Raspberry 3b+ mit aktuellem Linux raspberrypi 4.19.66-v7+ #1253 SMP und HM-MOD-RPI-PCB. Kein Updates verfügbar. Installiet ist FHEM dazu piVCCU. Sonst nix.
OS via SSH und FHEM über Webinterface durchgehend erreichbar. Keine verschlechterung der Performance bemerkbar.

# sudo pivccu-info

Code: Alles auswählen

 
piVCCU version: 3.65.8-74
Kernel modules: Available
Raw UART dev:   Available
Rasp.Pi UART:   Assigned to GPIO pins
HMRF Hardware:  HM-MOD-RPI-PCB
 Connected via: GPIO@3f201000.serial (/dev/raw-uart)
 Board serial:  OEQ0304345
 Radio MAC:     0x583397
HMIP Hardware:  HM-MOD-RPI-PCB
 Connected via: GPIO@3f201000.serial (/dev/raw-uart)
 SGTIN:         3014F711A061A7D7098E0CD9
 Radio MAC:     0xBF4893
State:          RUNNING
PID:            27719
IP:             192.168.178.11
CPU use:        0.86 seconds
BlkIO use:      1.07 MiB
Memory use:     4.48 MiB
KMem use:       2.19 MiB
Link:           vethpivccu
 TX bytes:      2.71 KiB
 RX bytes:      4.68 KiB
 Total bytes:   7.39 KiB
 
# /var/log/messages

Code: Alles auswählen

Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Booting Linux on physical CPU 0x0
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Linux version 4.19.66-v7+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1253 SMP Thu Aug 15 11:49:46 BST 2019
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] CPU: div instructions available: patching division code
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] OF: fdt: Machine model: Raspberry Pi 3 Model B Rev 1.2
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Memory policy: Data cache writealloc
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] cma: Reserved 8 MiB at 0x3ac00000
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] random: get_random_bytes called from start_kernel+0xac/0x4b4 with crng_init=0
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] percpu: Embedded 17 pages/cpu s39488 r8192 d21952 u69632
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 240555
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  dwc_otg.lpm_enable=0 console=tty1 root=PARTUUID=1b1a0538-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Memory: 939088K/970752K available (8192K kernel code, 629K rwdata, 2176K rodata, 1024K init, 821K bss, 23472K reserved, 8192K cma-reserved)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] Virtual kernel memory layout:
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]     vmalloc : 0xbb800000 - 0xff800000   (1088 MB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]     lowmem  : 0x80000000 - 0xbb400000   ( 948 MB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]     modules : 0x7f000000 - 0x80000000   (  16 MB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]       .text : 0x(ptrval) - 0x(ptrval)   (9184 kB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]       .init : 0x(ptrval) - 0x(ptrval)   (1024 kB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]       .data : 0x(ptrval) - 0x(ptrval)   ( 630 kB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000]        .bss : 0x(ptrval) - 0x(ptrval)   ( 822 kB)
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] ftrace: allocating 26394 entries in 78 pages
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] rcu: Hierarchical RCU implementation.
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys).
Sep 15 06:55:24 raspberrypi kernel: [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
Sep 15 06:55:24 raspberrypi kernel: [    0.000004] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
Sep 15 06:55:24 raspberrypi kernel: [    0.000012] Switching to timer-based delay loop, resolution 52ns
Sep 15 06:55:24 raspberrypi kernel: [    0.000160] Console: colour dummy device 80x30
Sep 15 06:55:24 raspberrypi kernel: [    0.000471] console [tty1] enabled
Sep 15 06:55:24 raspberrypi kernel: [    0.000508] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
Sep 15 06:55:24 raspberrypi kernel: [    0.000532] pid_max: default: 32768 minimum: 301
Sep 15 06:55:24 raspberrypi kernel: [    0.000724] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.000745] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.001285] CPU: Testing write buffer coherency: ok
Sep 15 06:55:24 raspberrypi kernel: [    0.001584] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Sep 15 06:55:24 raspberrypi kernel: [    0.001949] Setting up static identity map for 0x100000 - 0x10003c
Sep 15 06:55:24 raspberrypi kernel: [    0.002038] rcu: Hierarchical SRCU implementation.
Sep 15 06:55:24 raspberrypi kernel: [    0.002478] smp: Bringing up secondary CPUs ...
Sep 15 06:55:24 raspberrypi kernel: [    0.002981] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Sep 15 06:55:24 raspberrypi kernel: [    0.003502] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Sep 15 06:55:24 raspberrypi kernel: [    0.003968] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Sep 15 06:55:24 raspberrypi kernel: [    0.004030] smp: Brought up 1 node, 4 CPUs
Sep 15 06:55:24 raspberrypi kernel: [    0.004072] SMP: Total of 4 processors activated (153.60 BogoMIPS).
Sep 15 06:55:24 raspberrypi kernel: [    0.004084] CPU: All CPU(s) started in HYP mode.
Sep 15 06:55:24 raspberrypi kernel: [    0.004094] CPU: Virtualization extensions available.
Sep 15 06:55:24 raspberrypi kernel: [    0.004673] devtmpfs: initialized
Sep 15 06:55:24 raspberrypi kernel: [    0.011400] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
Sep 15 06:55:24 raspberrypi kernel: [    0.011550] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Sep 15 06:55:24 raspberrypi kernel: [    0.011576] futex hash table entries: 1024 (order: 4, 65536 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.011921] pinctrl core: initialized pinctrl subsystem
Sep 15 06:55:24 raspberrypi kernel: [    0.012413] NET: Registered protocol family 16
Sep 15 06:55:24 raspberrypi kernel: [    0.014043] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Sep 15 06:55:24 raspberrypi kernel: [    0.016946] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Sep 15 06:55:24 raspberrypi kernel: [    0.016965] hw-breakpoint: maximum watchpoint size is 8 bytes.
Sep 15 06:55:24 raspberrypi kernel: [    0.017099] Serial: AMBA PL011 UART driver
Sep 15 06:55:24 raspberrypi kernel: [    0.018295] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
Sep 15 06:55:24 raspberrypi kernel: [    0.036031] bcm2835-dma 3f007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
Sep 15 06:55:24 raspberrypi kernel: [    0.036922] SCSI subsystem initialized
Sep 15 06:55:24 raspberrypi kernel: [    0.037048] usbcore: registered new interface driver usbfs
Sep 15 06:55:24 raspberrypi kernel: [    0.037087] usbcore: registered new interface driver hub
Sep 15 06:55:24 raspberrypi kernel: [    0.037146] usbcore: registered new device driver usb
Sep 15 06:55:24 raspberrypi kernel: [    0.050228] raspberrypi-firmware soc:firmware: Attached to firmware from 2019-08-15 12:06, variant start
Sep 15 06:55:24 raspberrypi kernel: [    0.060071] raspberrypi-firmware soc:firmware: Firmware hash is 0e6daa5106dd4164474616408e0dc24f997ffcf3
Sep 15 06:55:24 raspberrypi kernel: [    0.070984] clocksource: Switched to clocksource arch_sys_counter
Sep 15 06:55:24 raspberrypi kernel: [    0.117015] VFS: Disk quotas dquot_6.6.0
Sep 15 06:55:24 raspberrypi mtp-probe: checking bus 1, device 3: "/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1"
Sep 15 06:55:24 raspberrypi kernel: [    0.117081] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.117196] FS-Cache: Loaded
Sep 15 06:55:24 raspberrypi mtp-probe: bus: 1, device: 3 was not an MTP device
Sep 15 06:55:24 raspberrypi kernel: [    0.117337] CacheFiles: Loaded
Sep 15 06:55:24 raspberrypi kernel: [    0.122464] NET: Registered protocol family 2
Sep 15 06:55:24 raspberrypi kernel: [    0.122902] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.122936] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.123002] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.123105] TCP: Hash tables configured (established 8192 bind 8192)
Sep 15 06:55:24 raspberrypi kernel: [    0.123195] UDP hash table entries: 512 (order: 2, 16384 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.123228] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.123404] NET: Registered protocol family 1
Sep 15 06:55:24 raspberrypi kernel: [    0.123745] RPC: Registered named UNIX socket transport module.
Sep 15 06:55:24 raspberrypi kernel: [    0.123759] RPC: Registered udp transport module.
Sep 15 06:55:24 raspberrypi kernel: [    0.123770] RPC: Registered tcp transport module.
Sep 15 06:55:24 raspberrypi kernel: [    0.123781] RPC: Registered tcp NFSv4.1 backchannel transport module.
Sep 15 06:55:24 raspberrypi kernel: [    0.124686] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
Sep 15 06:55:24 raspberrypi kernel: [    0.126323] Initialise system trusted keyrings
Sep 15 06:55:24 raspberrypi kernel: [    0.126439] workingset: timestamp_bits=14 max_order=18 bucket_order=4
Sep 15 06:55:24 raspberrypi kernel: [    0.131608] FS-Cache: Netfs 'nfs' registered for caching
Sep 15 06:55:24 raspberrypi kernel: [    0.131930] NFS: Registering the id_resolver key type
Sep 15 06:55:24 raspberrypi kernel: [    0.131956] Key type id_resolver registered
Sep 15 06:55:24 raspberrypi kernel: [    0.131968] Key type id_legacy registered
Sep 15 06:55:24 raspberrypi kernel: [    0.131984] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Sep 15 06:55:24 raspberrypi kernel: [    0.133188] Key type asymmetric registered
Sep 15 06:55:24 raspberrypi kernel: [    0.133204] Asymmetric key parser 'x509' registered
Sep 15 06:55:24 raspberrypi kernel: [    0.133241] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
Sep 15 06:55:24 raspberrypi kernel: [    0.133339] io scheduler noop registered
Sep 15 06:55:24 raspberrypi kernel: [    0.133352] io scheduler deadline registered (default)
Sep 15 06:55:24 raspberrypi kernel: [    0.133459] io scheduler cfq registered
Sep 15 06:55:24 raspberrypi kernel: [    0.133472] io scheduler mq-deadline registered (default)
Sep 15 06:55:24 raspberrypi kernel: [    0.133484] io scheduler kyber registered
Sep 15 06:55:24 raspberrypi kernel: [    0.135237] bcm2708_fb soc:fb: FB found 1 display(s)
Sep 15 06:55:24 raspberrypi kernel: [    0.140720] Console: switching to colour frame buffer device 82x26
Sep 15 06:55:24 raspberrypi kernel: [    0.144211] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 656x416
Sep 15 06:55:24 raspberrypi kernel: [    0.147088] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
Sep 15 06:55:24 raspberrypi kernel: [    0.149054] bcm2835-rng 3f104000.rng: hwrng registered
Sep 15 06:55:24 raspberrypi kernel: [    0.150415] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Sep 15 06:55:24 raspberrypi kernel: [    0.153173] vc-sm: Videocore shared memory driver
Sep 15 06:55:24 raspberrypi kernel: [    0.154587] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
Sep 15 06:55:24 raspberrypi kernel: [    0.162727] brd: module loaded
Sep 15 06:55:24 raspberrypi kernel: [    0.169490] loop: module loaded
Sep 15 06:55:24 raspberrypi kernel: [    0.171176] Loading iSCSI transport class v2.0-870.
Sep 15 06:55:24 raspberrypi kernel: [    0.172825] libphy: Fixed MDIO Bus: probed
Sep 15 06:55:24 raspberrypi kernel: [    0.174085] usbcore: registered new interface driver lan78xx
Sep 15 06:55:24 raspberrypi kernel: [    0.175348] usbcore: registered new interface driver smsc95xx
Sep 15 06:55:24 raspberrypi kernel: [    0.176570] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Sep 15 06:55:24 raspberrypi kernel: [    0.205489] dwc_otg 3f980000.usb: base=(ptrval)
Sep 15 06:55:24 raspberrypi kernel: [    0.406840] Core Release: 2.80a
Sep 15 06:55:24 raspberrypi kernel: [    0.408074] Setting default values for core params
Sep 15 06:55:24 raspberrypi kernel: [    0.409333] Finished setting default values for core params
Sep 15 06:55:24 raspberrypi kernel: [    0.610747] Using Buffer DMA mode
Sep 15 06:55:24 raspberrypi kernel: [    0.611962] Periodic Transfer Interrupt Enhancement - disabled
Sep 15 06:55:24 raspberrypi kernel: [    0.613176] Multiprocessor Interrupt Enhancement - disabled
Sep 15 06:55:24 raspberrypi kernel: [    0.614375] OTG VER PARAM: 0, OTG VER FLAG: 0
Sep 15 06:55:24 raspberrypi kernel: [    0.615555] Dedicated Tx FIFOs mode
Sep 15 06:55:24 raspberrypi kernel: [    0.616933] WARN::dwc_otg_hcd_init:1045: FIQ DMA bounce buffers: virt = bad04000 dma = 0xfad04000 len=9024
Sep 15 06:55:24 raspberrypi kernel: [    0.619230] FIQ FSM acceleration enabled for :
Sep 15 06:55:24 raspberrypi kernel: [    0.619230] Non-periodic Split Transactions
Sep 15 06:55:24 raspberrypi kernel: [    0.619230] Periodic Split Transactions
Sep 15 06:55:24 raspberrypi kernel: [    0.619230] High-Speed Isochronous Endpoints
Sep 15 06:55:24 raspberrypi kernel: [    0.619230] Interrupt/Control Split Transaction hack enabled
Sep 15 06:55:24 raspberrypi kernel: [    0.624732] WARN::hcd_init_fiq:457: FIQ on core 1
Sep 15 06:55:24 raspberrypi kernel: [    0.625852] WARN::hcd_init_fiq:458: FIQ ASM at 80654f4c length 36
Sep 15 06:55:24 raspberrypi kernel: [    0.626965] WARN::hcd_init_fiq:497: MPHI regs_base at bb810000
Sep 15 06:55:24 raspberrypi kernel: [    0.628101] dwc_otg 3f980000.usb: DWC OTG Controller
Sep 15 06:55:24 raspberrypi kernel: [    0.629239] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
Sep 15 06:55:24 raspberrypi kernel: [    0.630407] dwc_otg 3f980000.usb: irq 56, io mem 0x00000000
Sep 15 06:55:24 raspberrypi kernel: [    0.631588] Init: Port Power? op_state=1
Sep 15 06:55:24 raspberrypi kernel: [    0.632713] Init: Power Port (0)
Sep 15 06:55:24 raspberrypi kernel: [    0.633935] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
Sep 15 06:55:24 raspberrypi kernel: [    0.636193] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Sep 15 06:55:24 raspberrypi kernel: [    0.637401] usb usb1: Product: DWC OTG Controller
Sep 15 06:55:24 raspberrypi kernel: [    0.638584] usb usb1: Manufacturer: Linux 4.19.66-v7+ dwc_otg_hcd
Sep 15 06:55:24 raspberrypi kernel: [    0.639799] usb usb1: SerialNumber: 3f980000.usb
Sep 15 06:55:24 raspberrypi kernel: [    0.641310] hub 1-0:1.0: USB hub found
Sep 15 06:55:24 raspberrypi kernel: [    0.642457] hub 1-0:1.0: 1 port detected
Sep 15 06:55:24 raspberrypi kernel: [    0.644019] usbcore: registered new interface driver usb-storage
Sep 15 06:55:24 raspberrypi kernel: [    0.645257] mousedev: PS/2 mouse device common for all mice
Sep 15 06:55:24 raspberrypi kernel: [    0.646898] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Sep 15 06:55:24 raspberrypi kernel: [    0.648224] bcm2835-cpufreq: min=1200000 max=1200000
Sep 15 06:55:24 raspberrypi kernel: [    0.649664] sdhci: Secure Digital Host Controller Interface driver
Sep 15 06:55:24 raspberrypi kernel: [    0.650875] sdhci: Copyright(c) Pierre Ossman
Sep 15 06:55:24 raspberrypi kernel: [    0.652303] mmc-bcm2835 3f300000.mmcnr: could not get clk, deferring probe
Sep 15 06:55:24 raspberrypi kernel: [    0.653769] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
Sep 15 06:55:24 raspberrypi kernel: [    0.655114] sdhci-pltfm: SDHCI platform and OF driver helper
Sep 15 06:55:24 raspberrypi kernel: [    0.657535] ledtrig-cpu: registered to indicate activity on CPUs
Sep 15 06:55:24 raspberrypi kernel: [    0.658934] hidraw: raw HID events driver (C) Jiri Kosina
Sep 15 06:55:24 raspberrypi kernel: [    0.660336] usbcore: registered new interface driver usbhid
Sep 15 06:55:24 raspberrypi kernel: [    0.661674] usbhid: USB HID core driver
Sep 15 06:55:24 raspberrypi kernel: [    0.663390] vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
Sep 15 06:55:24 raspberrypi kernel: [    0.665739] [vc_sm_connected_init]: start
Sep 15 06:55:24 raspberrypi kernel: [    0.672704] [vc_sm_connected_init]: end - returning 0
Sep 15 06:55:24 raspberrypi kernel: [    0.674526] Initializing XFRM netlink socket
Sep 15 06:55:24 raspberrypi kernel: [    0.675747] NET: Registered protocol family 17
Sep 15 06:55:24 raspberrypi kernel: [    0.677018] Key type dns_resolver registered
Sep 15 06:55:24 raspberrypi kernel: [    0.678436] Registering SWP/SWPB emulation handler
Sep 15 06:55:24 raspberrypi kernel: [    0.680001] registered taskstats version 1
Sep 15 06:55:24 raspberrypi kernel: [    0.681230] Loading compiled-in X.509 certificates
Sep 15 06:55:24 raspberrypi kernel: [    0.687110] mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0
Sep 15 06:55:24 raspberrypi kernel: [    0.688343] mmc-bcm2835 3f300000.mmcnr: DMA channel allocated
Sep 15 06:55:24 raspberrypi kernel: [    0.713992] sdhost: log_buf @ (ptrval) (fad07000)
Sep 15 06:55:24 raspberrypi kernel: [    0.750956] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.753658] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.756278] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.760043] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Sep 15 06:55:24 raspberrypi kernel: [    0.761071] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Sep 15 06:55:24 raspberrypi kernel: [    0.762758] of_cfs_init
Sep 15 06:55:24 raspberrypi kernel: [    0.763756] of_cfs_init: OK
Sep 15 06:55:24 raspberrypi kernel: [    0.765003] Waiting for root device PARTUUID=1b1a0538-02...
Sep 15 06:55:24 raspberrypi kernel: [    0.834445] random: fast init done
Sep 15 06:55:24 raspberrypi kernel: [    0.852581] mmc0: host does not support reading read-only switch, assuming write-enable
Sep 15 06:55:24 raspberrypi kernel: [    0.857909] mmc0: new high speed SDHC card at address aaaa
Sep 15 06:55:24 raspberrypi kernel: [    0.859655] mmcblk0: mmc0:aaaa SC16G 14.8 GiB
Sep 15 06:55:24 raspberrypi kernel: [    0.861407] Indeed it is in host mode hprt0 = 00021501
Sep 15 06:55:24 raspberrypi kernel: [    0.927481]  mmcblk0: p1 p2
Sep 15 06:55:24 raspberrypi kernel: [    0.940771] mmc1: new high speed SDIO card at address 0001
Sep 15 06:55:24 raspberrypi kernel: [    0.963560] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Sep 15 06:55:24 raspberrypi kernel: [    0.965733] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Sep 15 06:55:24 raspberrypi kernel: [    0.974011] devtmpfs: mounted
Sep 15 06:55:24 raspberrypi kernel: [    0.977844] Freeing unused kernel memory: 1024K
Sep 15 06:55:24 raspberrypi kernel: [    1.001192] Run /sbin/init as init process
Sep 15 06:55:24 raspberrypi kernel: [    1.071021] usb 1-1: new high-speed USB device number 2 using dwc_otg
Sep 15 06:55:24 raspberrypi kernel: [    1.072373] Indeed it is in host mode hprt0 = 00001101
Sep 15 06:55:24 raspberrypi kernel: [    1.311191] usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00
Sep 15 06:55:24 raspberrypi kernel: [    1.313852] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Sep 15 06:55:24 raspberrypi kernel: [    1.315695] hub 1-1:1.0: USB hub found
Sep 15 06:55:24 raspberrypi kernel: [    1.317158] hub 1-1:1.0: 5 ports detected
Sep 15 06:55:24 raspberrypi kernel: [    1.571080] NET: Registered protocol family 10
Sep 15 06:55:24 raspberrypi kernel: [    1.573192] Segment Routing with IPv6
Sep 15 06:55:24 raspberrypi kernel: [    1.598555] random: systemd: uninitialized urandom read (16 bytes read)
Sep 15 06:55:24 raspberrypi kernel: [    1.601637] random: systemd: uninitialized urandom read (16 bytes read)
Sep 15 06:55:24 raspberrypi kernel: [    1.631035] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
Sep 15 06:55:24 raspberrypi kernel: [    1.658122] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read)
Sep 15 06:55:24 raspberrypi kernel: [    1.761229] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00
Sep 15 06:55:24 raspberrypi kernel: [    1.763905] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Sep 15 06:55:24 raspberrypi kernel: [    1.767751] smsc95xx v1.0.6
Sep 15 06:55:24 raspberrypi kernel: [    1.863162] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:9a:c6:c3
Sep 15 06:55:24 raspberrypi kernel: [    2.196788] plat_eq3ccu2: loading out-of-tree module taints kernel.
Sep 15 06:55:24 raspberrypi kernel: [    2.197407] Started plat_eq3ccu2
Sep 15 06:55:24 raspberrypi kernel: [    2.581884] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Sep 15 06:55:24 raspberrypi kernel: [    2.880027] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 06:55:24 raspberrypi kernel: [    2.881770] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Sep 15 06:55:24 raspberrypi kernel: [    2.881785] [vc_sm_connected_init]: start
Sep 15 06:55:24 raspberrypi kernel: [    2.890750] [vc_sm_connected_init]: installed successfully
Sep 15 06:55:24 raspberrypi kernel: [    2.932625] pl011_raw_uart 3f201000.serial: Initialized pl011 device; mapbase=0x3f201000; irq=81; clockrate=47999625
Sep 15 06:55:24 raspberrypi kernel: [    2.932653] pl011_raw_uart 3f201000.serial: Missing I2C driver of rtc device, trying to load
Sep 15 06:55:24 raspberrypi kernel: [    2.932659] pl011_raw_uart 3f201000.serial: Requesting module i2c:rx8130-legacy
Sep 15 06:55:24 raspberrypi kernel: [    2.937547] media: Linux media interface: v0.10
Sep 15 06:55:24 raspberrypi kernel: [    2.952419] rtc-rx8130: probe of 1-0032 failed with error -121
Sep 15 06:55:24 raspberrypi kernel: [    2.954524] rtc-rx8130: probe of 1-0032 failed with error -121
Sep 15 06:55:24 raspberrypi kernel: [    2.955092] raw-uart raw-uart: Reset radio module
Sep 15 06:55:24 raspberrypi kernel: [    2.978850] videodev: Linux video capture interface: v2.00
Sep 15 06:55:24 raspberrypi kernel: [    3.025507] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 06:55:24 raspberrypi kernel: [    3.029835] bcm2835_audio soc:audio: card created with 8 channels
Sep 15 06:55:24 raspberrypi kernel: [    3.058371] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 06:55:24 raspberrypi kernel: [    3.074662] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 06:55:24 raspberrypi kernel: [    3.080303] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 06:55:24 raspberrypi kernel: [    3.088329] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Sep 15 06:55:24 raspberrypi kernel: [    3.088338] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Sep 15 06:55:24 raspberrypi kernel: [    3.091986] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Sep 15 06:55:24 raspberrypi kernel: [    3.091996] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Sep 15 06:55:24 raspberrypi kernel: [    3.097260] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Sep 15 06:55:24 raspberrypi kernel: [    3.097268] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Sep 15 06:55:24 raspberrypi liblogging-stdlog:  [origin software="rsyslogd" swVersion="8.24.0" x-pid="429" x-info="http://www.rsyslog.com"] start
Sep 15 06:55:24 raspberrypi kernel: [    3.161113] raw-uart raw-uart: Registered new raw-uart device using underlying device GPIO@3f201000.serial.
Sep 15 06:55:24 raspberrypi kernel: [    3.198773] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Sep 15 06:55:24 raspberrypi kernel: [    3.232195] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Sep 15 06:55:24 raspberrypi kernel: [    3.297607] usbcore: registered new interface driver brcmfmac
Sep 15 06:55:24 raspberrypi kernel: [    3.886206] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Sep 15 06:55:24 raspberrypi kernel: [    3.899674] br0: port 1(eth0) entered blocking state
Sep 15 06:55:24 raspberrypi kernel: [    3.899685] br0: port 1(eth0) entered disabled state
Sep 15 06:55:24 raspberrypi kernel: [    3.899963] device eth0 entered promiscuous mode
Sep 15 06:55:24 raspberrypi kernel: [    3.992577] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
Sep 15 06:55:24 raspberrypi kernel: [    3.996549] IPv6: ADDRCONF(NETDEV_UP): br0: link is not ready
Sep 15 06:55:24 raspberrypi kernel: [    4.085804] new mount options do not match the existing superblock, will be ignored
Sep 15 06:55:24 raspberrypi kernel: [    4.258685] fuse init (API version 7.27)
Sep 15 06:55:24 raspberrypi kernel: [    4.890803] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
Sep 15 06:55:24 raspberrypi kernel: [    4.952373] br0: port 1(eth0) entered blocking state
Sep 15 06:55:24 raspberrypi kernel: [    4.952381] br0: port 1(eth0) entered forwarding state
Sep 15 06:55:24 raspberrypi kernel: [    4.952495] IPv6: ADDRCONF(NETDEV_CHANGE): br0: link becomes ready
Sep 15 06:55:25 raspberrypi kernel: [    5.611854] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0xDDE1
Sep 15 06:55:44 raspberrypi kernel: [   14.224639] raw-uart raw-uart: Reset radio module
Sep 15 06:56:57 raspberrypi kernel: [   87.206491] random: crng init done
Sep 15 06:56:57 raspberrypi kernel: [   87.206499] random: 7 urandom warning(s) missed due to ratelimiting
Sep 15 06:56:57 raspberrypi kernel: [   87.297535] br0: port 2(vethpivccu) entered blocking state
Sep 15 06:56:57 raspberrypi kernel: [   87.297550] br0: port 2(vethpivccu) entered disabled state
Sep 15 06:56:57 raspberrypi kernel: [   87.297955] device vethpivccu entered promiscuous mode
Sep 15 06:56:57 raspberrypi kernel: [   87.298491] IPv6: ADDRCONF(NETDEV_UP): vethpivccu: link is not ready
Sep 15 06:56:57 raspberrypi kernel: [   87.398153] eth0: renamed from vethBNTYEW
Sep 15 06:56:57 raspberrypi kernel: [   87.432296] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Sep 15 06:56:57 raspberrypi kernel: [   87.433291] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Sep 15 06:56:57 raspberrypi kernel: [   87.433395] IPv6: ADDRCONF(NETDEV_CHANGE): vethpivccu: link becomes ready
Sep 15 06:56:57 raspberrypi kernel: [   87.433461] br0: port 2(vethpivccu) entered blocking state
Sep 15 06:56:57 raspberrypi kernel: [   87.433466] br0: port 2(vethpivccu) entered forwarding state
Sep 15 06:57:06 raspberrypi kernel: [   96.311383] eq3loop: created slave mmd_hmip
Sep 15 06:57:06 raspberrypi kernel: [   96.311748] eq3loop: created slave mmd_bidcos
Sep 15 06:57:08 raspberrypi kernel: [   98.407483] eq3loop: eq3loop_open_slave() mmd_bidcos
Sep 15 06:57:26 raspberrypi kernel: [  116.302965] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 06:57:26 raspberrypi kernel: [  116.303224] eq3loop: eq3loop_close_slave() mmd_hmip
Sep 15 06:57:26 raspberrypi kernel: [  116.305997] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 06:57:26 raspberrypi kernel: [  116.306238] eq3loop: eq3loop_close_slave() mmd_hmip
Sep 15 06:57:26 raspberrypi kernel: [  116.307040] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 06:57:26 raspberrypi kernel: [  116.307215] eq3loop: eq3loop_close_slave() mmd_hmip
Sep 15 17:06:51 raspberrypi kernel: [36681.505496] eq3loop: eq3loop_close_master() mmd_bidcos
Sep 15 17:06:51 raspberrypi kernel: [36681.505678] eq3loop: eq3loop_close_master() mmd_hmip
Sep 15 17:06:53 raspberrypi kernel: [36684.160272] br0: port 2(vethpivccu) entered disabled state
Sep 15 17:06:53 raspberrypi kernel: [36684.161121] device vethpivccu left promiscuous mode
Sep 15 17:06:53 raspberrypi kernel: [36684.161133] br0: port 2(vethpivccu) entered disabled state
Sep 15 17:06:54 raspberrypi kernel: [36684.617092] raw-uart raw-uart: Reset radio module
Sep 15 17:07:02 raspberrypi kernel: [36692.340647] br0: port 2(vethpivccu) entered blocking state
Sep 15 17:07:02 raspberrypi kernel: [36692.340656] br0: port 2(vethpivccu) entered disabled state
Sep 15 17:07:02 raspberrypi kernel: [36692.340860] device vethpivccu entered promiscuous mode
Sep 15 17:07:02 raspberrypi kernel: [36692.341171] IPv6: ADDRCONF(NETDEV_UP): vethpivccu: link is not ready
Sep 15 17:07:02 raspberrypi kernel: [36692.414465] eth0: renamed from vethR8HMAV
Sep 15 17:07:02 raspberrypi kernel: [36692.479122] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Sep 15 17:07:02 raspberrypi kernel: [36692.482523] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Sep 15 17:07:02 raspberrypi kernel: [36692.482661] IPv6: ADDRCONF(NETDEV_CHANGE): vethpivccu: link becomes ready
Sep 15 17:07:02 raspberrypi kernel: [36692.482725] br0: port 2(vethpivccu) entered blocking state
Sep 15 17:07:02 raspberrypi kernel: [36692.482730] br0: port 2(vethpivccu) entered forwarding state
Sep 15 17:07:10 raspberrypi kernel: [36700.989587] eq3loop: created slave mmd_bidcos
Sep 15 17:07:28 raspberrypi kernel: [36718.559460] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 17:07:28 raspberrypi kernel: [36718.562433] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 17:07:28 raspberrypi kernel: [36718.562586] eq3loop: eq3loop_close_slave() mmd_hmip
Sep 15 17:07:28 raspberrypi kernel: [36718.563346] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 17:07:28 raspberrypi kernel: [36718.573615] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Booting Linux on physical CPU 0x0
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Linux version 4.19.66-v7+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1253 SMP Thu Aug 15 11:49:46 BST 2019
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] CPU: div instructions available: patching division code
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] OF: fdt: Machine model: Raspberry Pi 3 Model B Rev 1.2
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Memory policy: Data cache writealloc
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] cma: Reserved 8 MiB at 0x3ac00000
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] random: get_random_bytes called from start_kernel+0xac/0x4b4 with crng_init=0
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] percpu: Embedded 17 pages/cpu s39488 r8192 d21952 u69632
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 240555
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  dwc_otg.lpm_enable=0 console=tty1 root=PARTUUID=1b1a0538-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Memory: 939088K/970752K available (8192K kernel code, 629K rwdata, 2176K rodata, 1024K init, 821K bss, 23472K reserved, 8192K cma-reserved)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] Virtual kernel memory layout:
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]     vmalloc : 0xbb800000 - 0xff800000   (1088 MB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]     lowmem  : 0x80000000 - 0xbb400000   ( 948 MB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]     modules : 0x7f000000 - 0x80000000   (  16 MB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]       .text : 0x(ptrval) - 0x(ptrval)   (9184 kB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]       .init : 0x(ptrval) - 0x(ptrval)   (1024 kB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]       .data : 0x(ptrval) - 0x(ptrval)   ( 630 kB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000]        .bss : 0x(ptrval) - 0x(ptrval)   ( 822 kB)
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] ftrace: allocating 26394 entries in 78 pages
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] rcu: Hierarchical RCU implementation.
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys).
Sep 15 17:11:10 raspberrypi kernel: [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
Sep 15 17:11:10 raspberrypi kernel: [    0.000004] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
Sep 15 17:11:10 raspberrypi kernel: [    0.000012] Switching to timer-based delay loop, resolution 52ns
Sep 15 17:11:10 raspberrypi kernel: [    0.000161] Console: colour dummy device 80x30
Sep 15 17:11:10 raspberrypi kernel: [    0.000472] console [tty1] enabled
Sep 15 17:11:10 raspberrypi kernel: [    0.000509] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
Sep 15 17:11:10 raspberrypi kernel: [    0.000533] pid_max: default: 32768 minimum: 301
Sep 15 17:11:10 raspberrypi kernel: [    0.000724] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.000744] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.001282] CPU: Testing write buffer coherency: ok
Sep 15 17:11:10 raspberrypi kernel: [    0.001580] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Sep 15 17:11:10 raspberrypi kernel: [    0.001943] Setting up static identity map for 0x100000 - 0x10003c
Sep 15 17:11:10 raspberrypi kernel: [    0.002034] rcu: Hierarchical SRCU implementation.
Sep 15 17:11:10 raspberrypi kernel: [    0.002474] smp: Bringing up secondary CPUs ...
Sep 15 17:11:10 raspberrypi kernel: [    0.002969] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Sep 15 17:11:10 raspberrypi kernel: [    0.003488] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Sep 15 17:11:10 raspberrypi kernel: [    0.003957] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Sep 15 17:11:10 raspberrypi kernel: [    0.004019] smp: Brought up 1 node, 4 CPUs
Sep 15 17:11:10 raspberrypi kernel: [    0.004061] SMP: Total of 4 processors activated (153.60 BogoMIPS).
Sep 15 17:11:10 raspberrypi kernel: [    0.004073] CPU: All CPU(s) started in HYP mode.
Sep 15 17:11:10 raspberrypi kernel: [    0.004084] CPU: Virtualization extensions available.
Sep 15 17:11:10 raspberrypi kernel: [    0.004664] devtmpfs: initialized
Sep 15 17:11:10 raspberrypi kernel: [    0.011390] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
Sep 15 17:11:10 raspberrypi kernel: [    0.011542] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Sep 15 17:11:10 raspberrypi kernel: [    0.011568] futex hash table entries: 1024 (order: 4, 65536 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.011912] pinctrl core: initialized pinctrl subsystem
Sep 15 17:11:10 raspberrypi kernel: [    0.012403] NET: Registered protocol family 16
Sep 15 17:11:10 raspberrypi kernel: [    0.014052] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Sep 15 17:11:10 raspberrypi kernel: [    0.016964] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Sep 15 17:11:10 raspberrypi kernel: [    0.016983] hw-breakpoint: maximum watchpoint size is 8 bytes.
Sep 15 17:11:10 raspberrypi kernel: [    0.017116] Serial: AMBA PL011 UART driver
Sep 15 17:11:10 raspberrypi kernel: [    0.018315] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
Sep 15 17:11:10 raspberrypi kernel: [    0.036045] bcm2835-dma 3f007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
Sep 15 17:11:10 raspberrypi kernel: [    0.036929] SCSI subsystem initialized
Sep 15 17:11:10 raspberrypi kernel: [    0.037055] usbcore: registered new interface driver usbfs
Sep 15 17:11:10 raspberrypi kernel: [    0.037093] usbcore: registered new interface driver hub
Sep 15 17:11:10 raspberrypi kernel: [    0.037151] usbcore: registered new device driver usb
Sep 15 17:11:10 raspberrypi kernel: [    0.050227] raspberrypi-firmware soc:firmware: Attached to firmware from 2019-08-15 12:06, variant start
Sep 15 17:11:10 raspberrypi kernel: [    0.060068] raspberrypi-firmware soc:firmware: Firmware hash is 0e6daa5106dd4164474616408e0dc24f997ffcf3
Sep 15 17:11:10 raspberrypi kernel: [    0.070980] clocksource: Switched to clocksource arch_sys_counter
Sep 15 17:11:10 raspberrypi kernel: [    0.116988] VFS: Disk quotas dquot_6.6.0
Sep 15 17:11:10 raspberrypi kernel: [    0.117053] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.117168] FS-Cache: Loaded
Sep 15 17:11:10 raspberrypi kernel: [    0.117308] CacheFiles: Loaded
Sep 15 17:11:10 raspberrypi kernel: [    0.122436] NET: Registered protocol family 2
Sep 15 17:11:10 raspberrypi kernel: [    0.122869] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.122903] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.122968] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.123071] TCP: Hash tables configured (established 8192 bind 8192)
Sep 15 17:11:10 raspberrypi kernel: [    0.123160] UDP hash table entries: 512 (order: 2, 16384 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.123194] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.123371] NET: Registered protocol family 1
Sep 15 17:11:10 raspberrypi kernel: [    0.123716] RPC: Registered named UNIX socket transport module.
Sep 15 17:11:10 raspberrypi kernel: [    0.123729] RPC: Registered udp transport module.
Sep 15 17:11:10 raspberrypi kernel: [    0.123741] RPC: Registered tcp transport module.
Sep 15 17:11:10 raspberrypi kernel: [    0.123752] RPC: Registered tcp NFSv4.1 backchannel transport module.
Sep 15 17:11:10 raspberrypi kernel: [    0.124664] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
Sep 15 17:11:10 raspberrypi kernel: [    0.126303] Initialise system trusted keyrings
Sep 15 17:11:10 raspberrypi kernel: [    0.126413] workingset: timestamp_bits=14 max_order=18 bucket_order=4
Sep 15 17:11:10 raspberrypi kernel: [    0.131564] FS-Cache: Netfs 'nfs' registered for caching
Sep 15 17:11:10 raspberrypi kernel: [    0.131882] NFS: Registering the id_resolver key type
Sep 15 17:11:10 raspberrypi kernel: [    0.131909] Key type id_resolver registered
Sep 15 17:11:10 raspberrypi kernel: [    0.131920] Key type id_legacy registered
Sep 15 17:11:10 raspberrypi kernel: [    0.131937] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Sep 15 17:11:10 raspberrypi kernel: [    0.133148] Key type asymmetric registered
Sep 15 17:11:10 raspberrypi kernel: [    0.133163] Asymmetric key parser 'x509' registered
Sep 15 17:11:10 raspberrypi kernel: [    0.133200] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
Sep 15 17:11:10 raspberrypi mtp-probe: checking bus 1, device 3: "/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1"
Sep 15 17:11:10 raspberrypi kernel: [    0.133305] io scheduler noop registered
Sep 15 17:11:10 raspberrypi kernel: [    0.133317] io scheduler deadline registered (default)
Sep 15 17:11:10 raspberrypi kernel: [    0.133425] io scheduler cfq registered
Sep 15 17:11:10 raspberrypi kernel: [    0.133437] io scheduler mq-deadline registered (default)
Sep 15 17:11:10 raspberrypi kernel: [    0.133449] io scheduler kyber registered
Sep 15 17:11:10 raspberrypi kernel: [    0.135097] bcm2708_fb soc:fb: FB found 1 display(s)
Sep 15 17:11:10 raspberrypi kernel: [    0.140569] Console: switching to colour frame buffer device 82x26
Sep 15 17:11:10 raspberrypi kernel: [    0.144058] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 656x416
Sep 15 17:11:10 raspberrypi kernel: [    0.146943] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
Sep 15 17:11:10 raspberrypi mtp-probe: bus: 1, device: 3 was not an MTP device
Sep 15 17:11:10 raspberrypi kernel: [    0.148915] bcm2835-rng 3f104000.rng: hwrng registered
Sep 15 17:11:10 raspberrypi kernel: [    0.150281] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Sep 15 17:11:10 raspberrypi kernel: [    0.153021] vc-sm: Videocore shared memory driver
Sep 15 17:11:10 raspberrypi kernel: [    0.154442] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
Sep 15 17:11:10 raspberrypi kernel: [    0.162531] brd: module loaded
Sep 15 17:11:10 raspberrypi kernel: [    0.169303] loop: module loaded
Sep 15 17:11:10 raspberrypi kernel: [    0.170929] Loading iSCSI transport class v2.0-870.
Sep 15 17:11:10 raspberrypi kernel: [    0.172633] libphy: Fixed MDIO Bus: probed
Sep 15 17:11:10 raspberrypi kernel: [    0.173895] usbcore: registered new interface driver lan78xx
Sep 15 17:11:10 raspberrypi kernel: [    0.175156] usbcore: registered new interface driver smsc95xx
Sep 15 17:11:10 raspberrypi kernel: [    0.176377] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Sep 15 17:11:10 raspberrypi kernel: [    0.205297] dwc_otg 3f980000.usb: base=(ptrval)
Sep 15 17:11:10 raspberrypi kernel: [    0.406654] Core Release: 2.80a
Sep 15 17:11:10 raspberrypi kernel: [    0.407885] Setting default values for core params
Sep 15 17:11:10 raspberrypi kernel: [    0.409141] Finished setting default values for core params
Sep 15 17:11:10 raspberrypi kernel: [    0.610550] Using Buffer DMA mode
Sep 15 17:11:10 raspberrypi kernel: [    0.611762] Periodic Transfer Interrupt Enhancement - disabled
Sep 15 17:11:10 raspberrypi kernel: [    0.612975] Multiprocessor Interrupt Enhancement - disabled
Sep 15 17:11:10 raspberrypi kernel: [    0.614173] OTG VER PARAM: 0, OTG VER FLAG: 0
Sep 15 17:11:10 raspberrypi kernel: [    0.615354] Dedicated Tx FIFOs mode
Sep 15 17:11:10 raspberrypi kernel: [    0.616741] WARN::dwc_otg_hcd_init:1045: FIQ DMA bounce buffers: virt = bad04000 dma = 0xfad04000 len=9024
Sep 15 17:11:10 raspberrypi kernel: [    0.619045] FIQ FSM acceleration enabled for :
Sep 15 17:11:10 raspberrypi kernel: [    0.619045] Non-periodic Split Transactions
Sep 15 17:11:10 raspberrypi kernel: [    0.619045] Periodic Split Transactions
Sep 15 17:11:10 raspberrypi kernel: [    0.619045] High-Speed Isochronous Endpoints
Sep 15 17:11:10 raspberrypi kernel: [    0.619045] Interrupt/Control Split Transaction hack enabled
Sep 15 17:11:10 raspberrypi kernel: [    0.624566] WARN::hcd_init_fiq:457: FIQ on core 1
Sep 15 17:11:10 raspberrypi kernel: [    0.625684] WARN::hcd_init_fiq:458: FIQ ASM at 80654f4c length 36
Sep 15 17:11:10 raspberrypi liblogging-stdlog:  [origin software="rsyslogd" swVersion="8.24.0" x-pid="381" x-info="http://www.rsyslog.com"] start
Sep 15 17:11:10 raspberrypi kernel: [    0.626795] WARN::hcd_init_fiq:497: MPHI regs_base at bb810000
Sep 15 17:11:10 raspberrypi kernel: [    0.627929] dwc_otg 3f980000.usb: DWC OTG Controller
Sep 15 17:11:10 raspberrypi kernel: [    0.629068] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
Sep 15 17:11:10 raspberrypi kernel: [    0.630238] dwc_otg 3f980000.usb: irq 56, io mem 0x00000000
Sep 15 17:11:10 raspberrypi kernel: [    0.631421] Init: Port Power? op_state=1
Sep 15 17:11:10 raspberrypi kernel: [    0.632546] Init: Power Port (0)
Sep 15 17:11:10 raspberrypi kernel: [    0.633770] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
Sep 15 17:11:10 raspberrypi kernel: [    0.636035] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Sep 15 17:11:10 raspberrypi kernel: [    0.637247] usb usb1: Product: DWC OTG Controller
Sep 15 17:11:10 raspberrypi kernel: [    0.638437] usb usb1: Manufacturer: Linux 4.19.66-v7+ dwc_otg_hcd
Sep 15 17:11:10 raspberrypi kernel: [    0.639655] usb usb1: SerialNumber: 3f980000.usb
Sep 15 17:11:10 raspberrypi kernel: [    0.641177] hub 1-0:1.0: USB hub found
Sep 15 17:11:10 raspberrypi kernel: [    0.642322] hub 1-0:1.0: 1 port detected
Sep 15 17:11:10 raspberrypi kernel: [    0.643886] usbcore: registered new interface driver usb-storage
Sep 15 17:11:10 raspberrypi kernel: [    0.645125] mousedev: PS/2 mouse device common for all mice
Sep 15 17:11:10 raspberrypi kernel: [    0.646766] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Sep 15 17:11:10 raspberrypi kernel: [    0.648093] bcm2835-cpufreq: min=1200000 max=1200000
Sep 15 17:11:10 raspberrypi kernel: [    0.649530] sdhci: Secure Digital Host Controller Interface driver
Sep 15 17:11:10 raspberrypi kernel: [    0.650740] sdhci: Copyright(c) Pierre Ossman
Sep 15 17:11:10 raspberrypi kernel: [    0.652170] mmc-bcm2835 3f300000.mmcnr: could not get clk, deferring probe
Sep 15 17:11:10 raspberrypi kernel: [    0.653640] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
Sep 15 17:11:10 raspberrypi kernel: [    0.654984] sdhci-pltfm: SDHCI platform and OF driver helper
Sep 15 17:11:10 raspberrypi kernel: [    0.657408] ledtrig-cpu: registered to indicate activity on CPUs
Sep 15 17:11:10 raspberrypi kernel: [    0.658799] hidraw: raw HID events driver (C) Jiri Kosina
Sep 15 17:11:10 raspberrypi kernel: [    0.660196] usbcore: registered new interface driver usbhid
Sep 15 17:11:10 raspberrypi kernel: [    0.661530] usbhid: USB HID core driver
Sep 15 17:11:10 raspberrypi kernel: [    0.663246] vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
Sep 15 17:11:10 raspberrypi kernel: [    0.665591] [vc_sm_connected_init]: start
Sep 15 17:11:10 raspberrypi kernel: [    0.672590] [vc_sm_connected_init]: end - returning 0
Sep 15 17:11:10 raspberrypi kernel: [    0.674408] Initializing XFRM netlink socket
Sep 15 17:11:10 raspberrypi kernel: [    0.675623] NET: Registered protocol family 17
Sep 15 17:11:10 raspberrypi kernel: [    0.676885] Key type dns_resolver registered
Sep 15 17:11:10 raspberrypi kernel: [    0.678295] Registering SWP/SWPB emulation handler
Sep 15 17:11:10 raspberrypi kernel: [    0.679859] registered taskstats version 1
Sep 15 17:11:10 raspberrypi kernel: [    0.681083] Loading compiled-in X.509 certificates
Sep 15 17:11:10 raspberrypi kernel: [    0.686965] mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0
Sep 15 17:11:10 raspberrypi kernel: [    0.688202] mmc-bcm2835 3f300000.mmcnr: DMA channel allocated
Sep 15 17:11:10 raspberrypi kernel: [    0.713985] sdhost: log_buf @ (ptrval) (fad07000)
Sep 15 17:11:10 raspberrypi kernel: [    0.750599] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.753301] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.755925] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.759691] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Sep 15 17:11:10 raspberrypi kernel: [    0.762512] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Sep 15 17:11:10 raspberrypi kernel: [    0.764201] of_cfs_init
Sep 15 17:11:10 raspberrypi kernel: [    0.765199] of_cfs_init: OK
Sep 15 17:11:10 raspberrypi kernel: [    0.766448] Waiting for root device PARTUUID=1b1a0538-02...
Sep 15 17:11:10 raspberrypi kernel: [    0.834109] random: fast init done
Sep 15 17:11:10 raspberrypi kernel: [    0.852916] mmc0: host does not support reading read-only switch, assuming write-enable
Sep 15 17:11:10 raspberrypi kernel: [    0.858419] mmc0: new high speed SDHC card at address e624
Sep 15 17:11:10 raspberrypi kernel: [    0.860153] mmcblk0: mmc0:e624 SC16G 14.8 GiB
Sep 15 17:11:10 raspberrypi kernel: [    0.861508] Indeed it is in host mode hprt0 = 00021501
Sep 15 17:11:10 raspberrypi kernel: [    0.926815]  mmcblk0: p1 p2
Sep 15 17:11:10 raspberrypi kernel: [    0.940712] mmc1: new high speed SDIO card at address 0001
Sep 15 17:11:10 raspberrypi kernel: [    0.962828] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Sep 15 17:11:10 raspberrypi kernel: [    0.965001] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Sep 15 17:11:10 raspberrypi kernel: [    0.973351] devtmpfs: mounted
Sep 15 17:11:10 raspberrypi kernel: [    0.977173] Freeing unused kernel memory: 1024K
Sep 15 17:11:10 raspberrypi kernel: [    1.021191] Run /sbin/init as init process
Sep 15 17:11:10 raspberrypi kernel: [    1.071022] usb 1-1: new high-speed USB device number 2 using dwc_otg
Sep 15 17:11:10 raspberrypi kernel: [    1.072385] Indeed it is in host mode hprt0 = 00001101
Sep 15 17:11:10 raspberrypi kernel: [    1.311200] usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00
Sep 15 17:11:10 raspberrypi kernel: [    1.313860] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Sep 15 17:11:10 raspberrypi kernel: [    1.315702] hub 1-1:1.0: USB hub found
Sep 15 17:11:10 raspberrypi kernel: [    1.317164] hub 1-1:1.0: 5 ports detected
Sep 15 17:11:10 raspberrypi kernel: [    1.572276] NET: Registered protocol family 10
Sep 15 17:11:10 raspberrypi kernel: [    1.574399] Segment Routing with IPv6
Sep 15 17:11:10 raspberrypi kernel: [    1.597919] random: systemd: uninitialized urandom read (16 bytes read)
Sep 15 17:11:10 raspberrypi kernel: [    1.600788] random: systemd: uninitialized urandom read (16 bytes read)
Sep 15 17:11:10 raspberrypi kernel: [    1.631051] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
Sep 15 17:11:10 raspberrypi kernel: [    1.659355] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read)
Sep 15 17:11:10 raspberrypi kernel: [    1.771213] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00
Sep 15 17:11:10 raspberrypi kernel: [    1.773904] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Sep 15 17:11:10 raspberrypi kernel: [    1.777774] smsc95xx v1.0.6
Sep 15 17:11:10 raspberrypi kernel: [    1.873168] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:9a:c6:c3
Sep 15 17:11:10 raspberrypi kernel: [    2.207042] plat_eq3ccu2: loading out-of-tree module taints kernel.
Sep 15 17:11:10 raspberrypi kernel: [    2.208769] Started plat_eq3ccu2
Sep 15 17:11:10 raspberrypi kernel: [    2.547495] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Sep 15 17:11:10 raspberrypi kernel: [    2.838908] pl011_raw_uart 3f201000.serial: Initialized pl011 device; mapbase=0x3f201000; irq=81; clockrate=47999625
Sep 15 17:11:10 raspberrypi kernel: [    2.863825] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 17:11:10 raspberrypi kernel: [    2.865614] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Sep 15 17:11:10 raspberrypi kernel: [    2.865625] [vc_sm_connected_init]: start
Sep 15 17:11:10 raspberrypi kernel: [    2.871684] [vc_sm_connected_init]: installed successfully
Sep 15 17:11:10 raspberrypi kernel: [    2.872163] pl011_raw_uart 3f201000.serial: Initialized pl011 device; mapbase=0x3f201000; irq=81; clockrate=47999625
Sep 15 17:11:10 raspberrypi kernel: [    2.877257] media: Linux media interface: v0.10
Sep 15 17:11:10 raspberrypi kernel: [    2.905943] videodev: Linux video capture interface: v2.00
Sep 15 17:11:10 raspberrypi kernel: [    2.906863] pl011_raw_uart 3f201000.serial: Initialized pl011 device; mapbase=0x3f201000; irq=81; clockrate=47999625
Sep 15 17:11:10 raspberrypi kernel: [    2.906888] pl011_raw_uart 3f201000.serial: Missing I2C driver of rtc device, trying to load
Sep 15 17:11:10 raspberrypi kernel: [    2.906893] pl011_raw_uart 3f201000.serial: Requesting module i2c:rx8130-legacy
Sep 15 17:11:10 raspberrypi kernel: [    2.939567] rtc-rx8130: probe of 1-0032 failed with error -121
Sep 15 17:11:10 raspberrypi kernel: [    2.940874] rtc-rx8130: probe of 1-0032 failed with error -121
Sep 15 17:11:10 raspberrypi kernel: [    2.941311] raw-uart raw-uart: Reset radio module
Sep 15 17:11:10 raspberrypi kernel: [    2.980920] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 17:11:10 raspberrypi kernel: [    2.987084] bcm2835_audio soc:audio: card created with 8 channels
Sep 15 17:11:10 raspberrypi kernel: [    3.010389] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 17:11:10 raspberrypi kernel: [    3.012196] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 17:11:10 raspberrypi kernel: [    3.024685] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 17:11:10 raspberrypi kernel: [    3.028509] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Sep 15 17:11:10 raspberrypi kernel: [    3.040534] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Sep 15 17:11:10 raspberrypi kernel: [    3.040545] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Sep 15 17:11:10 raspberrypi kernel: [    3.044111] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Sep 15 17:11:10 raspberrypi kernel: [    3.044120] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Sep 15 17:11:10 raspberrypi kernel: [    3.053544] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Sep 15 17:11:10 raspberrypi kernel: [    3.053553] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Sep 15 17:11:10 raspberrypi kernel: [    3.126511] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Sep 15 17:11:10 raspberrypi kernel: [    3.161083] raw-uart raw-uart: Registered new raw-uart device using underlying device GPIO@3f201000.serial.
Sep 15 17:11:10 raspberrypi kernel: [    3.190011] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Sep 15 17:11:10 raspberrypi kernel: [    3.241866] usbcore: registered new interface driver brcmfmac
Sep 15 17:11:10 raspberrypi kernel: [    3.724608] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Sep 15 17:11:10 raspberrypi kernel: [    3.737329] br0: port 1(eth0) entered blocking state
Sep 15 17:11:10 raspberrypi kernel: [    3.737338] br0: port 1(eth0) entered disabled state
Sep 15 17:11:10 raspberrypi kernel: [    3.737565] device eth0 entered promiscuous mode
Sep 15 17:11:10 raspberrypi kernel: [    3.840315] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
Sep 15 17:11:10 raspberrypi kernel: [    3.848839] IPv6: ADDRCONF(NETDEV_UP): br0: link is not ready
Sep 15 17:11:10 raspberrypi kernel: [    3.922507] new mount options do not match the existing superblock, will be ignored
Sep 15 17:11:10 raspberrypi kernel: [    4.124208] fuse init (API version 7.27)
Sep 15 17:11:11 raspberrypi kernel: [    4.656673] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
Sep 15 17:11:12 raspberrypi kernel: [    5.299133] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0xDDE1
Sep 15 17:11:12 raspberrypi kernel: [    5.300292] br0: port 1(eth0) entered blocking state
Sep 15 17:11:12 raspberrypi kernel: [    5.300298] br0: port 1(eth0) entered forwarding state
Sep 15 17:11:12 raspberrypi kernel: [    5.300442] IPv6: ADDRCONF(NETDEV_CHANGE): br0: link becomes ready
Sep 15 17:37:30 raspberrypi kernel: [   10.640257] raw-uart raw-uart: Reset radio module
Sep 15 17:38:44 raspberrypi kernel: [   84.610082] random: crng init done
Sep 15 17:38:44 raspberrypi kernel: [   84.610089] random: 7 urandom warning(s) missed due to ratelimiting
Sep 15 17:38:45 raspberrypi kernel: [   84.694631] br0: port 2(vethpivccu) entered blocking state
Sep 15 17:38:45 raspberrypi kernel: [   84.694641] br0: port 2(vethpivccu) entered disabled state
Sep 15 17:38:45 raspberrypi kernel: [   84.694889] device vethpivccu entered promiscuous mode
Sep 15 17:38:45 raspberrypi kernel: [   84.695143] IPv6: ADDRCONF(NETDEV_UP): vethpivccu: link is not ready
Sep 15 17:38:45 raspberrypi kernel: [   84.695150] br0: port 2(vethpivccu) entered blocking state
Sep 15 17:38:45 raspberrypi kernel: [   84.695155] br0: port 2(vethpivccu) entered forwarding state
Sep 15 17:38:45 raspberrypi kernel: [   84.697426] br0: port 2(vethpivccu) entered disabled state
Sep 15 17:38:45 raspberrypi kernel: [   84.789132] eth0: renamed from vethRCSXBG
Sep 15 17:38:45 raspberrypi kernel: [   84.852432] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Sep 15 17:38:45 raspberrypi kernel: [   84.853412] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Sep 15 17:38:45 raspberrypi kernel: [   84.853516] IPv6: ADDRCONF(NETDEV_CHANGE): vethpivccu: link becomes ready
Sep 15 17:38:45 raspberrypi kernel: [   84.853582] br0: port 2(vethpivccu) entered blocking state
Sep 15 17:38:45 raspberrypi kernel: [   84.853588] br0: port 2(vethpivccu) entered forwarding state
Sep 15 17:39:13 raspberrypi kernel: [  113.470145] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 17:39:13 raspberrypi kernel: [  113.470400] eq3loop: eq3loop_close_slave() mmd_hmip
Sep 15 17:39:13 raspberrypi kernel: [  113.473621] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 17:39:13 raspberrypi kernel: [  113.473848] eq3loop: eq3loop_close_slave() mmd_hmip
Sep 15 17:39:13 raspberrypi kernel: [  113.474686] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 15 17:39:13 raspberrypi kernel: [  113.474861] eq3loop: eq3loop_close_slave() mmd_hmip
Sep 15 17:39:13 raspberrypi kernel: [  113.483815] eq3loop: eq3loop_open_slave() mmd_hmip

EDIT: Fehlerbeschreibung hinzugefügt

Grüße
Fabian

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

Re: piVCCu reagiert nicht.

Beitrag von deimos » 15.09.2022, 18:07

Hi,

was für Geräte reagieren nicht mehr, HM, HmIP oder beides?
it der /var/log/messages meinte ich die aus fem CCU Container.

Viele Grüße
Alex

fab_joe
Beiträge: 7
Registriert: 02.04.2018, 17:23

Re: piVCCu reagiert nicht.

Beitrag von fab_joe » 15.09.2022, 18:28

Hi,
ich habe ausschließlich HmIP im Einsatz.
die /var/log/message aus dem CCU Container hab ich leider nicht, wg reboot. Beim nächsten mal sicher ich die raus.
Wusste ich nicht. Sorry.
Kann ich noch weitere Daten/Infos liefern?

Sorry.
Gruß
Fabian

fab_joe
Beiträge: 7
Registriert: 02.04.2018, 17:23

Re: piVCCu reagiert nicht.

Beitrag von fab_joe » 16.09.2022, 08:22

Guten Morgen Alex,
heute morgen "war" schon die CCU abgestürzt, weiter gleiches verhalten.
Nach einem "sudo systemctl restart pivccu.service" lief es wieder.

Die ersten Einträge in der /var/log/messages waren erst um 5:19 Uhr, als ich meine Jalousien herunterfahren wollte.
Um 0 Uhr gab es den logswitch, sodass der Absturz nicht dabei ist.

Sobald heute die CCU wieder abstürzt (vor 23:59 Uhr) poste ich nochmal eine aktuelle /var/log/messages

Code: Alles auswählen

Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD687"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD687"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD665"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD665"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD665"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD665"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD665"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD665"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD846"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD846"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD846"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD846"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD846"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD846"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD5CD"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD5CD"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD5CD"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD5CD"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD5CD"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD5CD"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD65A"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD65A"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD65A"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD65A"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD65A"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD65A"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD684"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD684"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD684"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD684"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD684"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD684"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD602"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD602"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD602"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD602"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD602"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD602"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD63B"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD63B"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD63B"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD63B"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD63B"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD63B"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD6CD"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD6CD"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD6CD"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD6CD"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD6CD"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"001157099AD6CD"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"00241BE989E460"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"00241BE989E460"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"00241BE989E460"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"00241BE989E460"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"00241BE989E460"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"00241BE989E460"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A190"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A190"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A190"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A190"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A190"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A190"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0AA"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A0AA"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0AA"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A0AA"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0AA"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A0AA"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0CE"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A0CE"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0CE"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A0CE"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0CE"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"0001DBE9A1A0CE"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"HmIP-RCV-1"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"HmIP-RCV-1"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"HmIP-RCV-1"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"HmIP-RCV-1"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Sep 16 05:19:17 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getDeviceDescription': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"HmIP-RCV-1"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Sep 16 05:19:17 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getDeviceDescription' call failed (interface: 1011, params: {"HmIP-RCV-1"}) [CallGetDeviceDescription():iseXmlRpc.cpp:2192]
Sep 16 05:22:56 piVCCU syslog.info syslogd started: BusyBox v1.29.2
Sep 16 05:22:56 piVCCU user.notice kernel: klogd started: BusyBox v1.29.2 (2022-07-14 12:44:18 CEST)
Sep 16 05:22:56 piVCCU syslog.info syslogd exiting
Sep 16 05:22:56 ccu3-webui syslog.info syslogd started: BusyBox v1.29.2
Sep 16 05:22:56 ccu3-webui user.notice kernel: klogd started: BusyBox v1.29.2 (2022-07-14 12:44:18 CEST)
Sep 16 05:22:56 ccu3-webui daemon.err udhcpc[159]: started, v1.29.2
Sep 16 05:22:56 ccu3-webui daemon.err udhcpc[159]: sending discover
Sep 16 05:22:56 ccu3-webui daemon.err udhcpc[159]: sending select for 192.168.178.11
Sep 16 05:22:56 ccu3-webui daemon.err udhcpc[159]: lease of 192.168.178.11 obtained, lease time 864000
Sep 16 05:22:57 ccu3-webui user.info firewall: iptables v1.6.2: invalid port/service `310000' specified Try `iptables -h' or 'iptables --help' for more information.
Sep 16 05:22:57 ccu3-webui user.info firewall: ip6tables v1.6.2: invalid port/service `310000' specified Try `ip6tables -h' or 'ip6tables --help' for more information.
Sep 16 05:22:57 ccu3-webui user.info firewall: configuration set
Sep 16 05:22:57 ccu3-webui daemon.info ifplugd(eth0)[244]: ifplugd 0.28 initializing.
Sep 16 05:22:57 ccu3-webui daemon.info ifplugd(eth0)[244]: Using interface eth0/CA:CF:1C:B9:57:5C with driver <veth> (version: 1.0)
Sep 16 05:22:57 ccu3-webui daemon.info ifplugd(eth0)[244]: Using detection mode: SIOCETHTOOL
Sep 16 05:22:57 ccu3-webui daemon.info ifplugd(eth0)[244]: Initialization complete, link beat detected.
Sep 16 05:22:57 ccu3-webui daemon.warn ifplugd(eth0)[244]: Could not open /dev/tty, cannot beep.
Sep 16 05:22:57 ccu3-webui daemon.info ifplugd(eth0)[244]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Sep 16 05:22:57 ccu3-webui daemon.warn ifplugd(eth0)[244]: client: ifup: interface eth0 already configured
Sep 16 05:22:57 ccu3-webui daemon.info ifplugd(eth0)[244]: Program executed successfully.
Sep 16 05:23:03 ccu3-webui daemon.notice ntpdate[252]: step time server 136.243.102.134 offset -0.000038 sec
Sep 16 05:23:03 ccu3-webui daemon.notice ntpd[253]: ntpd 4.2.8p12@1.3728-o Thu Jul 14 12:42:17 CEST 2022 (1): Starting
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[253]: Command line: /usr/sbin/ntpd -g 0.de.pool.ntp.org
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: proto: precision = 0.469 usec (-21)
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: Listen and drop on 0 v6wildcard [::]:123
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: Listen normally on 2 lo 127.0.0.1:123
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: Listen normally on 3 eth0 192.168.178.11:123
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: Listen normally on 4 lo [::1]:123
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: Listening on routing socket on fd #21 for interface updates
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Sep 16 05:23:03 ccu3-webui daemon.info ntpd[255]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Sep 16 05:23:03 ccu3-webui daemon.err xinetd[271]: Unable to read included directory: /etc/config/xinetd.d [file=/etc/xinetd.conf] [line=14]
Sep 16 05:23:03 ccu3-webui daemon.crit xinetd[271]: 271 {init_services} no services. Exiting...
Sep 16 05:23:04 ccu3-webui user.info root: Updating RF Lan Gateway Coprocessor Firmware
Sep 16 05:23:04 ccu3-webui user.debug update-coprocessor: firmware filename is: coprocessor_update_hm_only.eq3
Sep 16 05:23:04 ccu3-webui user.info root: Updating RF Lan Gateway Firmware
Sep 16 05:23:04 ccu3-webui user.info update-lgw-firmware: No gateway found in config file /etc/config/rfd.conf
Sep 16 05:23:21 ccu3-webui user.info kernel: [42361.456033] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 16 05:23:21 ccu3-webui user.info kernel: [42361.459154] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 16 05:23:21 ccu3-webui user.info kernel: [42361.460050] eq3loop: eq3loop_open_slave() mmd_hmip
Sep 16 05:23:48 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0CE:6","ENERGY_COUNTER"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"0001DBE9A1A0CE:6","ENERGY_COUNTER"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:48 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0AA:6","ENERGY_COUNTER"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"0001DBE9A1A0AA:6","ENERGY_COUNTER"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:48 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0CE:6","ENERGY_COUNTER_OVERFLOW"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER_OVERFLOW"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"0001DBE9A1A0CE:6","ENERGY_COUNTER_OVERFLOW"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:48 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A190:6","ENERGY_COUNTER"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"0001DBE9A1A190:6","ENERGY_COUNTER"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:48 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A0AA:6","ENERGY_COUNTER_OVERFLOW"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER_OVERFLOW"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"0001DBE9A1A0AA:6","ENERGY_COUNTER_OVERFLOW"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:48 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"0001DBE9A1A190:6","ENERGY_COUNTER_OVERFLOW"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER_OVERFLOW"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"0001DBE9A1A190:6","ENERGY_COUNTER_OVERFLOW"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:48 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:51 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD8A0:5","LEVEL"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"001157099AD8A0:5","LEVEL"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:51 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD8A0:6","LEVEL"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"001157099AD8A0:6","LEVEL"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:51 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD8A0:4","LEVEL"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"001157099AD8A0:4","LEVEL"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:51 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD8A0:3","LEVEL"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"001157099AD8A0:3","LEVEL"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0.000000 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:51 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD8A0:3","LEVEL_STATUS"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: LEVEL_STATUS"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"001157099AD8A0:3","LEVEL_STATUS"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:51 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD8A0:3","ACTIVITY_STATE"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: ACTIVITY_STATE"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"001157099AD8A0:3","ACTIVITY_STATE"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:23:51 ccu3-webui local0.warn ReGaHss: WARNING: XMLRPC 'getValue': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"001157099AD8A0:7","WEEK_PROGRAM_CHANNEL_LOCKS"}, result: [faultCode:-5,faultString:"Unknown Parameter value for value key: WEEK_PROGRAM_CHANNEL_LOCKS"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: XMLRPC 'getValue' call failed (interface: 1011, params: {"001157099AD8A0:7","WEEK_PROGRAM_CHANNEL_LOCKS"}) [CallGetValue():iseXmlRpc.cpp:1435]
Sep 16 05:23:51 ccu3-webui local0.err ReGaHss: ERROR: CallGetValue failed; sVal = 0 [ReadValue():iseDOMdpHSS.cpp:124]
Sep 16 05:29:47 ccu3-webui daemon.info ntpd[255]: Listen normally on 5 eth0 [2a02:560:5505:b100:c8cf:1cff:feb9:575c]:123

Soweit erstmal.
Vielen Dank für deine Unterstützung.
Grüße
Fabian

Antworten

Zurück zu „piVCCU“