Raspberry Matic Addon für Home Assistant - kein Anlernen von Geräten möglich

[MrLemming]

Hier der Inhalt der /var/log/hmserver.log Datei direkt nach dem Neustart:

Code: Alles auswählen

Sep 28 22:49:41 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] @GenericFactory
Sep 28 22:49:41 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] created instance of HMServerConfiguration with parameter(s)
Sep 28 22:49:41 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] passed 1 parameter(s), in declarative order [String]
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [HMIPTRXWriterWorker] (1) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KeyServerWorker] (1) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KryoPersistenceWorker] (1) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [TransactionSubsystemHandler] (1) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [FirmwareLoaderFileSystem] (1) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerPersistentDataLoader] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerAdapterInitialization] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [TransactionManagementVerticle] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [BackendCommandHandler] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionAcceptHandler] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CheckDeviceExistHandler] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [IncomingHMIPFrameHandler] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceBackgroundUpdateSubsystem] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceLiveUpdateSubsystem] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionDefaultConfigurationChanger] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CyclicSmokeDetectorAwakening] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerFirmwareUpdateInitialization] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyNotificationHandler] (1) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyAPIWorker] (1) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBackendNotificationHandler] (3) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBlindLevelCorrectionHandler] (1) *worker
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyInitializion] (1)
Sep 28 22:49:47 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: deploying 22 classes to Vert.x
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: 22 VertxDeployers initialized
Sep 28 22:49:48 de.eq3.cbcs.server.core.vertx.CyclicSmokeDetectorAwakening INFO  [vert.x-eventloop-thread-0] SYSTEM: CyclicSmokeDetectorAwakening Verticle or Worker started
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of CyclicSmokeDetectorAwakening succeeded (c762169e-6680-444e-836b-dd84ee086307)
Sep 28 22:49:48 de.eq3.cbcs.server.core.vertx.DeviceInclusionDefaultConfigurationChanger INFO  [vert.x-eventloop-thread-5] SYSTEM: DeviceInclusionDefaultConfigurationChanger Verticle or Worker started
Sep 28 22:49:48 de.eq3.cbcs.server.core.vertx.HMIPAbstractWriterWorker INFO  [vert.x-worker-thread-3] SYSTEM: HMIPTRXWriterWorker Verticle or Worker started
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of DeviceInclusionDefaultConfigurationChanger succeeded (cc9d9fac-a332-493f-9691-422a11938450)
Sep 28 22:49:48 de.eq3.cbcs.server.core.vertx.CheckDeviceExistHandler INFO  [vert.x-eventloop-thread-3] SYSTEM: CheckDeviceExistHandler Verticle or Worker started
Sep 28 22:49:48 de.eq3.cbcs.server.core.vertx.TransactionSubsystemHandler INFO  [vert.x-worker-thread-1] SYSTEM: TransactionSubsystemHandler Verticle or Worker started
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of CheckDeviceExistHandler succeeded (de55cfaf-116a-4240-b366-a60db64dc163)
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of TransactionSubsystemHandler succeeded (7268d2cd-ee27-4046-90a1-71be338ec671)
Sep 28 22:49:48 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBlindLevelCorrectionHandler INFO  [vert.x-worker-thread-2] SYSTEM: LegacyBlindLevelCorrectionHandler Verticle or Worker started
Sep 28 22:49:48 de.eq3.cbcs.server.core.vertx.KeyServerWorker ERROR [vert.x-worker-thread-0] Missing key server configuration parameter (Network.Key) for  mode: KEYSERVER_LOCAL
Sep 28 22:49:48 de.eq3.cbcs.server.core.vertx.KeyServerWorker INFO  [vert.x-worker-thread-0] SYSTEM: KeyServerWorker Verticle or Worker started
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of KeyServerWorker succeeded (9e205bc2-8d9c-4c80-a062-a0eba887a8a3)
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LegacyBlindLevelCorrectionHandler succeeded (bdf1b495-9056-4141-9d0c-03b740426c67)
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of KryoPersistenceWorker succeeded (595c6fc3-44d1-4907-bf4c-a7225eb97b43)
Sep 28 22:49:48 de.eq3.cbcs.server.local.base.internal.LocalServerPersistentDataLoader INFO  [vert.x-eventloop-thread-4] SYSTEM: LocalServerPersistentDataLoader Verticle or Worker started
Sep 28 22:49:48 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of LocalServerPersistentDataLoader succeeded (f304bded-c823-4504-a38e-fed02dabdf80)
Sep 28 22:49:49 de.eq3.cbcs.server.core.otau.AbstractUpdateSubsystem INFO  [vert.x-eventloop-thread-6] SYSTEM: DeviceLiveUpdateSubsystem Verticle or Worker started
Sep 28 22:49:49 de.eq3.cbcs.server.core.otau.AbstractUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: DeviceBackgroundUpdateSubsystem Verticle or Worker started
Sep 28 22:49:49 de.eq3.cbcs.server.core.live_otau.DeviceLiveUpdateSubsystem INFO  [vert.x-eventloop-thread-6] SYSTEM: DeviceLiveUpdateSubsystem started
Sep 28 22:49:49 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DeviceLiveUpdateSubsystem succeeded (75fcec87-3a73-4d00-bba6-cdb7f5606676)
Sep 28 22:49:49 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of HMIPTRXWriterWorker succeeded (f7b0a412-cdfe-495b-b9fe-938476e02017)
Sep 28 22:49:49 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of DeviceBackgroundUpdateSubsystem succeeded (8fec30b2-6046-4a9c-98a0-988f9af5b51d)
Sep 28 22:49:49 de.eq3.cbcs.server.core.vertx.DeviceInclusionAcceptHandler INFO  [vert.x-eventloop-thread-7] SYSTEM: DeviceInclusionAcceptHandler Verticle or Worker started
Sep 28 22:49:49 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of DeviceInclusionAcceptHandler succeeded (2c4d87e3-4a70-4fd6-acd5-1830e8b82de0)
Sep 28 22:49:49 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-2] SYSTEM: Firmware update directory is set to /etc/config/firmware
Sep 28 22:49:49 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-2] SYSTEM: FirmwareLoaderFileSystem Verticle or Worker started
Sep 28 22:49:49 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of FirmwareLoaderFileSystem succeeded (a7f19931-a37f-46f2-8b40-5dc9bd060754)
Sep 28 22:49:49 de.eq3.cbcs.server.core.transaction.TransactionManagementVerticle INFO  [vert.x-eventloop-thread-2] SYSTEM: TransactionManagementVerticle Verticle or Worker started
Sep 28 22:49:49 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of TransactionManagementVerticle succeeded (6f0bc4f1-df01-4db1-a142-dcb8ba495a51)
Sep 28 22:49:49 de.eq3.cbcs.server.core.vertx.IncomingHMIPFrameHandler INFO  [vert.x-eventloop-thread-4] SYSTEM: IncomingHMIPFrameHandler Verticle or Worker started
Sep 28 22:49:49 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of IncomingHMIPFrameHandler succeeded (4e5d10db-fd95-43ae-afa7-26e00c44a083)
Sep 28 22:49:49 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [vert.x-eventloop-thread-6] SYSTEM: LocalServerAdapterInitialization Verticle or Worker started
Sep 28 22:49:49 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LocalServerAdapterInitialization succeeded (3539ff0b-67a4-4bdb-b526-5ac9e30715b8)
Sep 28 22:49:49 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] TRX adapter state 1: HMIP_TRX_App
Sep 28 22:49:49 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] TRX adapter application is already running or started
Sep 28 22:49:49 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] No NWK, try to set address ...
Sep 28 22:49:49 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Try to set radio address 12119218...
Sep 28 22:49:49 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Set max send attempts for 3014F711A000041709ADFD6D to 3
Sep 28 22:49:49 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Try to get application version...
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Application version 2.8.6
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Bootloader version 1.0.12
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] hmos version 1.20.3
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] MCU type: EFM32G200F64_CM3
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Duty Cycle: 0.0
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] set DutyCycle limit to ffffffc8
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Set Duty Cycle Limit
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Current Security Counter: 92212224
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Update security counter to calculation: 92213369
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] TRX adapter has no linkpartner
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [RXTXPortMonitor(/dev/ttyUSB0)] Adapter with Access Point id 3014F711A000041709ADFD6D initialized
Sep 28 22:49:50 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [RXTXPortMonitor(/dev/ttyUSB0)] HMIPTRXInitialResponseListener said that Adapter was initialized
Sep 28 22:49:51 de.eq3.cbcs.server.local.base.internal.LocalServerFirmwareUpdateInitialization INFO  [vert.x-eventloop-thread-3] SYSTEM: LocalServerFirmwareUpdateInitialization Verticle or Worker started
Sep 28 22:49:51 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyNotificationHandler INFO  [vert.x-worker-thread-1] SYSTEM: LegacyNotificationHandler Verticle or Worker started
Sep 28 22:49:51 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of LegacyNotificationHandler succeeded (bb779cfe-d345-4d07-9a08-5ba071b73108)
Sep 28 22:49:51 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of LocalServerFirmwareUpdateInitialization succeeded (eee93d01-3f4f-41b2-8005-41e98cf4685f)
Sep 28 22:49:51 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: Checking all devices on all accesspoints for updates
Sep 28 22:49:51 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: There are 0 APs queued with updatable devices (RF)
Sep 28 22:49:51 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: There are 0 APs queued with updatable devices (WIRED)
Sep 28 22:49:51 de.eq3.cbcs.server.core.vertx.BackendCommandHandler INFO  [vert.x-eventloop-thread-5] SYSTEM: BackendCommandHandler Verticle or Worker started
Sep 28 22:49:51 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of BackendCommandHandler succeeded (6bc6aa88-3b80-4611-bc8d-cc1c1134e687)
Sep 28 22:49:51 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-4] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started
Sep 28 22:49:51 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-4] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started
Sep 28 22:49:51 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyAPIWorker INFO  [vert.x-worker-thread-3] SYSTEM: LegacyAPIWorker Verticle or Worker started
Sep 28 22:49:51 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LegacyAPIWorker succeeded (a985921b-d502-4986-8e08-212f0563c41d)
Sep 28 22:49:51 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [vert.x-worker-thread-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started
Sep 28 22:49:51 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LegacyBackendNotificationHandler succeeded (0479be64-165b-450d-8a45-368ae1e2db4f)
Sep 28 22:49:52 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyInitializion INFO  [vert.x-eventloop-thread-1] SYSTEM: LegacyInitializion Verticle or Worker started
Sep 28 22:49:52 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LegacyInitializion succeeded (d5099e6f-ece4-48bc-9482-ff5fd12b0fa8)
Sep 28 22:49:52 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: initial deployment complete _____________________________________________________
Sep 28 22:49:53 de.eq3.cbcs.server.local.LocalServer INFO  [Thread-0] SYSTEM: Bind XML-RPC api to port 32010
Sep 28 22:49:56 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default MaxEventLoopExecuteTime: 2000000000
Sep 28 22:49:56 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default BlockedThreadCheckInterval: 1000
Sep 28 22:49:56 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default MaxWorkerExecuteTime: 60000000000
Sep 28 22:49:56 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default EventLoopPoolSize: 8
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [BackendWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [GroupRequestWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DiagramRequestWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [StorageRequestWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceFirmwareRequestWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [EnergyPriceRequestWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [CouplingRequestWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [RegaClientWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [GroupConfigurationPersistenceFileSystem] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [HmIPGatewayManagementRequestWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [AccessPointUpdateServerWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [AccessPointUpdateLoaderWorker] (1) *worker
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: deploying 12 classes to Vert.x
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: 12 VertxDeployers initialized
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of BackendWorker succeeded (ac42bb67-ad1d-4f9b-9ba5-f252ddc83faa)
Sep 28 22:49:56 de.eq3.ccu.hmip.accesspoint.update.AccessPointUpdateLoaderWorker INFO  [vert.x-worker-thread-2] SYSTEM: Firmware update directory is set to /etc/config/firmware
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of AccessPointUpdateLoaderWorker succeeded (4a1fc0b4-628b-4b58-80b4-4585262066f2)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of GroupConfigurationPersistenceFileSystem succeeded (08309c2a-37b4-4b2c-bf08-040a0763a1e9)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of StorageRequestWorker succeeded (42052304-9f18-421c-a0d6-c5f23ba9f589)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of RegaClientWorker succeeded (0e5ded87-e2bd-46be-a596-776cd90ef003)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of EnergyPriceRequestWorker succeeded (b80576de-a680-470c-ad23-5843b8c9d027)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of AccessPointUpdateServerWorker succeeded (acc898d7-7a0f-4a31-9bcb-4aa493ec6d1a)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of CouplingRequestWorker succeeded (42bd9d71-ea70-4882-b46f-55f02bc659aa)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of GroupRequestWorker succeeded (205569b4-5a27-4e35-ae14-5cb66d5ce2cd)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of DiagramRequestWorker succeeded (6de8dc05-904e-48dc-b9f0-7a6aec26ed9b)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (e5835df0-6627-42ea-be56-d4d5a22ebb4e)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of HmIPGatewayManagementRequestWorker succeeded (6d6c57bb-adf6-4550-bcea-023b41c09b7b)
Sep 28 22:49:56 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: initial deployment complete _____________________________________________________
Sep 28 22:49:56 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Starting HMServer at 127.0.0.1:39292
Sep 28 22:49:56 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Read Configuration
Sep 28 22:49:56 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create Bidcos Dispatcher
Sep 28 22:49:56 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] InitBidCosCache
Sep 28 22:49:57 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create groupDefinitionProvider
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create VirtualDeviceHolder
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create VirtualDeviceHandlerRega
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupAdministrationService
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupDeviceDispatcher
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupDeviceHandler
Sep 28 22:49:58 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-1] @GroupDeviceHandler - initializing...
Sep 28 22:49:58 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-1] --> created groupDeviceDispatcher (GroupDeviceService to BidCoS (via Dispatcher))
Sep 28 22:49:58 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-1] --> created virtualDeviceHandler (GroupDeviceService to ReGa)
Sep 28 22:49:58 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-1] --> got groupDefinitionProvider
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create BidCosGroupMemberProvider
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Init groupAdministrationService
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Init Virtual OS Device
Sep 28 22:49:58 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Init ESHLight Bridge
Sep 28 22:49:59 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create RrdDatalogging
Sep 28 22:49:59 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create MeasurementService
Sep 28 22:49:59 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Init MeasurementService
Sep 28 22:49:59 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create HTTP Server
Sep 28 22:49:59 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create BidCos context and start handler
Sep 28 22:49:59 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create group context and start handler
Sep 28 22:49:59 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
Sep 28 22:49:59 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [HmIP-RF_java_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started
Sep 28 22:49:59 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] init finished
Sep 28 22:49:59 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-2] Added InterfaceId: HmIP-RF_java
Sep 28 22:49:59 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-2] updateDevicesForClient HmIP-RF_java -> 52 device addresses will be added
Sep 28 22:49:59 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: Checking all devices on all accesspoints for updates
Sep 28 22:49:59 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: There are 0 APs queued with updatable devices (RF)
Sep 28 22:49:59 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: There are 0 APs queued with updatable devices (WIRED)
Sep 28 22:50:00 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Starting HMServer done
Sep 28 22:50:07 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-5] (un)registerCallback on VirtualDeviceHandlerRega called from url: xmlrpc_bin://127.0.0.1:31999
Sep 28 22:50:07 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-5] Added InterfaceId: 1007
Sep 28 22:50:07 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-13] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand
Sep 28 22:50:17 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
Sep 28 22:50:17 de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendNotificationHandler INFO  [1008_WorkerPool-0] SYSTEM: LegacyBackendNotificationHandler Verticle or Worker started
Sep 28 22:50:17 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-2] init finished
Sep 28 22:50:17 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-2] Added InterfaceId: 1008
Sep 28 22:54:49 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: 0 Accesspoints in Queue
Sep 28 22:54:49 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used
Sep 28 22:54:49 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: Eventlistener Handler utilization: 0/50 used

