Lesekopf-probleme wegen udev-Bug

Homoran

@lukas-g sagte in Adapter "smartmeter":

Datenübertragung: Serielle Daten werden nur gelesen

und

@lukas-g sagte in Adapter "smartmeter":

Daten-Protokoll: D0 (WakeUp, SignOn, Data)

passt IMHO nicht zusammen

@lukas-g sagte in Adapter "smartmeter":

D0: Kommando SignOn-Nachricht: /?!

macht der Adapter schon! 2x macht Ärger

lukas.g

@homoran
Der Widerspruch von "nur lesen" und "WakeUp" war mir tatsächlich aufgefallen. Da keimte kurz Hoffnung auf, dass ich "nur" zu blöd bin.
Leider hat das keinen Einfluss.

Ich habe nun die smartmeter-Instanz nochmal weggeworfen und mit Standardwerten angefangen (für D0 und SML).
Dabei habe ich immer "Serielle Daten werden nur gelesen" und "Serielles Gerät mit bidir. Komm" probiert.
Letztlich nochmal die mutmaßlich vollständige Konfiguration:

Auch die vielleicht unnötige SignOn-Nachricht habe ich nochmal weggelassen.

Immer das gleiche Ergebnis: "No or too long answer from Serial Device after last request."

Zum Schluss noch ein Hinweis: Es kommt immer mal wieder vor, dass iobroker recht unvermittelt meldet, dass eine "Langsame Verbindung erkannt" wurde. Vielleicht hat das ja doch eine konkrete Bewandnis. Allerdings finde ich dazu nichts weiter konkretes in den Logs.

Homoran

@lukas-g sagte in Adapter "smartmeter":

Letztlich nochmal die mutmaßlich vollständige Konfiguration:

bitte nicht!

@lukas-g sagte in Adapter "smartmeter":

Auch die vielleicht unnötige SignOn-Nachricht habe ich nochmal weggelassen.

die darf da nicht stehen!

lass alles leer bis auf de USB Port.
wobei du da ggf. mit dem udev Bug zu kämpfen haben könntest
was steht im debug log beim Adapter start?

lukas.g

@homoran
Frische Instanz mit USB-Auswahl:

Debug Log:

