Closed Ice81 closed 4 years ago
Wie ist die Titelleiste der Fehlermeldung? Was für Geräte werden angelernt? Wurde ein Backup eingespielt oder ist das ein "jungfräuliches" System?
Es ist ein jungfräuliches System auf piVCCU gesehen. Es ist schon FHEM drauf und ein aktuell deaktiviertes Iobroker. Die Titelleiste lautet: HMIP-RF und Virtualdevices,
Bitte einmal neu starten, 10 Minuten warten und dann die Ausgabe von sudo pivccu-attach cat /var/log/messages
und sudo pivccu-attach cat /var/log/hmserver.log
posten.
Kein Problem. Vielen Dank schonmal
sudo pivccu-attach cat /var/log/messages:
pi@raspberrypi:~ $ sudo pivccu-attach cat /var/log/messages
Oct 13 17:36:01 homematic-ccu2 syslog.info syslogd started: BusyBox v1.20.2
Oct 13 17:36:01 homematic-ccu2 user.notice kernel: klogd started: BusyBox v1.20.2 (2019-09-23 15:46:22 CEST)
Oct 13 19:36:01 homematic-ccu2 syslog.info syslogd started: BusyBox v1.20.2
Oct 13 19:36:01 homematic-ccu2 user.notice kernel: klogd started: BusyBox v1.20.2 (2019-09-23 15:46:22 CEST)
Oct 13 17:36:02 homematic-ccu2 daemon.info ifplugd(eth0)[185]: ifplugd 0.28 initializing.
Oct 13 17:36:02 homematic-ccu2 daemon.info ifplugd(eth0)[185]: Using interface eth0/4A:5C:2D:49:EF:3E with driver
sudo pivccu-attach cat /var/log/hmserver.log:
pi@raspberrypi:~ $ sudo pivccu-attach cat /var/log/hmserver.log
Oct 13 19:36:25 de.eq3.lib.util.dynamics.GenericFactory INFO [main] @GenericFactory
Oct 13 19:36:25 de.eq3.lib.util.dynamics.GenericFactory INFO [main] creating instance of HMServerConfiguration with no-arg constructor
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [HMIPTRXWriterWorker] (1) worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [KeyServerWorker] (1) worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [KryoPersistenceWorker] (1) worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [TransactionSubsystemHandler] (1) worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [FirmwareLoaderFileSystem] (1) worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [LocalServerPersistentDataLoader] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [LocalServerAdapterInitialization] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [BackendCommandHandler] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [DeviceInclusionAcceptHandler] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [CheckDeviceExistHandler] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [IncomingHMIPFrameHandler] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [DeviceBackgroundUpdateSubsystem] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [DeviceLiveUpdateSubsystem] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [DeviceInclusionDefaultConfigurationChanger] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [CyclicSmokeDetectorAwakening] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [AccessPointElectroCardioGram] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [LocalServerFirmwareUpdateInitialization] (1)
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [LegacyNotificationHandler] (1) worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [LegacyAPIWorker] (1) worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [LegacyBackendNotificationHandler] (3) worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [LegacyBlindLevelCorrectionHandler] (1) *worker
Oct 13 19:36:39 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: added for deployment [LegacyInitializion] (1)
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: deploying 22 classes to Vert.x
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [Thread-0] SYSTEM: 22 VertxDeployers initialized
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-6] SYSTEM: start of AccessPointElectroCardioGram succeeded (30f37e2d-0762-45dc-9867-55bc734109a6)
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-7] SYSTEM: start of HMIPTRXWriterWorker succeeded (3f5b18ec-4db5-43ad-9535-3b9e64861424)
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-4] SYSTEM: start of DeviceInclusionDefaultConfigurationChanger succeeded (f7fdeb11-d2cd-4584-8887-756ce5a53a5f)
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-7] SYSTEM: start of TransactionSubsystemHandler succeeded (b201be4d-fa9c-41b8-ba37-e41cc224b4f6)
Oct 13 19:36:40 de.eq3.cbcs.server.core.vertx.KeyServerWorker ERROR [vert.x-worker-thread-3] Missing key server configuration parameter (Network.Key) for mode: KEYSERVER_LOCAL
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-0] SYSTEM: start of CheckDeviceExistHandler succeeded (4ab4ef15-082c-4673-9af4-077df1db44ff)
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-3] SYSTEM: start of CyclicSmokeDetectorAwakening succeeded (7b356321-a805-4268-a3ec-9660a294ef4e)
Oct 13 19:36:40 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-3] SYSTEM: start of KeyServerWorker succeeded (3a608312-20a2-4359-b119-c5f6950de6bf)
Oct 13 19:36:43 de.eq3.cbcs.server.core.live_otau.DeviceLiveUpdateSubsystem INFO [vert.x-eventloop-thread-2] SYSTEM: DeviceLiveUpdateSubsystem started
Oct 13 19:36:43 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-0] SYSTEM: start of DeviceLiveUpdateSubsystem succeeded (5aee9f76-3b46-4ab1-962c-b83f29ac5265)
Oct 13 19:36:43 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-2] SYSTEM: start of LegacyBlindLevelCorrectionHandler succeeded (fd72b033-c7f0-4852-9d19-cd472995341c)
Oct 13 19:36:43 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-2] SYSTEM: start of KryoPersistenceWorker succeeded (1d254910-a604-4e91-820c-184651539541)
Oct 13 19:36:43 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-7] SYSTEM: start of DeviceBackgroundUpdateSubsystem succeeded (f282fa6b-16dc-4834-8c05-aba73821f9f2)
Oct 13 19:36:43 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-4] SYSTEM: start of LocalServerPersistentDataLoader succeeded (595dacce-b812-4073-b7b3-638c665894b1)
Oct 13 19:36:44 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-7] SYSTEM: start of DeviceInclusionAcceptHandler succeeded (909176ea-a839-490f-95cf-d187c457c61b)
Oct 13 19:36:44 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-0] SYSTEM: start of IncomingHMIPFrameHandler succeeded (a6166ff3-89fe-4d47-812b-e3253fda1b95)
Oct 13 19:36:44 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO [vert.x-worker-thread-2] SYSTEM: Firmware update directory is set to /etc/config/firmware
Oct 13 19:36:44 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-3] SYSTEM: start of FirmwareLoaderFileSystem succeeded (0b742047-73e4-461a-9f5d-3c6a5911647a)
Oct 13 19:36:44 de.eq3.cbcs.vertx.management.VertxManager INFO [vert.x-eventloop-thread-4] SYSTEM: start of BackendCommandHandler succeeded (2a25e332-1f50-4fd7-a6e6-7b6db7b28496)
Oct 13 19:36:45 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization ERROR [vert.x-eventloop-thread-0] Error 'LOCAL_ADAPTER_NO_SUCH_PORT' while trying to open port '/dev/ttyS0':
de.eq3.cbcs.lib.commdevice.CommDeviceException: Exception while trying to open serial port. Check configured port '/dev/ttyS0'
at de.eq3.cbcs.lib.nrjavaserialdevice.SerialCommDevice.open(SerialCommDevice.java:105)
at de.eq3.cbcs.lib.hmiptrxcommadapter.HomeMaticIPTRXCommAdapter.open(HomeMaticIPTRXCommAdapter.java:726)
at de.eq3.cbcs.lib.hmiptrxcommadapter.HomeMaticIPTRXCommAdapter.
Ich habe es jetzt gerade geschafft einen normalen Homematic Aktor mit der CCU zu verbinden.
Bitte einmal die Ausgabe von sudo pivccu-attach cat /etc/crRFD.conf
pi@raspberrypi:~ $ sudo pivccu-attach cat /etc/crRFD.conf
Adapter.1.Type=HMIP_CCU2 Adapter.1.Port=/dev/ttyS0
Config.Dir=/etc/config/crRFD Config.Include=hmip_user.conf
Persistence.Home=/etc/config/crRFD/data FirmwareUpdate.BG.OTAU.Home=/etc/config/firmware FirmwareUpdate.BG.OTAU.divergent.device.type.definition.file=/opt/HmIP/crrfd.fwfix
API.1.Type=XML-RPC Legacy.Encoding=ISO-8859-1 Legacy.ResponseTimeout=20 Legacy.ReplacementURL=127.0.0.1 Legacy.Parameter.Definition.File=/opt/HmIP/legacy-parameter-definition.config
Legacy.AddressPrefix=3014F711A0 Legacy.SwitchTypeAndSubtype=true Legacy.HandlersFilename=/var/LegacyService.handlers Legacy.DiscardDutyCycleEvents=true Legacy.SendUDPServiceMessages=true Legacy.VirtualRemoteControl.Enabled=true Legacy.CallDeleteDevicesForChangedDevices=false Legacy.Client.Connection.Timeout=300000 Legacy.Client.Socket.Timeout=300000
CyclicTimeout.TimerStartMaxDelay=90 CyclicTimeout.TimerCycleTime=600 Legacy.Parameter.ReplaceEnumValueWithOrdinal=true
KeyServer.Mode=KEYSERVER_LOCAL KeyServer.Gateway.URL=secgtw.homematic.com Vertx.WorkerPoolSize=5
Ich kann in den Ausgaben leider keine Ursache für das Problem erkennen. Allerdings loggt der HmIP-Server teilweise auch nicht wirklich zielführend und da ich keinen Zugriff auf den Sourcecode habe, ist das teilweise Stochern im Nebel. Aber andere Frage: Warum für eine Neuinstallation piVCCU2 und nicht gleich piVCCU3?
Ähm, weil Ich davon ausgegangen bin das das HM-MOD-RPI-PCB maximal eine CCU2 emulieren kann. Sonst update Ich gerne.
Nein, das läuft auch wunderbar mit piVCCU3.
Ok, versuche gerade es upzudaten, kam gerade dieser Fehler: pivccu3 (3.47.15-30) wird eingerichtet ... Neue Version der Konfigurationsdatei /lib/systemd/system/pivccu.service wird ins talliert ... /var/lib/piVCCU3/detect_hardware.inc: Zeile 59: /sys/class/raw-uart/raw-uart/res et_radio_module: Keine Berechtigung dpkg: Fehler beim Bearbeiten des Paketes pivccu3 (--configure): Unterprozess installiertes post-installation-Skript gab den Fehlerwert 1 zur▒ck Fehler traten auf beim Bearbeiten von: pivccu3
Das klingt nach alten Kernel Modulen. Wie wurden diese installiert? War mal YAHM auf dem System installiert?
Ja, das hatte Ich auch mal probiert
YAHM hängt sich leider extrem tief in das System und verhindert recht penetrant die Aktualisierung der Kernel Module. Ein Versuch:
sudo apt-mark unhold raspberrypi-kernel
sudo apt update
sudo apt upgrade
sudo apt install --reinstall raspberrypi-kernel
sudo dpkg-reconfigure pivccu-modules-dkms
sudo reboot
Und dabei bitte auch beachten, dass mind. Raspbian Stretch installiert ist (auch der Kernel)
P.S. Jungfräuliches System definiere ich da etwas anders...
Wie gesagt auf piVCCU gesehen
Ich habe es hinbekommen, das Problem war der veraltete Kernel. Kernel update und es ließ sich problemlos installieren. Es hat gleich auf anhieb geklappt HMIP und die normalen HM anzulernen. Vielen Vielen dank für die Unterstützung
Hallo, Ich habe das piVCCU erfolgreich installieren können, doch leider bekomme Ich keine Verbindung zu meinen Homematicgeräten. Wenn Ich unter der Webobfläche es probiere, läuft der Timer runter und zwischendurch kommt folgende Fehlermeldung:
unter SSH sieht es alles richtig aus: pi@raspberrypi:~ $ sudo pivccu-info piVCCU version: 2.47.20-55 Kernel modules: Available Raw UART dev: Available HMRF Hardware: HM-MOD-RPI-PCB HMIP Hardware: HM-MOD-RPI-PCB Board serial: NEQ1332157 Radio MAC: 0x4f603e SGTIN: 3014F711A061A7D5699DBBBD State: RUNNING PID: 1039 IP: 192.168.178.6 IP: 2a02:8109:1880:12ba:485c:2dff:fe49:ef3e CPU use: 64.57 seconds BlkIO use: 32.79 MiB Memory use: 97.26 MiB KMem use: 2.75 MiB Link: vethpivccu TX bytes: 1.18 MiB RX bytes: 1.23 MiB Total bytes: 2.40 MiB
Weiß jemand evtl. rat ? Vielen Dank im voraus Gruß Ralf