[MrLemming]

Hier ein Link zum TeachIn-Dialog: https://ibb.co/X22KW8f

[jmaus]

Komisch, das logfile sieht auch soweit i.o. aus. Welche version von HAos hast du denn für den rpi4 installiert? Die 64bit version oder die 32bit?

[MrLemming]

Die 64bit Version

[MrLemming]

Ich habe gerade in meiner System Log folgende Meldungen gefunden:

Code: Alles auswählen

21-09-28 23:07:34 INFO (MainThread) [supervisor.hardware.monitor] Detecting HardwareAction.REMOVE hardware /dev/bus/usb/001/048 - None
21-09-28 23:07:37 INFO (MainThread) [supervisor.hardware.monitor] Detecting HardwareAction.ADD hardware /dev/bus/usb/001/049 - None
21-09-28 23:07:37 INFO (MainThread) [supervisor.hardware.monitor] Detecting HardwareAction.ADD hardware /dev/ttyACM0 - /dev/serial/by-id/usb-dresden_elektronik_ingenieurtechnik_GmbH_ConBee_II_DE2268797-if00

Für den Conbee sieht das normal aus. Könnte das andere der eQ-3_HmIP-RFUSB sein?
Unter Hardware wird der Stick zwar richtig aufgeführt, aber hier taucht scheinbar ein None auf. Die Meldungen sind dennoch grün und nicht als Warnung oder Fehler gekennzeichnet.