2023-07-20 22:48:32.300 - info: host.rpi-lg2 iobroker add smartmeter 0 --host rpi-lg2 --debug
2023-07-20 22:48:49.549 - info: host.rpi-lg2 iobroker host.rpi-lg2 create instance smartmeter
2023-07-20 22:48:49.672 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.alive created
2023-07-20 22:48:49.742 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.connected created
2023-07-20 22:48:49.809 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.compactMode created
2023-07-20 22:48:49.885 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.cpu created
2023-07-20 22:48:49.949 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.cputime created
2023-07-20 22:48:50.007 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.memHeapUsed created
2023-07-20 22:48:50.082 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.memHeapTotal created
2023-07-20 22:48:50.143 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.memRss created
2023-07-20 22:48:50.206 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.uptime created
2023-07-20 22:48:50.277 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.inputCount created
2023-07-20 22:48:50.333 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.outputCount created
2023-07-20 22:48:50.463 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.eventLoopLag created
2023-07-20 22:48:50.559 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.sigKill created
2023-07-20 22:48:50.643 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0.logLevel created
2023-07-20 22:48:50.727 - info: host.rpi-lg2 iobroker host.rpi-lg2 object smartmeter.0.info created
2023-07-20 22:48:50.798 - info: host.rpi-lg2 iobroker host.rpi-lg2 object smartmeter.0.info.connection created
2023-07-20 22:48:50.832 - info: host.rpi-lg2 iobroker host.rpi-lg2 Set default value of smartmeter.0.info.connection: false
2023-07-20 22:48:50.935 - info: host.rpi-lg2 iobroker host.rpi-lg2 object system.adapter.smartmeter.0 created
2023-07-20 22:48:52.158 - info: host.rpi-lg2 iobroker exit 0
2023-07-20 22:48:54.569 - info: host.rpi-lg2 instance system.adapter.smartmeter.0 started with pid 2385
2023-07-20 22:48:55.329 - info: admin.0 (781) ==> Connected system.user.admin from ::ffff:192.168.100.202
2023-07-20 22:49:15.281 - info: smartmeter.0 (2385) starting. Version 3.3.4 in /opt/iobroker/node_modules/iobroker.smartmeter, node: v16.20.1, js-controller: 4.0.24
2023-07-20 22:49:15.488 - error: smartmeter.0 (2385) Serial port device is undefined, check your configuration!
2023-07-20 22:49:17.488 - info: smartmeter.0 (2385) List of port: [{"path":"/dev/ttyAMA0"},{"path":"/dev/ttyUSB0","manufacturer":"Silicon Labs","serialNumber":"0001","pnpId":"usb-Silicon_Labs_CP2102_USB_to_UART_Bridge_Controller_0001-if00-port0","vendorId":"10c4","productId":"ea60"}]
2023-07-20 22:50:48.066 - info: host.rpi-lg2 stopInstance system.adapter.smartmeter.0 (force=false, process=true)
2023-07-20 22:50:48.111 - info: smartmeter.0 (2385) Got terminate signal TERMINATE_YOURSELF
2023-07-20 22:50:48.185 - info: admin.0 (781) <== Disconnect system.user.admin from ::ffff:192.168.100.202
2023-07-20 22:50:48.141 - info: smartmeter.0 (2385) terminating
2023-07-20 22:50:48.170 - info: smartmeter.0 (2385) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2023-07-20 22:50:48.304 - info: host.rpi-lg2 stopInstance system.adapter.smartmeter.0 send kill signal
2023-07-20 22:50:48.964 - info: host.rpi-lg2 instance system.adapter.smartmeter.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2023-07-20 22:50:51.457 - info: host.rpi-lg2 instance system.adapter.smartmeter.0 started with pid 2401
2023-07-20 22:51:11.310 - info: smartmeter.0 (2401) starting. Version 3.3.4 in /opt/iobroker/node_modules/iobroker.smartmeter, node: v16.20.1, js-controller: 4.0.24
2023-07-20 22:51:17.340 - info: host.rpi-lg2 stopInstance system.adapter.smartmeter.0 (force=false, process=true)
2023-07-20 22:51:17.389 - info: smartmeter.0 (2401) Got terminate signal TERMINATE_YOURSELF
2023-07-20 22:51:17.447 - info: smartmeter.0 (2401) terminating
2023-07-20 22:51:17.479 - info: smartmeter.0 (2401) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2023-07-20 22:51:17.559 - info: host.rpi-lg2 stopInstance system.adapter.smartmeter.0 send kill signal
2023-07-20 22:51:18.307 - info: host.rpi-lg2 instance system.adapter.smartmeter.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2023-07-20 22:51:20.701 - info: host.rpi-lg2 instance system.adapter.smartmeter.0 started with pid 2416
2023-07-20 22:51:36.525 - debug: smartmeter.0 (2416) Redis Objects: Use Redis connection: 127.0.0.1:9001
2023-07-20 22:51:36.859 - debug: smartmeter.0 (2416) Objects client ready ... initialize now
2023-07-20 22:51:36.878 - debug: smartmeter.0 (2416) Objects create System PubSub Client
2023-07-20 22:51:36.889 - debug: smartmeter.0 (2416) Objects create User PubSub Client
2023-07-20 22:51:37.075 - debug: smartmeter.0 (2416) Objects client initialize lua scripts
2023-07-20 22:51:37.147 - debug: smartmeter.0 (2416) Objects connected to redis: 127.0.0.1:9001
2023-07-20 22:51:37.306 - debug: smartmeter.0 (2416) Redis States: Use Redis connection: 127.0.0.1:9000
2023-07-20 22:51:37.380 - debug: smartmeter.0 (2416) States create System PubSub Client
2023-07-20 22:51:37.391 - debug: smartmeter.0 (2416) States create User PubSub Client
2023-07-20 22:51:37.527 - debug: smartmeter.0 (2416) States connected to redis: 127.0.0.1:9000
2023-07-20 22:51:37.738 - debug: smartmeter.0 (2416) Plugin sentry Initialize Plugin (enabled=true)
2023-07-20 22:51:40.509 - info: smartmeter.0 (2416) starting. Version 3.3.4 in /opt/iobroker/node_modules/iobroker.smartmeter, node: v16.20.1, js-controller: 4.0.24
2023-07-20 22:51:40.708 - debug: smartmeter.0 (2416) SmartmeterObis options: {"debug":2,"protocol":"SmlProtocol","transport":"SerialResponseTransport","requestInterval":"300","anotherQueryDelay":"1000","transportSerialPort":"/dev/serial/by-id/usb-Silicon_Labs_CP2102_USB_to_UART_Bridge_Controller_0001-if00-port0","transportSerialBaudrate":null,"transportSerialMessageTimeout":null,"protocolSmlIgnoreInvalidCRC":false}
2023-07-20 22:51:40.727 - debug: smartmeter.0 (2416) CREATE SERIALPORT: 9600 8 1 none
2023-07-20 22:51:40.834 - debug: smartmeter.0 (2416) SERIALPORT OPEN
2023-07-20 22:51:40.985 - debug: smartmeter.0 (2416) SET MESSAGE TIMEOUT TIMER: 120000
2023-07-20 22:51:41.084 - debug: smartmeter.0 (2416) connected set to false
2023-07-20 22:53:40.992 - debug: smartmeter.0 (2416) MESSAGE TIMEOUT TRIGGERED
2023-07-20 22:53:41.002 - debug: smartmeter.0 (2416) Error: No or too long answer from Serial Device after last request.
2023-07-20 22:53:41.012 - warn: smartmeter.0 (2416) No or too long answer from Serial Device after last request.
2023-07-20 22:53:41.017 - debug: smartmeter.0 (2416) Error: No or too long answer from Serial Device after last request.
2023-07-20 22:53:41.022 - debug: smartmeter.0 (2416) Transport Reset!! Restart = true
2023-07-20 22:53:41.043 - debug: smartmeter.0 (2416) SERIALPORT CLOSE
2023-07-20 22:53:41.049 - debug: smartmeter.0 (2416) SCHEDULE NEXT RUN IN 300s
2023-07-20 22:58:41.052 - debug: smartmeter.0 (2416) CREATE SERIALPORT: 9600 8 1 none
2023-07-20 22:58:41.064 - debug: smartmeter.0 (2416) SERIALPORT OPEN
2023-07-20 22:58:41.082 - debug: smartmeter.0 (2416) SET MESSAGE TIMEOUT TIMER: 120000
2023-07-20 23:00:41.093 - debug: smartmeter.0 (2416) MESSAGE TIMEOUT TRIGGERED
2023-07-20 23:00:41.097 - debug: smartmeter.0 (2416) Error: No or too long answer from Serial Device after last request.
2023-07-20 23:00:41.101 - warn: smartmeter.0 (2416) No or too long answer from Serial Device after last request.
2023-07-20 23:00:41.103 - debug: smartmeter.0 (2416) Error: No or too long answer from Serial Device after last request.
2023-07-20 23:00:41.106 - debug: smartmeter.0 (2416) Transport Reset!! Restart = true
2023-07-20 23:00:41.114 - debug: smartmeter.0 (2416) SERIALPORT CLOSE
2023-07-20 23:00:41.118 - debug: smartmeter.0 (2416) SCHEDULE NEXT RUN IN 300s

