Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Moderator: Co-Administratoren
Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Hallo zusammen,
ich nutze seit einigen Wochen Debmatic auf Debian auf einer VM (Proxmox). Am Anfang lief das System einwandfrei ohne Ausfälle.
Seitdem ich das HB-RF-USB-TK mit dem neuen Funkmodul verwende, habe ich jedoch enorme Stabilitätsprobleme.
Das System läuft erstmal grundsätzlich normal, bis irgendwann aus unerklärlichen Gründen die BidCOS Meldung (Eine Komponente oder Gerät reagiert nicht mehr...) erscheint und in der Web-UI alle Geräte verschwunden sind bzw. sich nichts mehr steuern lässt.
Das ganze lässt sich dann mit einem Neustart der ganzen VM beheben und dann läuft alles wieder normal.
Neben dem HB-RF-USB-TK nutze ich noch 2 weitere LAN-Gateways. Das System schafft es keine 3 Tage. Meist ist nach ca. 1 oder 2 Tagen Schluss.
Der Duty Cycle ist dabei insgesamt bei allerhöchstens 20%. Alles ist auch auf dem neuesten Stand.
Ich habe bereits versucht, alles auf einer separaten, neuen VM zu installieren und nur ein Backup von Debmatic (über die UI erstellt) zu importieren.
Außerdem habe ich mittlerweile das HB-RF-USB-TK an einem atkiven USB-Port hängen, was leider auch keine Besserung brachte.
Das Leeren des Caches per Cronjob habe ich testweise auch deaktiviert, bringt aber auch keine Besserung.
Das Logfile habe ich am Anhang beigefügt. Ich selbst kann die Einträge aber leider nicht korrekt deuten.
Kann jemand anhand den Einträgen dort das Problem eingrenzen bzw. erkennen?
Vielen Dank für Eure Hilfe.
Frank
ich nutze seit einigen Wochen Debmatic auf Debian auf einer VM (Proxmox). Am Anfang lief das System einwandfrei ohne Ausfälle.
Seitdem ich das HB-RF-USB-TK mit dem neuen Funkmodul verwende, habe ich jedoch enorme Stabilitätsprobleme.
Das System läuft erstmal grundsätzlich normal, bis irgendwann aus unerklärlichen Gründen die BidCOS Meldung (Eine Komponente oder Gerät reagiert nicht mehr...) erscheint und in der Web-UI alle Geräte verschwunden sind bzw. sich nichts mehr steuern lässt.
Das ganze lässt sich dann mit einem Neustart der ganzen VM beheben und dann läuft alles wieder normal.
Neben dem HB-RF-USB-TK nutze ich noch 2 weitere LAN-Gateways. Das System schafft es keine 3 Tage. Meist ist nach ca. 1 oder 2 Tagen Schluss.
Der Duty Cycle ist dabei insgesamt bei allerhöchstens 20%. Alles ist auch auf dem neuesten Stand.
Ich habe bereits versucht, alles auf einer separaten, neuen VM zu installieren und nur ein Backup von Debmatic (über die UI erstellt) zu importieren.
Außerdem habe ich mittlerweile das HB-RF-USB-TK an einem atkiven USB-Port hängen, was leider auch keine Besserung brachte.
Das Leeren des Caches per Cronjob habe ich testweise auch deaktiviert, bringt aber auch keine Besserung.
Das Logfile habe ich am Anhang beigefügt. Ich selbst kann die Einträge aber leider nicht korrekt deuten.
Kann jemand anhand den Einträgen dort das Problem eingrenzen bzw. erkennen?
Vielen Dank für Eure Hilfe.
Frank
- Dateianhänge
-
- logfile.txt
- (1.02 MiB) 67-mal heruntergeladen
- 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: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Hi,
rein Anhand des Logs lässt sich leider nichts sagen. Ich sehe, dass da einige Male der HmServer neu gestartet wurde, aber aus dem Log lässt sich nicht erkennen, ob das von alleine passiert ist oder ob das die angesprochenen Restarts waren.
Interessant wäre es, wenn du bei einem Ausfall vor dem Neustart mal einige Daten ausließt:
Was ist eigentlich ein aktiver USB Port? Meinst du einen aktiven USB Hub?
Viele Grüße
Alex
rein Anhand des Logs lässt sich leider nichts sagen. Ich sehe, dass da einige Male der HmServer neu gestartet wurde, aber aus dem Log lässt sich nicht erkennen, ob das von alleine passiert ist oder ob das die angesprochenen Restarts waren.
Interessant wäre es, wenn du bei einem Ausfall vor dem Neustart mal einige Daten ausließt:
Code: Alles auswählen
lsusb
dmesg | tail -100
ps aux
tail -100 /var/log/syslog
systemctl status debmatic-rfd
Viele Grüße
Alex
Re: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Hallo Alex,
vielen Dank für Deine Hilfe!
Sorry, natürlich meinte ich einen aktiven USB-HUB zur besseren Stromversorgung;) Dachte, dass sich dadurch evtl. ab und zu das HM-RF-USB stört und sich das System deshalb verabschiedet - war aber nicht die Ursache.
Die Neustarts im Log waren vermutlich die manuellen von mir. Zur Zeit läuft das System in der Regel nur einen Tag stabil-.
Ich werde beim nächsten Ausfall die von Dir genannten Befehle durchführen und die Ergebnisse mitteilen.
Hoffentlich sieht man dort dann mehr bzw. kommt man dem Problem auf die Spur.
Das nervt mittlerweile schon enorm.
LG
Frank
vielen Dank für Deine Hilfe!
Sorry, natürlich meinte ich einen aktiven USB-HUB zur besseren Stromversorgung;) Dachte, dass sich dadurch evtl. ab und zu das HM-RF-USB stört und sich das System deshalb verabschiedet - war aber nicht die Ursache.
Die Neustarts im Log waren vermutlich die manuellen von mir. Zur Zeit läuft das System in der Regel nur einen Tag stabil-.
Ich werde beim nächsten Ausfall die von Dir genannten Befehle durchführen und die Ergebnisse mitteilen.
Hoffentlich sieht man dort dann mehr bzw. kommt man dem Problem auf die Spur.
Das nervt mittlerweile schon enorm.
LG
Frank
Re: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Hi Alex,
es ist mal wieder so weit...
Anbei die Ausgaben der Befehle in der Hoffnung, dass Du da eine Ursache erkennen kannst:
Vielen Dank im Voraus für Deine Hilfe!
Grüße
Frank
es ist mal wieder so weit...
Anbei die Ausgaben der Befehle in der Hoffnung, dass Du da eine Ursache erkennen kannst:
Code: Alles auswählen
root@debmatic:~# lsusb
Bus 002 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 005 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 004 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 003 Device 002: ID 0403:6f70 Future Technology Devices International, Ltd
Bus 003 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 001 Device 002: ID 0627:0001 Adomax Technology Co., Ltd
Bus 001 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Code: Alles auswählen
root@debmatic:~# root@debmatic:~# dmesg | tail -100
[217498.764041] sh (6201): drop_caches: 1
[217558.779588] sh (6237): drop_caches: 1
[217618.795652] sh (6274): drop_caches: 1
[217678.811382] sh (6310): drop_caches: 1
[217738.826911] sh (6354): drop_caches: 1
[217798.839114] sh (6393): drop_caches: 1
[217858.854207] sh (6429): drop_caches: 1
[217918.878457] sh (6465): drop_caches: 1
[217978.906215] sh (6502): drop_caches: 1
[218038.923367] sh (6544): drop_caches: 1
[218098.939302] sh (6580): drop_caches: 1
[218158.955568] sh (6616): drop_caches: 1
[218218.988127] sh (6653): drop_caches: 1
[218279.006356] sh (6692): drop_caches: 1
[218339.021762] sh (6733): drop_caches: 1
[218399.036264] sh (6772): drop_caches: 1
[218459.051414] sh (6808): drop_caches: 1
[218519.066830] sh (6844): drop_caches: 1
[218579.081820] sh (6881): drop_caches: 1
[218639.095152] sh (6929): drop_caches: 1
[218699.111342] sh (6966): drop_caches: 1
[218759.127357] sh (7008): drop_caches: 1
[218819.145984] sh (7044): drop_caches: 1
[218879.161084] sh (7081): drop_caches: 1
[218939.198163] sh (7123): drop_caches: 1
[218999.212034] sh (7162): drop_caches: 1
[219059.239569] sh (7198): drop_caches: 1
[219119.266649] sh (7234): drop_caches: 1
[219179.293702] sh (7271): drop_caches: 1
[219239.307514] sh (7315): drop_caches: 1
[219299.335594] sh (7348): drop_caches: 1
[219359.360868] sh (7384): drop_caches: 1
[219419.387249] sh (7420): drop_caches: 1
[219479.399585] sh (7456): drop_caches: 1
[219539.425660] sh (7501): drop_caches: 1
[219599.440304] sh (7540): drop_caches: 1
[219659.466019] sh (7579): drop_caches: 1
[219719.493074] sh (7616): drop_caches: 1
Code: Alles auswählen
root@debmatic:~# ps aux
USER PID %CPU %MEM VSZ RSS TTY STAT START TIME COMMAND
root 1 0.0 0.2 56964 6680 ? Ss Jun18 0:02 /sbin/init
root 2 0.0 0.0 0 0 ? S Jun18 0:00 [kthreadd]
root 3 0.0 0.0 0 0 ? S Jun18 0:04 [ksoftirqd/0]
root 5 0.0 0.0 0 0 ? S< Jun18 0:00 [kworker/0:0H]
root 6 0.0 0.0 0 0 ? S Jun18 0:01 [kworker/u2:0]
root 7 0.0 0.0 0 0 ? S Jun18 0:09 [rcu_sched]
root 8 0.0 0.0 0 0 ? S Jun18 0:00 [rcu_bh]
root 9 0.0 0.0 0 0 ? S Jun18 0:00 [migration/0]
root 10 0.0 0.0 0 0 ? S< Jun18 0:00 [lru-add-drain]
root 11 0.0 0.0 0 0 ? S Jun18 0:00 [watchdog/0]
root 12 0.0 0.0 0 0 ? S Jun18 0:00 [cpuhp/0]
root 13 0.0 0.0 0 0 ? S Jun18 0:00 [kdevtmpfs]
root 14 0.0 0.0 0 0 ? S< Jun18 0:00 [netns]
root 15 0.0 0.0 0 0 ? S Jun18 0:00 [khungtaskd]
root 16 0.0 0.0 0 0 ? S Jun18 0:00 [oom_reaper]
root 17 0.0 0.0 0 0 ? S< Jun18 0:00 [writeback]
root 18 0.0 0.0 0 0 ? S Jun18 0:00 [kcompactd0]
root 19 0.0 0.0 0 0 ? SN Jun18 0:00 [ksmd]
root 21 0.0 0.0 0 0 ? SN Jun18 0:00 [khugepaged]
root 22 0.0 0.0 0 0 ? S< Jun18 0:00 [crypto]
root 23 0.0 0.0 0 0 ? S< Jun18 0:00 [kintegrityd]
root 24 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 25 0.0 0.0 0 0 ? S< Jun18 0:00 [kblockd]
root 26 0.0 0.0 0 0 ? S< Jun18 0:00 [devfreq_wq]
root 27 0.0 0.0 0 0 ? S< Jun18 0:00 [watchdogd]
root 28 0.0 0.0 0 0 ? S Jun18 0:00 [kswapd0]
root 29 0.0 0.0 0 0 ? S< Jun18 0:00 [vmstat]
root 41 0.0 0.0 0 0 ? S< Jun18 0:00 [kthrotld]
root 42 0.0 0.0 0 0 ? S< Jun18 0:00 [ipv6_addrconf]
root 75 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 76 0.0 0.0 0 0 ? S< Jun18 0:00 [ata_sff]
root 77 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 78 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 79 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 80 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 81 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 82 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 83 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 84 0.0 0.0 0 0 ? S Jun18 0:01 [kworker/u2:1]
root 85 0.0 0.0 0 0 ? S Jun18 0:00 [scsi_eh_0]
root 86 0.0 0.0 0 0 ? S< Jun18 0:00 [scsi_tmf_0]
root 87 0.0 0.0 0 0 ? S Jun18 0:00 [scsi_eh_1]
root 88 0.0 0.0 0 0 ? S< Jun18 0:00 [scsi_tmf_1]
root 91 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 93 0.0 0.0 0 0 ? S Jun18 0:00 [scsi_eh_2]
root 94 0.0 0.0 0 0 ? S< Jun18 0:00 [scsi_tmf_2]
root 96 0.0 0.0 0 0 ? S< Jun18 0:00 [bioset]
root 354 0.0 0.0 0 0 ? S< Jun18 0:02 [kworker/0:1H]
root 387 0.0 0.0 0 0 ? S< Jun18 0:00 [kworker/u3:0]
root 394 0.0 0.0 0 0 ? S Jun18 0:03 [jbd2/sda1-8]
root 395 0.0 0.0 0 0 ? S< Jun18 0:00 [ext4-rsv-conve
root 416 0.2 0.3 61824 9728 ? Ss Jun18 8:26 /lib/systemd/sy
root 427 0.0 0.0 0 0 ? S Jun18 0:00 [kauditd]
root 449 0.0 0.1 45956 3936 ? Ss Jun18 0:45 /lib/systemd/sy
root 515 0.0 0.0 0 0 ? S< Jun18 0:00 [ttm_swap]
systemd+ 609 0.0 0.1 127284 4092 ? Ssl Jun18 0:00 /lib/systemd/sy
root 621 0.0 0.1 250112 4424 ? Ssl Jun18 2:15 /usr/sbin/rsysl
root 625 0.0 0.0 29636 2680 ? Ss Jun18 0:00 /usr/sbin/cron
root 626 0.0 0.1 46472 4524 ? Ss Jun18 0:00 /lib/systemd/sy
message+ 627 0.0 0.1 45112 3616 ? Ss Jun18 0:00 /usr/bin/dbus-d
root 693 0.0 0.0 14524 1492 tty1 Ss+ Jun18 0:00 /sbin/agetty --
root 702 0.0 0.1 69952 5272 ? Ss Jun18 0:00 /usr/sbin/sshd
root 711 0.0 0.0 37672 2404 ? Ss Jun18 0:00 /lib/nut/upsmon
nut 713 0.0 0.1 48756 3568 ? S Jun18 0:03 /lib/nut/upsmon
root 714 0.0 0.0 20472 2776 ? Ss Jun18 0:00 /sbin/dhclient
www-data 735 0.0 0.2 63028 7436 ? Ss Jun18 0:20 /usr/sbin/light
root 920 0.0 0.0 4480 1396 ? Ss Jun18 0:00 /bin/eq3configd
root 978 0.0 0.0 4684 1508 ? Ss Jun18 0:24 /bin/hss_led -l
root 992 0.0 0.0 3676 2232 ? Ss Jun18 0:42 /usr/local/addo
root 994 0.5 0.0 7244 2924 ? Ssl Jun18 21:33 /bin/multimacd
root 1017 0.0 0.3 61600 9924 ? S Jun18 0:13 /usr/sbin/light
root 1018 0.0 0.1 4952 3452 ? S Jun18 0:00 /bin/tclsh /usr
root 1023 0.0 0.0 4492 2336 ? Ss Jun18 0:00 /bin/hs485dLoad
root 1025 0.0 0.1 43140 5116 ? Sl Jun18 0:09 /bin/hs485d -l
root 1134 1.2 5.6 2133608 170456 ? Sl Jun18 48:12 /usr/bin/java -
root 1261 0.6 0.8 34948 26392 ? Sl Jun18 23:38 /bin/ReGaHss.no
root 9246 0.0 0.0 0 0 ? S 22:24 0:00 [kworker/0:1]
root 9439 0.0 0.0 0 0 ? S 22:29 0:00 [kworker/0:2]
root 9621 0.0 0.2 95208 6776 ? Ss 22:33 0:00 sshd: root@pts/
root 9624 0.0 0.1 56392 5804 ? Ss 22:33 0:00 /lib/systemd/sy
root 9625 0.0 0.0 82488 1624 ? S 22:33 0:00 (sd-pam)
root 9632 0.0 0.1 21056 4780 pts/0 Ss 22:33 0:00 -bash
root 9733 0.0 0.0 0 0 ? S 22:35 0:00 [kworker/0:0]
root 9748 0.0 0.1 38304 3128 pts/0 R+ 22:35 0:00 ps aux
root@debmatic:~#
Code: Alles auswählen
root@debmatic:~# tail -100 /var/log/syslog
Jun 20 22:33:46 debmatic systemd[1]: Starting User Manager for UID 0...
Jun 20 22:33:47 debmatic systemd[9624]: Listening on GnuPG cryptographic agent (access for web browsers).
Jun 20 22:33:47 debmatic systemd[9624]: Listening on GnuPG cryptographic agent and passphrase cache.
Jun 20 22:33:47 debmatic systemd[9624]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Paths.
Jun 20 22:33:47 debmatic systemd[9624]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Sockets.
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Timers.
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Basic System.
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Default.
Jun 20 22:33:47 debmatic systemd[9624]: Startup finished in 13ms.
Jun 20 22:33:47 debmatic systemd[1]: Started User Manager for UID 0.
Jun 20 22:34:01 debmatic CRON[9664]: (root) CMD (echo 1 > /proc/sys/vm/drop_caches)
Jun 20 22:34:01 debmatic kernel: [222839.488439] sh (9664): drop_caches: 1
Jun 20 22:34:02 debmatic hs485d: Event: MEQ0808088:21.VALUE=719.000000
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:18 debmatic hs485d: Event: MEQ0808088:21.VALUE=718.000000
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ0172180:1","STATE",false}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"OEQ0172180:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ0172180:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"NEQ1526804:1","STATE",false}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"NEQ1526804:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = NEQ1526804:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ0172300:1","STATE",false}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"OEQ0172300:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ0172300:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"NEQ1501164:1","STATE",false}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"NEQ1501164:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = NEQ1501164:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ1551504:1","STATE",false}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"OEQ1551504:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ1551504:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:01 debmatic CRON[9729]: (root) CMD (echo 1 > /proc/sys/vm/drop_caches)
Jun 20 22:35:01 debmatic kernel: [222899.513081] sh (9729): drop_caches: 1
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ0172180:1","INHIBIT",true}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"OEQ0172180:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ0172180:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"NEQ1526804:1","INHIBIT",true}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"NEQ1526804:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = NEQ1526804:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ0172300:1","INHIBIT",true}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"OEQ0172300:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ0172300:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"NEQ1501164:1","INHIBIT",true}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"NEQ1501164:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = NEQ1501164:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute() failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ1551504:1","INHIBIT",true}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interface: 1007, params: {"OEQ1551504:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp:1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ1551504:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:05 debmatic hs485d: Event: MEQ0808088:21.VALUE=719.000000
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:17 debmatic hs485d: Event: MEQ0808088:21.VALUE=718.000000
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:33 debmatic hs485d: Event: MEQ0808088:21.VALUE=719.000000
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:49 debmatic hs485d: Event: MEQ0808088:21.VALUE=718.000000
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:36:01 debmatic CRON[9784]: (root) CMD (echo 1 > /proc/sys/vm/drop_caches)
Jun 20 22:36:01 debmatic kernel: [222959.538033] sh (9784): drop_caches: 1
root@debmatic:~#
Code: Alles auswählen
root@debmatic:~# tail -100 /var/log/syslog
Jun 20 22:33:46 debmatic systemd[1]: Starting User Manager for UID 0...
Jun 20 22:33:47 debmatic systemd[9624]: Listening on GnuPG cryptographic agent ( access for web browsers).
Jun 20 22:33:47 debmatic systemd[9624]: Listening on GnuPG cryptographic agent a nd passphrase cache.
Jun 20 22:33:47 debmatic systemd[9624]: Listening on GnuPG cryptographic agent ( ssh-agent emulation).
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Paths.
Jun 20 22:33:47 debmatic systemd[9624]: Listening on GnuPG cryptographic agent a nd passphrase cache (restricted).
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Sockets.
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Timers.
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Basic System.
Jun 20 22:33:47 debmatic systemd[9624]: Reached target Default.
Jun 20 22:33:47 debmatic systemd[9624]: Startup finished in 13ms.
Jun 20 22:33:47 debmatic systemd[1]: Started User Manager for UID 0.
Jun 20 22:34:01 debmatic CRON[9664]: (root) CMD (echo 1 > /proc/sys/vm/drop_cach es)
Jun 20 22:34:01 debmatic kernel: [222839.488439] sh (9664): drop_caches: 1
Jun 20 22:34:02 debmatic hs485d: Event: MEQ0808088:21.VALUE=719.000000
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:02 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:18 debmatic hs485d: Event: MEQ0808088:21.VALUE=718.000000
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:34:18 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ0172180:1","STATE",fal se}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"OEQ0172180:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1 505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ0 172180:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"NEQ1526804:1","STATE",fal se}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"NEQ1526804:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1 505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = NEQ1 526804:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ0172300:1","STATE",fal se}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"OEQ0172300:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1 505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ0 172300:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"NEQ1501164:1","STATE",fal se}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"NEQ1501164:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1 505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = NEQ1 501164:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:00 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ1551504:1","STATE",fal se}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"OEQ1551504:1","STATE",false}) [CallSetValue():iseXmlRpc.cpp:1 505]
Jun 20 22:35:00 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ1 551504:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:01 debmatic CRON[9729]: (root) CMD (echo 1 > /proc/sys/vm/drop_cach es)
Jun 20 22:35:01 debmatic kernel: [222899.513081] sh (9729): drop_caches: 1
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ0172180:1","INHIBIT",t rue}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"OEQ0172180:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp: 1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ0 172180:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"NEQ1526804:1","INHIBIT",t rue}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"NEQ1526804:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp: 1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = NEQ1 526804:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ0172300:1","INHIBIT",t rue}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"OEQ0172300:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp: 1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ0 172300:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"NEQ1501164:1","INHIBIT",t rue}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"NEQ1501164:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp: 1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = NEQ1 501164:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeReq uest: write error (error 111). [error():iseXmlRpc.h:281]
Jun 20 22:35:02 debmatic ReGaHss: WARNING: XMLRPC 'setValue': rpcClient.execute( ) failed (url: xmlrpc_bin://127.0.0.1:32001, params: {"OEQ1551504:1","INHIBIT",t rue}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2602]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: XMLRPC 'setValue' call failed (interfac e: 1007, params: {"OEQ1551504:1","INHIBIT",true}) [CallSetValue():iseXmlRpc.cpp: 1505]
Jun 20 22:35:02 debmatic ReGaHss: ERROR: rpc.CallSetValue failed; address = OEQ1 551504:1 [WriteValue():iseDOMdpHSS.cpp:76]
Jun 20 22:35:05 debmatic hs485d: Event: MEQ0808088:21.VALUE=719.000000
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:05 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:17 debmatic hs485d: Event: MEQ0808088:21.VALUE=718.000000
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:17 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:33 debmatic hs485d: Event: MEQ0808088:21.VALUE=719.000000
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:33 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:49 debmatic hs485d: Event: MEQ0808088:21.VALUE=718.000000
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send 1 events
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:35:49 debmatic hs485d: HSSXmlRpcEventDispatcher::Handle send completed
Jun 20 22:36:01 debmatic CRON[9784]: (root) CMD (echo 1 > /proc/sys/vm/drop_cach es)
Jun 20 22:36:01 debmatic kernel: [222959.538033] sh (9784): drop_caches: 1
root@debmatic:~# ^C
root@debmatic:~# systemctl status debmatic-rfd
● debmatic-rfd.service - debmatic rfd
Loaded: loaded (/lib/systemd/system/debmatic-rfd.service; enabled; vendor pre
Active: failed (Result: core-dump) since Thu 2019-06-20 19:55:27 CEST; 2h 41m
Process: 3467 ExecStopPost=/bin/rm -f /var/run/rfd.pid (code=exited, status=0/
Process: 1070 ExecStart=/usr/share/debmatic/bin/start_rfd.sh (code=exited, sta
Main PID: 1080 (code=dumped, signal=SEGV)
Jun 20 19:55:24 debmatic rfd[1080]: (OEQ0016319) CCU2CommController::sendBidcosR
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: Device 0x571FCE is now associated with inter
CNT=7,RPTEN=1,RPTED=1,BIDI=1,BURST=0,WAKEU
CHANNEL = 1
STATUS = 206
STATE = 0
CLOCK = 0
LOWBAT = 0
DUTY_CYCLE = 0
RSSI = 0
Jun 20 19:55:26 debmatic rfd[1080]: LGWPortWrapper::reconnect(): Unable to find
Jun 20 19:55:26 debmatic rfd[1080]: LGWPortWrapper::reconnect(): Device not foun
Jun 20 19:55:26 debmatic systemd[1]: debmatic-rfd.service: Main process exited,
lines 1-23
root@debmatic:~# systemctl status debmatic-rfd
● debmatic-rfd.service - debmatic rfd
Loaded: loaded (/lib/systemd/system/debmatic-rfd.service; enabled; vendor pre
Active: failed (Result: core-dump) since Thu 2019-06-20 19:55:27 CEST; 2h 42m
Process: 3467 ExecStopPost=/bin/rm -f /var/run/rfd.pid (code=exited, status=0/
Process: 1070 ExecStart=/usr/share/debmatic/bin/start_rfd.sh (code=exited, sta
Main PID: 1080 (code=dumped, signal=SEGV)
Jun 20 19:55:24 debmatic rfd[1080]: (OEQ0016319) CCU2CommController::sendBidcosR
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: Device 0x571FCE is now associated with inter
CNT=7,RPTEN=1,RPTED=1,BIDI=1,BURST=0,WAKEU
CHANNEL = 1
STATUS = 206
STATE = 0
CLOCK = 0
LOWBAT = 0
DUTY_CYCLE = 0
RSSI = 0
Jun 20 19:55:26 debmatic rfd[1080]: LGWPortWrapper::reconnect(): Unable to find
Jun 20 19:55:26 debmatic rfd[1080]: LGWPortWrapper::reconnect(): Device not foun
Jun 20 19:55:26 debmatic systemd[1]: debmatic-rfd.service: Main process exited,
Jun 20 19:55:27 debmatic systemd[1]: debmatic-rfd.service: Unit entered failed s
Jun 20 19:55:27 debmatic systemd[1]: debmatic-rfd.service: Failed with result 'c
lines 3-25/25 (END)
root@debmatic:~# Jun 20 19:55:26 debmatic rfd[1080]: LGWPortWrapper::reconnect(): Unable to find
-bash: Syntaxfehler beim unerwarteten Wort `('
root@debmatic:~# Jun 20 19:55:26 debmatic rfd[1080]: LGWPortWrapper::reconnect(): Device not foun
-bash: Syntaxfehler beim unerwarteten Wort `('
root@debmatic:~# Jun 20 19:55:26 debmatic systemd[1]: debmatic-rfd.service: Main process exited,
Jun 20 19:55:27 debmatic systemd[1]: debmatic-rfd.service: Failed with result 'c-bash: Jun: Kommando nicht gefunden.
root@debmatic:~# Jun 20 19:55:27 debmatic systemd[1]: debmatic-rfd.service: Unit entered failed s
-bash: Jun: Kommando nicht gefunden.
root@debmatic:~# Jun 20 19:55:27 debmatic systemd[1]: debmatic-rfd.service: Failed with result 'csystemctl status debmatic-rfdsystemctl status debmatic-rfd
> systemctl status debmatic-rfd
>
>
>
> ^C
root@debmatic:~# systemctl status debmatic-rfd
● debmatic-rfd.service - debmatic rfd
Loaded: loaded (/lib/systemd/system/debmatic-rfd.service; enabled; vendor preset: enabled)
Active: failed (Result: core-dump) since Thu 2019-06-20 19:55:27 CEST; 2h 43min ago
Process: 3467 ExecStopPost=/bin/rm -f /var/run/rfd.pid (code=exited, status=0/SUCCESS)
Process: 1070 ExecStart=/usr/share/debmatic/bin/start_rfd.sh (code=exited, status=0/SUCCESS)
Main PID: 1080 (code=dumped, signal=SEGV)
Jun 20 19:55:24 debmatic rfd[1080]: (OEQ0016319) CCU2CommController::sendBidcosRequest(): Got response after retry number 1
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: (PEQ1948616) Response status: OK, Data.
Jun 20 19:55:24 debmatic rfd[1080]: Device 0x571FCE is now associated with interface PEQ1948616 because of @1980195170 RSSI
CNT=7,RPTEN=1,RPTED=1,BIDI=1,BURST=0,WAKEUP=0,WAKEMEUP=1,BCAST=1,TYPE=0x10
CHANNEL = 1
STATUS = 206
STATE = 0
CLOCK = 0
LOWBAT = 0
DUTY_CYCLE = 0
RSSI = 0
Jun 20 19:55:26 debmatic rfd[1080]: LGWPortWrapper::reconnect(): Unable to find device with serial PEQ0140497.
Jun 20 19:55:26 debmatic rfd[1080]: LGWPortWrapper::reconnect(): Device not found retrying in 20 seconds.
Jun 20 19:55:26 debmatic systemd[1]: debmatic-rfd.service: Main process exited, code=dumped, status=11/SEGV
Jun 20 19:55:27 debmatic systemd[1]: debmatic-rfd.service: Unit entered failed state.
Jun 20 19:55:27 debmatic systemd[1]: debmatic-rfd.service: Failed with result 'core-dump'.
Grüße
Frank
- 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: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Hi,
alle 60 Sekunden drop_caches ist etwas extrem, aber das wird nicht die Ursache sein, das müllt einfach nur das Log voll, was leider dafür sorgt, dass die Einschränkung auf 100 Zeilen in den Befehlen von mir den eigentlichen Zeitpunkt des Absturzes nicht mehr snzeigt.
Was man aber sehen kann: Der rfd verliert die Verbindung zu einem LAN GW (PEQ0140497) und kann diese nicht wieder aufbauen. Innrhalb des rfd scheint dann irgendein Bug zu sein, so dass er da keinen korrekten Reconnect macht, sondern mit einer SEGV abschmiert. SEGV bedeutet generell, dass da eine falsche Sprungmarke angesteuert werden soll. In 99% ein Bug, aber theoretisch kann das auch ein kaputter Arbeitsspeicher sein.
Da das ganze im Closed Source von eQ-3 ist, kann ich an der Stelle aber leider nicht tiefer reinschauen.
Viele Grüße
Alex
alle 60 Sekunden drop_caches ist etwas extrem, aber das wird nicht die Ursache sein, das müllt einfach nur das Log voll, was leider dafür sorgt, dass die Einschränkung auf 100 Zeilen in den Befehlen von mir den eigentlichen Zeitpunkt des Absturzes nicht mehr snzeigt.
Was man aber sehen kann: Der rfd verliert die Verbindung zu einem LAN GW (PEQ0140497) und kann diese nicht wieder aufbauen. Innrhalb des rfd scheint dann irgendein Bug zu sein, so dass er da keinen korrekten Reconnect macht, sondern mit einer SEGV abschmiert. SEGV bedeutet generell, dass da eine falsche Sprungmarke angesteuert werden soll. In 99% ein Bug, aber theoretisch kann das auch ein kaputter Arbeitsspeicher sein.
Da das ganze im Closed Source von eQ-3 ist, kann ich an der Stelle aber leider nicht tiefer reinschauen.
Viele Grüße
Alex
Re: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Moin Alex und danke für die Auswertung.
Den Cronjob habe ich normalerweise stündlich laufen. Habe es jetzt wieder geändert.
Und mein Problem werde ich dann wohl nicht so einfach zu lösen bekommen wenn ich Dich richtig verstehe...
Hast Du mir einen Vorschlag, was ich machen könnte? Soll ich testweise einfach mal das betroffene LAN-.GW komplett raus nehmen und testen, ob es dann besser wird? Oder Dein USB-Modul wieder rausnehmen (habe noch keine IP-Geräte im Einsatz)?
Viele Grüße
Frank
Den Cronjob habe ich normalerweise stündlich laufen. Habe es jetzt wieder geändert.
Und mein Problem werde ich dann wohl nicht so einfach zu lösen bekommen wenn ich Dich richtig verstehe...
Hast Du mir einen Vorschlag, was ich machen könnte? Soll ich testweise einfach mal das betroffene LAN-.GW komplett raus nehmen und testen, ob es dann besser wird? Oder Dein USB-Modul wieder rausnehmen (habe noch keine IP-Geräte im Einsatz)?
Viele Grüße
Frank
- 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: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Hi,
wenn du ohne das LGW auskommst, dann würde ich es mal ohne dieses ausprobieren.
Viele Grüße
Alex
wenn du ohne das LGW auskommst, dann würde ich es mal ohne dieses ausprobieren.
Viele Grüße
Alex
Re: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Kurze Rückmeldung zu dieser Sache:
Seit ich das betroffene LAN-GW aus dem Netz habe, ist kein weiterer Fehler aufgetreten und Debmatic läuft stabil.
Grundsätzlich sehr ärgerlich, da ich so wie es aussieht ein zusätzliches LAN-GW benötige.
Ich werde mal versuchen, ein anderes zu testen um auszuschließen, dass das eine Gerät einen einen "Schuss" hat.
Viele Grüße
Seit ich das betroffene LAN-GW aus dem Netz habe, ist kein weiterer Fehler aufgetreten und Debmatic läuft stabil.
Grundsätzlich sehr ärgerlich, da ich so wie es aussieht ein zusätzliches LAN-GW benötige.
Ich werde mal versuchen, ein anderes zu testen um auszuschließen, dass das eine Gerät einen einen "Schuss" hat.
Viele Grüße
Re: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Ich benutze auch das USB Modul mit dem neuen Funkmodul unter Proxmox mit einer Ubuntu 18.04 VM. Ich habe auch ein Funk Lan GW. Den neueren eckigen.
Bei mir läuft alles perfekt stabil.
Genauso unter Raspbian 9 direkt.
Gruß Sebastian
Bei mir läuft alles perfekt stabil.
Genauso unter Raspbian 9 direkt.
Gruß Sebastian
- eiGelbGeek
- Beiträge: 979
- Registriert: 24.07.2014, 17:46
- Wohnort: Ruhrpottrandgebiet
- Hat sich bedankt: 105 Mal
- Danksagung erhalten: 19 Mal
Re: Ständige Ausfälle von Debmatic mit HB-RF-USB-TK
Wo wird dein debmatic denn weiter verarbeitet? (openHAB vielleicht?) oder arbeitest du nur in der HM Welt?deifel hat geschrieben: ↑27.06.2019, 09:02Kurze Rückmeldung zu dieser Sache:
Seit ich das betroffene LAN-GW aus dem Netz habe, ist kein weiterer Fehler aufgetreten und Debmatic läuft stabil.
Grundsätzlich sehr ärgerlich, da ich so wie es aussieht ein zusätzliches LAN-GW benötige.
Ich werde mal versuchen, ein anderes zu testen um auszuschließen, dass das eine Gerät einen einen "Schuss" hat.
Viele Grüße
Wenn deine komplette Logik z.b. in openhab liegt, dann ziehe einfach eine 2te CCU mit debmatic (z.b. auf einen Raspberry Pi) auf, anstatt ein LAN Gateway. (Die LAN Gateways haben schon immer und überall ärger gemacht)
Ich betreibe 2 x debmatic einmal auf einen RPi 4/4GB im Keller (dort läuft dann noch openHAB 2.5) und einen RPi 3 in der Wohnung, dort ist noch ein Conbee2 (Zigbee) und ein Z-Wave Stick dran (der Z-Wave Stick wird mit ser2net/socat zum RPi 4 / 4GB im Keller verbunden)
Wenn deine Logik auf der CCU liegt, dann ist eine 2te CCU natürlich suboptimal... weil die Geräte nicht untereinander kommunizieren können
Wenn du irgendwas anderes als openHAB verwendest, solltest du dich vorher schlau machen ob mehrfache CCU Instanzen unterstützt werden.
Nur weil es nicht geht, muss es nicht kaputt sein ^^
Apple for Work, Linux for Network, iOS for Mobility and still Windows for Solitaire
Apple for Work, Linux for Network, iOS for Mobility and still Windows for Solitaire