[MrLemming]

Vielleicht auch noch hilfreich:

Unter Devices: Für den HmIP-RCV-50 Unterpunkt: HmIP-RCV-50 HmIP-RCV-1:0 bekomme ich ein "no connection possible" als Interface category, für alle anderen (Push buttons) stattdessen "Transmitter" angezeigt.

Und in der Log, die man aus RaspberryMatic heraus herunterladen kann gibt es unter ***** messages ***** u.a. folgende Einträge:

Code: Alles auswählen

Sep 28 22:50:35 de838cd8-raspberrymatic user.warn monit[575]: 'hasUSB' status failed (1) -- no output
Sep 28 22:50:36 de838cd8-raspberrymatic user.warn monit[575]: 'rpi4usb3Check' status failed (1) -- no output
Sep 28 22:50:36 de838cd8-raspberrymatic user.err monit[575]: Filesystem '/media/usb1' not mounted
Sep 28 22:50:36 de838cd8-raspberrymatic user.err monit[575]: 'usb1' unable to read filesystem '/media/usb1' state
Sep 28 22:50:36 de838cd8-raspberrymatic user.info monit[575]: 'usb1' trying to restart
Sep 28 22:50:52 de838cd8-raspberrymatic user.warn monit[575]: 'hasUSB' status failed (1) -- no output
Sep 28 22:50:52 de838cd8-raspberrymatic user.err monit[575]: 'rpi4usb3Check' status failed (1) -- no output
Sep 28 22:50:52 de838cd8-raspberrymatic user.err monit[575]: Filesystem '/media/usb1' not mounted
Sep 28 22:50:52 de838cd8-raspberrymatic user.err monit[575]: 'usb1' unable to read filesystem '/media/usb1' state
Sep 28 22:50:52 de838cd8-raspberrymatic user.info monit[575]: 'usb1' trying to restart
Sep 28 22:51:08 de838cd8-raspberrymatic user.warn monit[575]: 'hasUSB' status failed (1) -- no output
Sep 28 22:51:09 de838cd8-raspberrymatic user.err monit[575]: Filesystem '/media/usb1' not mounted
Sep 28 22:51:09 de838cd8-raspberrymatic user.err monit[575]: 'usb1' unable to read filesystem '/media/usb1' state
Sep 28 22:51:09 de838cd8-raspberrymatic user.info monit[575]: 'usb1' trying to restart
Sep 28 22:51:24 de838cd8-raspberrymatic user.err monit[575]: 'hasUSB' status failed (1) -- no output