@homoran said in Adapter "smartmeter":

wobei du da ggf. mit dem udev Bug zu kämpfen haben könntest

Verrate mir bitte, was Du mit "dem udev Bug" meinst.

Thomas Braun

@lukas-g

sudo apt update
apt policy udev

ausführen.

Homoran

@lukas-g sagte in Adapter "smartmeter":

Verrate mir bitte, was Du mit "dem udev Bug" meinst.

hat Thomas bereits gemacht. Jetzt bi ich gespannt, ob bei

@lukas-g sagte in Adapter "smartmeter":

SERIALPORT OPEN

trotzdem udev defekt sein kann

Thomas Braun

Irgendwas ist aber mit dem Port:

2023-07-20 22:49:15.488 - error: smartmeter.0 (2385) Serial port device is undefined, check your configuration!

Homoran

@thomas-braun wieso sehe ich das nicht. könnte passen!

Thomas Braun

@homoran sagte in Adapter "smartmeter":

wieso sehe ich das nicht. könnte passen!

lukas.g

@thomas-braun

lukas@rpi-lg2:~ $ sudo apt update
Get:1 http://raspbian.raspberrypi.org/raspbian bullseye InRelease [15.0 kB]
Get:2 http://archive.raspberrypi.org/debian bullseye InRelease [23.6 kB]
Get:3 http://raspbian.raspberrypi.org/raspbian bullseye/main armhf Packages [13.2 MB]
Get:4 http://archive.raspberrypi.org/debian bullseye/main armhf Packages [314 kB]
Fetched 13.6 MB in 36s (376 kB/s)
Reading package lists... Done
Building dependency tree... Done
Reading state information... Done
4 packages can be upgraded. Run 'apt list --upgradable' to see them.
lukas@rpi-lg2:~ $ sudo apt list --upgradable
Listing... Done
libcamera-apps-lite/stable 1.2.1-1 armhf [upgradable from: 0~git20230301+54a781d-1]
libcamera0/stable 0~git20230707+2783c8d8-1 armhf [upgradable from: 0~git20230302+923f5d70-1]
python3-libcamera/stable 0~git20230707+2783c8d8-1 armhf [upgradable from: 0~git20230302+923f5d70-1]
python3-picamera2/stable 0.3.12-1 all [upgradable from: 0.3.9-1]
lukas@rpi-lg2:~ $ apt policy udev
udev:
  Installed: 247.3-7+rpi1+deb11u2
  Candidate: 247.3-7+rpi1+deb11u2
  Version table:
 *** 247.3-7+rpi1+deb11u2 500
        500 http://raspbian.raspberrypi.org/raspbian bullseye/main armhf Packages
        100 /var/lib/dpkg/status

