Jahresrückblick 2025 – unser neuer Blogbeitrag ist online! ✨

[onki2]

Hallo zusammen,

ich habe ein Problem mit dem Modbus Adapter, und zwar funktioniert alles bestens, bis nach ein paar Stunden immer häufiger Fehler auftreten. Das Problem setzt sich fort, bis der Adapter neu startet, und dann funktioniert es wieder für einige Stunden.

Ich hab den IOBroker auf Windows 10 am laufen, der Modbus Adapter ist aktuell 3.2.2.

Folgend der log vom Start der Adapter Instanz:

2020-12-26 20:07:14.650  - info: host.Win10Server(IOBrokerDahoim) instance system.adapter.modbus.0 started with pid 9564
2020-12-26 20:07:15.515  - debug: modbus.0 (9564) Redis Objects: Use Redis connection: 127.0.0.1:9001
2020-12-26 20:07:15.565  - debug: modbus.0 (9564) Objects client ready ... initialize now
2020-12-26 20:07:15.570  - debug: modbus.0 (9564) Objects create System PubSub Client
2020-12-26 20:07:15.572  - debug: modbus.0 (9564) Objects create User PubSub Client
2020-12-26 20:07:15.577  - debug: modbus.0 (9564) Objects client initialize lua scripts
2020-12-26 20:07:15.591  - debug: modbus.0 (9564) Objects connected to redis: 127.0.0.1:9001
2020-12-26 20:07:15.600  - debug: modbus.0 (9564) objectDB connected
2020-12-26 20:07:15.602  - debug: modbus.0 (9564) Redis States: Use Redis connection: 127.0.0.1:9000
2020-12-26 20:07:15.674  - debug: modbus.0 (9564) States create User PubSub Client
2020-12-26 20:07:15.677  - debug: modbus.0 (9564) States create System PubSub Client
2020-12-26 20:07:15.796  - debug: modbus.0 (9564) States connected to redis: 127.0.0.1:9000
2020-12-26 20:07:15.797  - debug: modbus.0 (9564) statesDB connected
2020-12-26 20:07:17.151  - debug: modbus.0 (9564) Plugin sentry Initialize Plugin (enabled=true)
2020-12-26 20:07:17.504  - info: modbus.0 (9564) starting. Version 3.2.2 in C:/Program Files/iobroker/IOBrokerDahoim/node_modules/iobroker.modbus, node: v12.20.0, js-controller: 3.1.6
2020-12-26 20:07:18.058  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-26 20:07:18.080  - info: modbus.0 (9564) Connected to slave
2020-12-26 20:07:18.081  - debug: modbus.0 (9564) Poll device 40
2020-12-26 20:07:18.083  - debug: modbus.0 (9564) Initialization of scale factors done!
2020-12-26 20:07:18.084  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-26 20:07:18.137  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-26 20:07:18.182  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-26 20:07:18.215  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-26 20:07:20.299  - debug: modbus.0 (9564) Poll device 40
2020-12-26 20:07:20.300  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-26 20:07:20.339  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-26 20:07:20.387  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-26 20:07:20.419  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes

das ganze läuft dann über Stunden stabil, bis die Probleme los gehen:

2020-12-27 02:38:35.730  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:38:35.730  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:38:35.780  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:38:35.828  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:38:35.860  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 02:38:37.997  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:38:37.997  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:38:38.080  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:38:43.088  - warn: modbus.0 (9564) Error: undefined
2020-12-27 02:38:43.089  - error: modbus.0 (9564) Request timed out.
2020-12-27 02:38:43.090  - warn: modbus.0 (9564) Poll error count: 1 code: {"err":"timeout","timeout":5000}
2020-12-27 02:38:44.094  - info: modbus.0 (9564) Disconnected from slave
2020-12-27 02:38:44.215  - debug: modbus.0 (9564) Clearing timeout of the current request.
2020-12-27 02:38:44.216  - debug: modbus.0 (9564) Cleaning up request fifo.
2020-12-27 02:38:45.102  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:38:45.102  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:39:44.108  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-27 02:39:44.124  - info: modbus.0 (9564) Connected to slave
2020-12-27 02:39:44.124  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:39:44.125  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:39:44.184  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:39:44.231  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:39:44.280  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:39:44.328  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:39:44.447  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 02:39:44.595  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 02:39:46.802  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:39:46.802  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:39:46.937  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:39:46.991  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:39:52.002  - warn: modbus.0 (9564) Error: undefined
2020-12-27 02:39:52.002  - error: modbus.0 (9564) Request timed out.
2020-12-27 02:39:52.002  - warn: modbus.0 (9564) Poll error count: 1 code: {"err":"timeout","timeout":5000}
2020-12-27 02:39:53.002  - info: modbus.0 (9564) Disconnected from slave
2020-12-27 02:39:53.112  - debug: modbus.0 (9564) Clearing timeout of the current request.
2020-12-27 02:39:53.112  - debug: modbus.0 (9564) Cleaning up request fifo.
2020-12-27 02:39:54.018  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:39:54.018  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:40:53.014  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-27 02:40:53.033  - info: modbus.0 (9564) Connected to slave
2020-12-27 02:40:53.034  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:40:53.034  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:40:53.096  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:40:53.159  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:40:53.225  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:40:53.289  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:40:53.378  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 02:40:53.431  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 02:40:55.821  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:40:55.827  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:41:00.829  - warn: modbus.0 (9564) Error: undefined
2020-12-27 02:41:00.830  - error: modbus.0 (9564) Request timed out.
2020-12-27 02:41:00.830  - warn: modbus.0 (9564) Poll error count: 1 code: {"err":"timeout","timeout":5000}
2020-12-27 02:41:01.832  - info: modbus.0 (9564) Disconnected from slave
2020-12-27 02:41:01.942  - debug: modbus.0 (9564) Clearing timeout of the current request.
2020-12-27 02:41:01.942  - debug: modbus.0 (9564) Cleaning up request fifo.
2020-12-27 02:41:02.848  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:41:02.848  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:42:01.845  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-27 02:42:01.865  - info: modbus.0 (9564) Connected to slave
2020-12-27 02:42:01.865  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:42:01.866  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:42:01.911  - error: modbus.0 (9564) Wrong CRC for frame: 40,4,12,9,42,0,0,9,28,0,0,9,29,0,0,100,40
2020-12-27 02:42:01.926  - error: modbus.0 (9564) unknown function code: 0
2020-12-27 02:42:06.914  - warn: modbus.0 (9564) Error: undefined
2020-12-27 02:42:06.914  - error: modbus.0 (9564) Request timed out.
2020-12-27 02:42:07.086  - warn: modbus.0 (9564) Poll error count: 2 code: "App Timeout"
2020-12-27 02:42:07.915  - info: modbus.0 (9564) Disconnected from slave
2020-12-27 02:42:08.024  - debug: modbus.0 (9564) Clearing timeout of the current request.
2020-12-27 02:42:08.024  - debug: modbus.0 (9564) Cleaning up request fifo.
2020-12-27 02:42:09.135  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:42:09.135  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:43:07.920  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-27 02:43:07.939  - info: modbus.0 (9564) Connected to slave
2020-12-27 02:43:07.939  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:43:07.939  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:43:08.019  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:43:08.097  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:43:08.177  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:43:08.257  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:43:08.321  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 02:43:08.385  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 02:43:10.650  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:43:10.651  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:43:10.733  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:43:10.813  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:43:10.877  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 02:43:13.033  - debug: modbus.0 (9564) Poll device 40
2020-12-27 02:43:13.033  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 02:43:13.113  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 02:43:13.193  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 02:43:13.256  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 274 - 6 bytes

Teilweise fängt es sich dann wieder, aber irgendwann startet die Instanz neu:

2020-12-27 04:00:30.072  - warn: modbus.0 (9564) Error: undefined
2020-12-27 04:00:30.072  - error: modbus.0 (9564) Request timed out.
2020-12-27 04:00:30.072  - warn: modbus.0 (9564) Poll error count: 9 code: {"err":"timeout","timeout":5000}
2020-12-27 04:00:31.075  - info: modbus.0 (9564) Disconnected from slave
2020-12-27 04:00:31.184  - debug: modbus.0 (9564) Clearing timeout of the current request.
2020-12-27 04:00:31.184  - debug: modbus.0 (9564) Cleaning up request fifo.
2020-12-27 04:01:31.102  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-27 04:01:31.116  - info: modbus.0 (9564) Connected to slave
2020-12-27 04:01:31.117  - debug: modbus.0 (9564) Poll device 40
2020-12-27 04:01:31.117  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 04:01:36.132  - warn: modbus.0 (9564) Error: undefined
2020-12-27 04:01:36.132  - error: modbus.0 (9564) Request timed out.
2020-12-27 04:01:36.132  - warn: modbus.0 (9564) Poll error count: 10 code: {"err":"timeout","timeout":5000}
2020-12-27 04:01:37.158  - info: modbus.0 (9564) Disconnected from slave
2020-12-27 04:01:37.428  - debug: modbus.0 (9564) Clearing timeout of the current request.
2020-12-27 04:01:37.429  - debug: modbus.0 (9564) Cleaning up request fifo.
2020-12-27 04:02:37.185  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-27 04:02:37.222  - info: modbus.0 (9564) Connected to slave
2020-12-27 04:02:37.222  - debug: modbus.0 (9564) Poll device 40
2020-12-27 04:02:37.223  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 04:02:42.225  - warn: modbus.0 (9564) Error: undefined
2020-12-27 04:02:42.226  - error: modbus.0 (9564) Request timed out.
2020-12-27 04:02:42.226  - warn: modbus.0 (9564) Poll error count: 11 code: {"err":"timeout","timeout":5000}
2020-12-27 04:02:43.227  - info: modbus.0 (9564) Disconnected from slave
2020-12-27 04:02:43.337  - debug: modbus.0 (9564) Clearing timeout of the current request.
2020-12-27 04:02:43.337  - debug: modbus.0 (9564) Cleaning up request fifo.
2020-12-27 04:03:43.237  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-27 04:03:43.243  - info: modbus.0 (9564) Connected to slave
2020-12-27 04:03:43.244  - debug: modbus.0 (9564) Poll device 40
2020-12-27 04:03:43.244  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 04:03:48.275  - warn: modbus.0 (9564) Error: undefined
2020-12-27 04:03:48.282  - error: modbus.0 (9564) Request timed out.
2020-12-27 04:03:48.282  - warn: modbus.0 (9564) Poll error count: 12 code: {"err":"timeout","timeout":5000}
2020-12-27 04:03:49.291  - info: modbus.0 (9564) Disconnected from slave
2020-12-27 04:03:49.401  - debug: modbus.0 (9564) Clearing timeout of the current request.
2020-12-27 04:03:49.401  - debug: modbus.0 (9564) Cleaning up request fifo.
2020-12-27 04:04:49.296  - debug: modbus.0 (9564) connect to serial COM4 with 9600
2020-12-27 04:04:49.312  - info: modbus.0 (9564) Connected to slave
2020-12-27 04:04:49.313  - debug: modbus.0 (9564) Poll device 40
2020-12-27 04:04:49.313  - debug: modbus.0 (9564) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 04:04:54.329  - warn: modbus.0 (9564) Error: undefined
2020-12-27 04:04:54.330  - error: modbus.0 (9564) Request timed out.
2020-12-27 04:04:54.330  - warn: modbus.0 (9564) Poll error count: 13 code: {"err":"timeout","timeout":5000}
2020-12-27 04:04:54.331  - error: modbus.0 (9564) Reconnect did not help, restart adapter
2020-12-27 04:04:54.332  - debug: modbus.0 (9564) Plugin sentry destroyed
2020-12-27 04:04:54.333  - info: modbus.0 (9564) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason
2020-12-27 04:04:55.007  - info: host.Win10Server(IOBrokerDahoim) instance system.adapter.modbus.0 terminated with code 156 (START_IMMEDIATELY_AFTER_STOP)
2020-12-27 04:04:55.014  - info: host.Win10Server(IOBrokerDahoim) Restart adapter system.adapter.modbus.0 because enabled
2020-12-27 04:04:56.047  - info: host.Win10Server(IOBrokerDahoim) instance system.adapter.modbus.0 started with pid 7300
2020-12-27 04:04:57.668  - debug: modbus.0 (7300) Redis Objects: Use Redis connection: 127.0.0.1:9001
2020-12-27 04:04:57.759  - debug: modbus.0 (7300) Objects client ready ... initialize now
2020-12-27 04:04:57.765  - debug: modbus.0 (7300) Objects create System PubSub Client
2020-12-27 04:04:57.766  - debug: modbus.0 (7300) Objects create User PubSub Client
2020-12-27 04:04:57.774  - debug: modbus.0 (7300) Objects client initialize lua scripts
2020-12-27 04:04:57.787  - debug: modbus.0 (7300) Objects connected to redis: 127.0.0.1:9001
2020-12-27 04:04:57.797  - debug: modbus.0 (7300) objectDB connected
2020-12-27 04:04:57.801  - debug: modbus.0 (7300) Redis States: Use Redis connection: 127.0.0.1:9000
2020-12-27 04:04:57.870  - debug: modbus.0 (7300) States create User PubSub Client
2020-12-27 04:04:57.873  - debug: modbus.0 (7300) States create System PubSub Client
2020-12-27 04:04:57.995  - debug: modbus.0 (7300) States connected to redis: 127.0.0.1:9000
2020-12-27 04:04:57.995  - debug: modbus.0 (7300) statesDB connected
2020-12-27 04:04:58.647  - debug: modbus.0 (7300) Plugin sentry Initialize Plugin (enabled=true)
2020-12-27 04:04:58.979  - info: modbus.0 (7300) starting. Version 3.2.2 in C:/Program Files/iobroker/IOBrokerDahoim/node_modules/iobroker.modbus, node: v12.20.0, js-controller: 3.1.6
2020-12-27 04:05:00.173  - debug: modbus.0 (7300) connect to serial COM4 with 9600
2020-12-27 04:05:00.186  - info: modbus.0 (7300) Connected to slave
2020-12-27 04:05:00.187  - debug: modbus.0 (7300) Poll device 40
2020-12-27 04:05:00.188  - debug: modbus.0 (7300) Initialization of scale factors done!
2020-12-27 04:05:00.188  - debug: modbus.0 (7300) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 04:05:00.248  - debug: modbus.0 (7300) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 04:05:00.298  - debug: modbus.0 (7300) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 04:05:00.342  - debug: modbus.0 (7300) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 04:05:02.410  - debug: modbus.0 (7300) Poll device 40
2020-12-27 04:05:02.411  - debug: modbus.0 (7300) Poll inputRegs DevID(40) address 0 - 6 bytes
2020-12-27 04:05:02.450  - debug: modbus.0 (7300) Poll inputRegs DevID(40) address 18 - 6 bytes
2020-12-27 04:05:02.499  - debug: modbus.0 (7300) Poll inputRegs DevID(40) address 40 - 2 bytes
2020-12-27 04:05:02.531  - debug: modbus.0 (7300) Poll inputRegs DevID(40) address 274 - 6 bytes
2020-12-27 04:05:04.587  - debug: modbus.0 (7300) Poll device 40

ich hab auch schon mit den Einstellungen gespielt, aber das Verhalten ist immer das selbe. Aktuell habe ich folgende Settings:

Und folgende Register frage ich ab:

Falls jemand eine Idee hat, wäre ich für jeden Tipp dankbar.

Mfg Stefan

[onki2]

Hallo,

Ich wollte mich nur noch mal kurz zurück melden, das Problem scheint nicht am IOBroker oder Modbus Adapter zu liegen, es scheint als ob die Messgeräte die ich verwende etwas "Zickig" sind.
Wenn ich auf Modbus TCP und einen Ethernet --> RS486 Adapter wechsle verhält es sich besser, dann hab ich nur noch 1-2 Fehler pro Tag, damit kann ich erst mal leben.

Wenn ich ein Anderes Modbus Gerät im Serial Mode betreibe funktioniert es auch.

Mfg Stefan

[Glasfaser]

@onki2 sagte in Modbus Serial: Plötzlich Fehler nach fehlerfreier Laufzeit:

Spiele mal mit dem Wert Poll delay , würde ihn mal auf 5000 setzen .