[jmaus]

Hmm, wirklich komisch. Das sieht eigentlich alles ziemlich normal aus und ich kann mir wirklich nicht erklären warum bei der der Anlerndialog leer bleibt. Auch sagst du du bekommst das HmIP-RCV-50 device angezeigt, dann sollte der rest doch eigentlich auch gehen. Probier doch bitte nochmal folgendes:

1. Inhalt von /etc/config/InterfacesList.xml zeigen
2. Inhalt von /var/etc/crRFD.conf zeigen
3. Ausgabe des Kommandos "ps aux | grep HMIPServer" zeigen
4. Schick mal nen Screenshot deiner Firewalleinstellungen in der RaspberryMatic WebUI (Einstellungen -> Firewall)
5. Lenk mal Port 80 in der Addon-Konfiguration auf z.B. Port 8088 um und starte das Addon neu, dann verbinde dich mit http://IP:8080/ und greife so mal auf die WebUI von RaspberryMatic zu und schau ob da dann der Anlerndialog kommt.
6. Probier mal bitte nen anderen Browser
7. Schau mal in die Browser-Console ob da irgendwelche Fehler geloggt werden. ggf. wird der Dialog ja einfach fälschlicherweise nur nicht angezeigt.

[jmaus]

Also nun hab ich mal einen Pi4 + HmIP-RFUSB aus meiner Kiste geholt und versucht das ganze mit einer komplett frischen HomeAssistantOS 6.4 Installation + RaspberryMatic 3.59.6.20210911 Add-on Version zu reproduzieren. Leider ohne erfolg, bei mir kommt immer wie zu erwarten dann auch korrekt das Anlernfenster mit der möglichkeit homematicIP Geräte anlernen zu lassen:

Ich kann mir also nur erklären, das das bei dir nicht funktioniert weil ggf. irgendetwas innerhalb deiner HomeAssistantOS Installation anders ist als bei mir bzw. anderen. Es kann gut sein, das auf Grund der vorherigen Nutzung des nativen HomeMatic Add-ons irgendetwas anders bzw. umkonfiguriert ist und der USB Stick doch nicht so sauber eingebunden wird oder ähnliches.

Deshalb würde ich dir vorschlagen doch einfach mal auf einer zweiten SD Karte mal probeweise eine frische HomeAssistantOS Installation durchzuführen und dann darin das RaspberryMatic Addon noch einmal zu testen. Würde mich nicht wundern, wenn in dem Falle der Anlerndialog korrekt hochkommt und du Geräte daraufhin anlernen kannst. Ich für meinen Teil habe aber auf dem Testsystem hier keinerlei Probleme und andere vmtl. auch nicht.

[MrLemming]

Hi,
danke für deinen Einsatz und die ganze Hilfe.
Ich hatte leider gestern keine Zeit und komme auch erst richtig wieder am Wochenende dazu, aber ich habe eben mal Punkt 6. ausprobiert. Ich habe die HA-Webseite bei mir als WebApp installiert (und damit bisher auch keine Probleme gehabt). Das war aber schonmal der Grund für das fehlende UI. DIrekt im FireFox Browser klappt es und ich sehe die Buttons (und auch die Infos auf der Startseite), sowie die runterzählenden Sekunden, wenn ich den Button drücke.