Thomas Braun

@lukas-g

Ja, das ist das kaputte udev.
Gibt einen Thread dazu von @mickym

tomasog

Hallo,
leider bekomme ich meinen Adapter nicht installiert.
Ich habe ein Landis+Gyr e350 und folgende Werte gemäß Volkszähler (https://wiki.volkszaehler.org/hardware/channels/meters/power/edl-ehz/landisgyr_e350) eingegeben:

Könnt Ihr mir bitte weiterhelfen?
Habe ich die Initialisierungssequenz richtig eingegeben?
Vielen Dank für Eure Hilfe!

Homoran

@tomasog sagte in Adapter "smartmeter":

Könnt Ihr mir bitte weiterhelfen?

Für dich gilt das selbe wie beim Fall unmittelbar davor!

@homoran sagte in Adapter "smartmeter":

Grundsätzlich erst mal alles auf default lassen!

@homoran sagte in Adapter "smartmeter":

lass alles leer bis auf de USB Port.
wobei du da ggf. mit dem udev Bug zu kämpfen haben könntest
was steht im debug log beim Adapter start?

lukas.g

@thomas-braun said in Adapter "smartmeter":

Ja, das ist das kaputte udev.

Sicher, dass es kaputt ist, auch wenn ls -la /dev/serial/by-id das Gerät wie erwartet anzeigt?

Thomas Braun

@lukas-g

Ja.
Installed: 247.3-7+rpi1+deb11u2
Ist die kaputte Version

@lukas-g sagte in Adapter "smartmeter":

Sicher, dass es kaputt ist,

Moin,

kannst Du mal schauen, ob er Dir Binär etwas auf der Konsole ausgibt?

sudo cat /dev/ttyUSB0

Hast Du schon mal den die ID des Sticks genutzt?

ls -la /dev/serial/by-id/

Durch Umstecken kann sich das /dev/ttyU* mal ändern, die ID bleibt aber immer gleich.
Ich hoffe, dass es bei den Hitch-USB auch so ist, wie bei den Zigbee Sticks, dass er da etwas unter /dev/serial/ anlegen.

VG
Bernd

P.S.: schon mal einen kompletten Reboot gemacht?

TT-Tom

@dp20eic sagte in Adapter "smartmeter":

Ich hoffe, dass es bei den Hitch-USB auch so ist, wie bei den Zigbee Sticks, dass er da etwas unter /dev/serial/ anlegen.

meiner macht das, sollte also funktionieren

Meister Mopper

v3.3.4, gelesen wird mit einem Hichi am Raspberry Pi 4

Schlagartig (21.07.2023,15:41 Uhr) werden keine Daten mehr geliefert und der Adapter kann sich nicht mehr mit dem Gerät verbinden.

Probeweise habe ich ohne Erfolg mal sentry ausgeschaltet, den Adapter gestoppt, den Hichi mal abgezogen und neu gesteckt => alles ohne Erfolg.

debug log beim Starten des Adapters:

smartmeter.0	2023-07-25 10:23:16.448	debug	Redis Objects: Use Redis connection: 192.168.178.10:9001
smartmeter.0	2023-07-25 10:23:16.508	debug	Objects client ready ... initialize now
smartmeter.0	2023-07-25 10:23:16.512	debug	Objects create System PubSub Client
smartmeter.0	2023-07-25 10:23:16.513	debug	Objects create User PubSub Client
smartmeter.0	2023-07-25 10:23:16.588	debug	Objects client initialize lua scripts
smartmeter.0	2023-07-25 10:23:16.597	debug	Objects connected to redis: 192.168.178.10:9001
smartmeter.0	2023-07-25 10:23:16.646	debug	Redis States: Use Redis connection: 192.168.178.10:6379
smartmeter.0	2023-07-25 10:23:16.657	debug	States create System PubSub Client
smartmeter.0	2023-07-25 10:23:16.659	debug	States create User PubSub Client
smartmeter.0	2023-07-25 10:23:16.673	debug	States connected to redis: 192.168.178.10:6379
smartmeter.0	2023-07-25 10:23:16.718	debug	Plugin sentry Initialize Plugin (enabled=true)
smartmeter.0	2023-07-25 10:23:17.078	info	starting. Version 3.3.4 in /opt/iobroker/node_modules/iobroker.smartmeter, node: v18.17.0, js-controller: 4.0.24
smartmeter.0	2023-07-25 10:23:17.120	debug	SmartmeterObis options: {"debug":2,"protocol":"SmlProtocol","transport":"SerialResponseTransport","requestInterval":"10","anotherQueryDelay":"1000","transportSerialPort":"/dev/serial/by-id/usb-1a86_USB_Serial-if00-port0","transportSerialBaudrate":null,"transportSerialMessageTimeout":null,"protocolSmlIgnoreInvalidCRC":false}
smartmeter.0	2023-07-25 10:23:17.124	debug	CREATE SERIALPORT: 9600 8 1 none
smartmeter.0	2023-07-25 10:23:17.133	debug	SET MESSAGE TIMEOUT TIMER: 120000
smartmeter.0	2023-07-25 10:23:17.155	debug	connected set to false

Der Zähler ist ein Itron, neu installiert im März 2022.

Ich habe hier gelesen, dass die LED der Zähler schnell altersschwach werden und nicht mehr ausgelesen werden können. Kann das sein?

Homoran

@meister-mopper sagte in Adapter "smartmeter":

Kann das sein?

ja.
Alternativ kann auch der Lesekopf defekt sein

Gemacht hast du nichts?
Stromausfall war auch nicht?

auch nicht eine Sekunde?

Meister Mopper

@homoran sagte in Adapter "smartmeter":

Stromausfall war auch nicht?

auch nicht eine Sekunde?

Nein, nein, das hätte mir die USV gemeldet. Ach ja, ich habe natürlich auch nachgesehen, ob der PIN noch drin war, habe ihn sogar deaktiviert und neu eingegeben.

Edit:

Am Donnerstag kommt ein Mitarbeiter des Netzbetreibers und schaut sich den Zähler an.
Einen neuen Hichi habe ich sicherheitshalber auch bestellt.

NEWS

Lesekopf-probleme wegen udev-Bug

Support us

977
Online

31.7k
Users

79.6k
Topics

1.3m
Posts

NEWS

Lesekopf-probleme wegen udev-Bug

Support us

977Online

31.7kUsers

79.6kTopics

1.3mPosts

977
Online

31.7k
Users

79.6k
Topics

1.3m
Posts