Leider finde ich auf Anhieb weiterhin keine Geräte. Ich werde es am Wochenende weiter probieren (und die anderen Tipps von dir befolgen). Wohlmöglich ist es noch so ein banaler Fehler.
Vielleicht kannst du aber mal testen, ob das UI bei dir auch nicht auftaucht, wenn du die Seite als App installierst (bei mir über den neuen Edge).

Nochmal Danke!
Lemming

[jmaus]

Ich habe die HA-Webseite bei mir als WebApp installiert (und damit bisher auch keine Probleme gehabt). Das war aber schonmal der Grund für das fehlende UI. DIrekt im FireFox Browser klappt es und ich sehe die Buttons (und auch die Infos auf der Startseite), sowie die runterzählenden Sekunden, wenn ich den Button drücke.

Na da haben wir es doch! Hättest du mal gleich dazu sagen können das du diesen ominösen WebApp Modus nimmst! Sowas macht man ja auch nicht und das ist mal wieder so ne von M$ eklig eingeführte Unsitte die sich da breit macht. Finger weg davon in Zukunft kann ich nur raten.

Vielleicht kannst du aber mal testen, ob das UI bei dir auch nicht auftaucht, wenn du die Seite als App installierst (bei mir über den neuen Edge).

Ne danke, Windows fass ich nichtmal mit Handschuhen an