pivccu(3) Zentrale hat Schluckauf

[Darth.Weber]

Hallo, ich habe seit einigen Wochen Probleme mit meiner pivccu auf einem RasPi3 mit einem (alten) Funkmodul. Nach dem Start der Zentrale läuft alles einwandfrei, aber nach kurzer Zeit purzel diverse Geräte in die Meldung rein mit "Kommunikation gestört". Die Geräte sind dann auch nicht mehr bedienbar. Nach kurzer Zeit läuft es dann wieder bis zum nächsten Aussetzer....

Ich habe mein System unter pivccu gesichert und pivccu3 neu aufgespielt - leider mit dem gleichen Ergebnis.

Die Funkabstrahlung sollte ausreichen sein, ich nutze neben dem Modul noch 2 HM LAN Konfigurationsadapter.

Es hängt IP Symcon dran - habe die Probleme aber auch beim Bedienen über die ccu.

Die Log:

Code: Alles auswählen

***** messages *****
Apr  5 14:51:54 piVCCU syslog.info syslogd started: BusyBox v1.29.2
Apr  5 14:51:54 piVCCU user.notice kernel: klogd started: BusyBox v1.29.2 (2019-03-15 17:05:46 CET)
Apr  5 14:51:54 piVCCU syslog.info syslogd exiting
Apr  5 14:51:54 Uhura-ccu3 syslog.info syslogd started: BusyBox v1.29.2
Apr  5 14:51:54 Uhura-ccu3 user.notice kernel: klogd started: BusyBox v1.29.2 (2019-03-15 17:05:46 CET)
Apr  5 14:51:54 Uhura-ccu3 daemon.err udhcpc[178]: started, v1.29.2
Apr  5 14:51:54 Uhura-ccu3 daemon.err udhcpc[178]: sending discover
Apr  5 14:51:54 Uhura-ccu3 daemon.err udhcpc[178]: sending select for 192.168.178.44
Apr  5 14:51:54 Uhura-ccu3 daemon.err udhcpc[178]: lease of 192.168.178.44 obtained, lease time 864000
Apr  5 14:51:55 Uhura-ccu3 user.info firewall: iptables v1.6.2: invalid port/service `310000' specified Try `iptables -h' or 'iptables --help' for more information.
Apr  5 14:51:55 Uhura-ccu3 user.info firewall: ip6tables v1.6.2: invalid port/service `310000' specified Try `ip6tables -h' or 'ip6tables --help' for more information.
Apr  5 14:51:55 Uhura-ccu3 user.info firewall: configuration set
Apr  5 14:51:55 Uhura-ccu3 daemon.info ifplugd(eth0)[261]: ifplugd 0.28 initializing.
Apr  5 14:51:55 Uhura-ccu3 daemon.info ifplugd(eth0)[261]: Using interface eth0/CA:A6:AA:DB:18:4C with driver <veth> (version: 1.0)
Apr  5 14:51:55 Uhura-ccu3 daemon.info ifplugd(eth0)[261]: Using detection mode: SIOCETHTOOL
Apr  5 14:51:55 Uhura-ccu3 daemon.info ifplugd(eth0)[261]: Initialization complete, link beat detected.
Apr  5 14:51:55 Uhura-ccu3 daemon.warn ifplugd(eth0)[261]: Could not open /dev/tty, cannot beep.
Apr  5 14:51:55 Uhura-ccu3 daemon.info ifplugd(eth0)[261]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Apr  5 14:51:55 Uhura-ccu3 daemon.warn ifplugd(eth0)[261]: client: ifup: interface eth0 already configured
Apr  5 14:51:55 Uhura-ccu3 daemon.info ifplugd(eth0)[261]: Program executed successfully.
Apr  5 14:52:02 Uhura-ccu3 daemon.notice ntpdate[269]: step time server 85.114.128.137 offset 0.002557 sec
Apr  5 14:52:02 Uhura-ccu3 daemon.notice ntpd[270]: ntpd 4.2.8p12@1.3728-o Fri Mar 15 16:04:16 UTC 2019 (1): Starting
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[270]: Command line: /usr/sbin/ntpd -g 0.de.pool.ntp.org
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: proto: precision = 0.416 usec (-21)
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: Listen and drop on 0 v6wildcard [::]:123
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: Listen normally on 2 lo 127.0.0.1:123
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: Listen normally on 3 eth0 192.168.178.44:123
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: Listen normally on 4 lo [::1]:123
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: Listening on routing socket on fd #21 for interface updates
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Apr  5 14:52:02 Uhura-ccu3 daemon.info ntpd[272]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Apr  5 14:52:02 Uhura-ccu3 daemon.err xinetd[292]: Unable to read included directory: /etc/config/xinetd.d [file=/etc/xinetd.conf] [line=14]
Apr  5 14:52:02 Uhura-ccu3 daemon.crit xinetd[292]: 292 {init_services} no services. Exiting...
Apr  5 14:52:02 Uhura-ccu3 user.info root: Updating RF Lan Gateway Coprocessor Firmware
Apr  5 14:52:02 Uhura-ccu3 user.debug update-coprocessor: firmware filename is: coprocessor_update_hm_only.eq3
Apr  5 14:52:02 Uhura-ccu3 user.info root: Updating RF Lan Gateway Firmware
Apr  5 14:52:02 Uhura-ccu3 user.info update-lgw-firmware: No gateway found in config file /etc/config/rfd.conf
Apr  5 14:52:04 Uhura-ccu3 user.warn Sniffing Mode: opendir(/etc/config/firmware//) failed
Apr  5 14:52:07 Uhura-ccu3 user.warn Sniffing Mode: Timeout waiting for set key message
Apr  5 14:52:07 Uhura-ccu3 user.warn Sniffing Mode: Timeout waiting for set key message
Apr  5 14:52:07 Uhura-ccu3 user.warn Sniffing Mode: Timeout waiting for set key message
Apr  5 14:52:07 Uhura-ccu3 user.warn Sniffing Mode: Timeout waiting for set key message
Apr  5 14:52:07 Uhura-ccu3 user.warn Sniffing Mode: Timeout waiting for set key message
Apr  5 14:53:18 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 14:53:18 Uhura-ccu3 user.warn Sniffing Mode: Peering with MEQ0649408 failed
Apr  5 14:53:26 Uhura-ccu3 daemon.err ntpd[272]: bind(24) AF_INET6 2003:c1:fbca:b700:c8a6:aaff:fedb:184c#123 flags 0x11 failed: Cannot assign requested address
Apr  5 14:53:26 Uhura-ccu3 daemon.err ntpd[272]: unable to create socket on eth0 (5) for 2003:c1:fbca:b700:c8a6:aaff:fedb:184c#123
Apr  5 14:53:26 Uhura-ccu3 daemon.info ntpd[272]: failed to init interface for address 2003:c1:fbca:b700:c8a6:aaff:fedb:184c
Apr  5 14:53:28 Uhura-ccu3 daemon.info ntpd[272]: Listen normally on 6 eth0 [2003:c1:fbca:b700:c8a6:aaff:fedb:184c]:123
Apr  5 14:53:48 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 14:53:48 Uhura-ccu3 user.warn Sniffing Mode: Peering with MEQ0649408 failed
Apr  5 14:55:10 Uhura-ccu3 local0.warn ReGaHss: WARNING: incorrect use of Variable() (use AlType()): Name=dom.GetObject(1235).Name(); ValueType=dom.GetObject(1235).ValueType(); integer Type=dom.GetObject(1235).Type(); WriteLine(dom.GetObject(1235).Variable()); Timestamp=dom.GetObject(1235).Timestamp();  [ExecAlarmDP():iseESPexec.cpp:10132]
Apr  5 14:55:10 Uhura-ccu3 local0.err ReGaHss: ERROR: ScriptRuntimeError: Name=dom.GetObject(1235).Name(); ValueType=dom.GetObject(1235).ValueType(); integer Type=dom.GetObject(1235).Type(); WriteLine(dom.GetObject(1235).Variable()); Timestamp=dom.GetObject(1235).Timestamp();  [ExecError():iseESPexec.cpp:12679]
Apr  5 14:55:10 Uhura-ccu3 local0.warn ReGaHss: WARNING: incorrect use of Variable() (use AlType()): Name=dom.GetObject(1235).Name(); ValueType=dom.GetObject(1235).ValueType(); integer Type=dom.GetObject(1235).Type(); WriteLine(dom.GetObject(1235).Variable()); Timestamp=dom.GetObject(1235).Timestamp();  [ExecAlarmDP():iseESPexec.cpp:10132]
Apr  5 14:55:10 Uhura-ccu3 local0.err ReGaHss: ERROR: ScriptRuntimeError: Name=dom.GetObject(1235).Name(); ValueType=dom.GetObject(1235).ValueType(); integer Type=dom.GetObject(1235).Type(); WriteLine(dom.GetObject(1235).Variable()); Timestamp=dom.GetObject(1235).Timestamp();  [ExecError():iseESPexec.cpp:12679]
Apr  5 15:06:03 Uhura-ccu3 local0.err ReGaHss: ERROR: ScriptRuntimeError: string channels = "";string timestamps = ""; [ExecError():iseESPexec.cpp:12679]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:0",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:0",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:1",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:1",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:10",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:10",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:11",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:11",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:12",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:12",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:13",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:13",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:14",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:14",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:15",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:15",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:16",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:16",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:17",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:17",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:18",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:18",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:19",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:19",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:2",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:2",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:20",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:20",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:21",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:21",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:22",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:22",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:23",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:23",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:24",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:24",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:25",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:25",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:26",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:26",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:27",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:27",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:28",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:28",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:29",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:29",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:3",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:3",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:30",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:30",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:31",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:31",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:32",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:32",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:33",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:33",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:34",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:34",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:35",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:35",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:36",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:36",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:37",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:37",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:27 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:38",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:27 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:38",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:39",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:39",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:4",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:4",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:40",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:40",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:41",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:41",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:42",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:42",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:43",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:43",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:44",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:44",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:45",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:45",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:46",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:46",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:47",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:47",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:48",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:48",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:49",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:49",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:5",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:5",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:50",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:50",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:6",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:6",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:7",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:7",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:8",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:8",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 15:06:28 Uhura-ccu3 local0.warn ReGaHss: WARNING: XMLRPC 'getLinks': rpcClient.isFault() failed (url: xmlrpc://127.0.0.1:32010, params: {"61A7D70992B057:9",0}, result: [faultCode:-2,faultString:"Invalid device"]) [CallXmlrpcMethod():iseXmlRpc.cpp:2608]
Apr  5 15:06:28 Uhura-ccu3 local0.err ReGaHss: ERROR: XMLRPC 'getLinks' call failed (interface: 2589, params: {"61A7D70992B057:9",0}) [GetLinkPeersCount():iseXmlRpc.cpp:2526]
Apr  5 16:04:05 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:04:05 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:04:22 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:04:27 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:04:27 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:04:41 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:04:49 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:04:51 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:05:06 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:05:09 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:05:10 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:05:21 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle nearly used
Apr  5 16:05:27 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:05:27 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:05:31 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:05:31 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:05:38 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:05:38 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:05:41 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:05:41 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:05:47 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:05:47 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:05:53 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:05:53 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:08 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:06:08 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:11 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:06:11 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:11 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:17 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:06:17 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:06:27 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:06:27 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:33 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:06:33 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:35 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:42 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:06:42 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:46 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:06:46 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:06:47 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:01 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:07:01 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:04 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:07:04 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:14 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:07:14 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:27 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:07:27 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:31 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:07:31 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:35 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:07:35 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:46 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:07:46 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:49 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:07:49 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:07:49 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:02 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:02 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:11 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:11 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:15 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:15 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:23 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:23 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:27 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:27 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:32 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:32 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:43 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:43 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:51 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:51 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:08:54 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:08:54 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() false Put failed
Apr  5 16:09:01 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:01 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:09:08 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:08 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:09:12 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:12 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:09:22 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:22 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:09:28 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:28 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:09:35 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:35 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:09:42 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:42 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:09:52 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:52 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:09:55 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:09:55 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:02 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:10:02 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:04 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:10:04 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:09 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:10:09 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:27 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:10:27 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:29 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:31 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:44 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:10:44 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:50 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:10:50 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:10:52 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:05 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:11:05 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:07 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:14 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:11:14 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:29 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:11:29 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:32 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:11:32 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:33 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:44 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:11:44 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:49 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:11:49 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:11:53 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:11:53 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:00 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:00 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:04 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:04 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:07 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:07 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:12 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:12 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:16 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:16 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:23 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:23 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:33 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:33 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:38 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:38 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:43 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:43 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:54 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:54 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:58 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:12:58 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:12:58 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:13:14 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:13:14 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:13:17 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:13:17 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:13:25 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:13:25 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:13:31 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:13:31 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:13:35 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:13:35 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:13:40 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:13:40 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed
Apr  5 16:13:51 Uhura-ccu3 user.warn Sniffing Mode: HEQ0400002: Duty cycle fully used
Apr  5 16:13:51 Uhura-ccu3 user.err Sniffing Mode: HSSParameter::SetValue() true Put failed


***** hmserver.log *****
Apr 5 14:52:10 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] @GenericFactory 
Apr 5 14:52:10 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] created instance of HMServerConfiguration with parameter(s) 
Apr 5 14:52:10 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] passed 1 parameter(s), in declarative order [String] 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [HMIPTRXWriterWorker] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KeyServerWorker] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KryoPersistenceWorker] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [TransactionSubsystemHandler] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [FirmwareLoaderFileSystem] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerPersistentDataLoader] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerAdapterInitialization] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [BackendCommandHandler] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionAcceptHandler] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CheckDeviceExistHandler] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [IncomingHMIPFrameHandler] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceBackgroundUpdateSubsystem] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceLiveUpdateSubsystem] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionDefaultConfigurationChanger] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CyclicSmokeDetectorAwakening] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerFirmwareUpdateInitialization] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [AccessPointAuthorisationHandler] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [AccessPointMessageDispatcher] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [AccessPointWatchdog] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [WebSocketManager] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [AccessPointCommDevice] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [RouterKeyServerWorker] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [AccessPointKeyServerWorker] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [RemoteCommAdapterInitialization] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [RemoteCommAdapterFinalization] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LanRoutingWorker] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyNotificationHandler] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyAPIWorker] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBackendNotificationHandler] (3) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBlindLevelCorrectionHandler] (1) *worker 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyInitializion] (1)  
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: deploying 31 classes to Vert.x 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: 31 VertxDeployers initialized 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of CyclicSmokeDetectorAwakening succeeded (6ca20551-2cde-4979-a170-f7b4a3ebbc93) 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of TransactionSubsystemHandler succeeded (2fe5a9b8-04ff-4867-b7ac-4a6d3f399bc6) 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of CheckDeviceExistHandler succeeded (60510d24-1295-492d-aa7e-5afdaaca081b) 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of AccessPointKeyServerWorker succeeded (b64d0a08-5af4-4370-bc09-997bb0e00d50) 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of HMIPTRXWriterWorker succeeded (83189c94-dd88-4a9a-9774-374cfc4b8c6b) 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LegacyBlindLevelCorrectionHandler succeeded (84acb231-4883-4f16-9f05-b14853c9c90f) 
Apr 5 14:52:16 de.eq3.cbcs.server.core.vertx.KeyServerWorker ERROR [vert.x-worker-thread-4] Missing key server configuration parameter (Network.Key) for  mode: KEYSERVER_LOCAL 
Apr 5 14:52:16 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of KeyServerWorker succeeded (cb3e0806-18fe-4dda-be00-9d6a72fb44d7) 
Apr 5 14:52:16 de.eq3.cbcs.lib.remotecommadapter.device.security.RouterKeyServerWorker ERROR [vert.x-worker-thread-3] Missing key server configuration parameter (Network.Key) for  mode: KEYSERVER_LOCAL 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of KryoPersistenceWorker succeeded (71d0f714-8c70-456b-b31f-2bbcc10bc260) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LocalServerPersistentDataLoader succeeded (623d1db6-fa6a-45c4-82f4-5f2d22063014) 
Apr 5 14:52:17 de.eq3.cbcs.server.core.live_otau.DeviceLiveUpdateSubsystem INFO  [vert.x-eventloop-thread-5] SYSTEM: DeviceLiveUpdateSubsystem started 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of DeviceInclusionDefaultConfigurationChanger succeeded (4088e629-548c-4b68-8d20-e1a62f92337c) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of RouterKeyServerWorker succeeded (010bf6aa-b2ad-487b-8127-684754007f48) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of DeviceLiveUpdateSubsystem succeeded (980f054d-f8b5-4070-bbd7-9aa96a140d45) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of DeviceBackgroundUpdateSubsystem succeeded (c7a15401-ba55-483a-b7e6-1da190a58a8b) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of RemoteCommAdapterInitialization succeeded (54e29e6c-1639-41a6-931f-e472d460f9ee) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of AccessPointMessageDispatcher succeeded (8d5876c4-e0c1-4cbe-9589-c74de7425f27) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of WebSocketManager succeeded (7ce95c67-a0bf-4903-9f3b-e7bbf716dd0d) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of BackendCommandHandler succeeded (56c00fc3-5b13-45f5-b701-5a3de2cfb39d) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of AccessPointCommDevice succeeded (676f1c4c-78a9-40e3-a84a-f3707ee5c6e3) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of DeviceInclusionAcceptHandler succeeded (da8ecb41-fede-471e-a257-1fb4d1a22639) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of AccessPointWatchdog succeeded (54775fcf-2671-42da-936c-62f9c035d108) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of IncomingHMIPFrameHandler succeeded (9cc776c4-9237-4c52-bc9e-ae3e7acfab2b) 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of AccessPointAuthorisationHandler succeeded (0b987449-2f38-4917-9d03-6ef7722c0a17) 
Apr 5 14:52:17 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-4] SYSTEM: Firmware update directory is set to /etc/config/firmware 
Apr 5 14:52:17 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of FirmwareLoaderFileSystem succeeded (2c7f3511-5ab6-4e54-89a8-5f93650cbe7a) 
Apr 5 14:52:18 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LocalServerAdapterInitialization succeeded (9e206e4f-3537-4bb8-82b7-e80e2a1a1eb0) 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter state 1: HMIP_TRX_App 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter application is already running or started 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] No NWK, try to set address ... 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Try to set radio address 12549111... 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Set max send attempts for 3014F711A061A7D70992B057 to 3 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Try to get application version... 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Application version 2.8.6 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Bootloader version 1.0.3 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] hmos version 1.20.3 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] MCU type: Si1002_8051 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Duty Cycle: 0.0 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] set DutyCycle limit to ffffffc8 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Set Duty Cycle Limit 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Current Security Counter: 139904586 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Update security counter to calculation: 140268534 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter has no linkpartner 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Adapter with Access Point id 3014F711A061A7D70992B057 initialized 
Apr 5 14:52:18 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [Thread-6] HMIPTRXInitialResponseListener said that Adapter was initialized 
Apr 5 14:52:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LegacyNotificationHandler succeeded (61653dc5-02e8-4e04-a1f3-63349432fc6f) 
Apr 5 14:52:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LegacyInitializion succeeded (42b6869e-cf33-4d80-8e78-ccd23ab6a942) 
Apr 5 14:52:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LocalServerFirmwareUpdateInitialization succeeded (7982e504-87d3-48fb-8af8-4adec8124147) 
Apr 5 14:52:19 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem WARN  [vert.x-worker-thread-4] SYSTEM: Firmware update directory in config file is no valid directory: /etc/config/firmware 
Apr 5 14:52:19 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Checking all devices on all accesspoints for updates 
Apr 5 14:52:19 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: There are 0 APs queued with updatable devices (RF) 
Apr 5 14:52:19 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: There are 0 APs queued with updatable devices (WIRED) 
Apr 5 14:52:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LegacyBackendNotificationHandler succeeded (a2714a8c-5217-4662-9170-f20f4f6db68d) 
Apr 5 14:52:19 de.eq3.cbcs.lib.lanrouting.UdpServer INFO  [vert.x-worker-thread-0] UDP Routing configuration: trying to bind port 43438 on eth0 0.0.0.0 -> 192.168.178.44 
Apr 5 14:52:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LegacyAPIWorker succeeded (6dcf5cb7-df70-497e-a248-45574b43c922) 
Apr 5 14:52:20 de.eq3.cbcs.lib.lanrouting.LanRoutingWorker INFO  [vert.x-worker-thread-0] AP 3014F711A061A7D70992B057: Could not initialize routing of access point, version is 2.8.6 
Apr 5 14:52:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of LanRoutingWorker succeeded (ae2de099-b00f-4732-8730-60418a14c174) 
Apr 5 14:52:20 de.eq3.cbcs.lib.lanrouting.UdpServer INFO  [vert.x-worker-thread-4] UDP Routing established on network interface eth0 : 0.0.0.0 (192.168.178.44) 
Apr 5 14:52:20 de.eq3.cbcs.lib.lanrouting.UdpServer INFO  [vert.x-worker-thread-2] UDP Routing multi cast established on network interface eth0 : 192.168.178.44 
Apr 5 14:52:20 de.eq3.cbcs.lib.remotecommadapter.AccessPointCommDevice INFO  [vert.x-eventloop-thread-1] SYSTEM: Started Access Point WebSocket server with port 9293 
Apr 5 14:52:20 de.eq3.cbcs.lib.remotecommadapter.AccessPointCommDevice INFO  [vert.x-eventloop-thread-1] SYSTEM: connector open 
Apr 5 14:52:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of RemoteCommAdapterFinalization succeeded (8c4e3f0c-dfde-4a59-9db8-a47d1ad60bad) 
Apr 5 14:52:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: initial deployment complete _____________________________________________________ 
Apr 5 14:52:20 de.eq3.cbcs.server.local.LocalServer INFO  [Thread-0] SYSTEM: Bind XML-RPC api to port 32010 
Apr 5 14:52:25 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default MaxEventLoopExecuteTime: 2000000000 
Apr 5 14:52:25 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default BlockedThreadCheckInterval: 1000 
Apr 5 14:52:25 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default MaxWorkerExecuteTime: 60000000000 
Apr 5 14:52:25 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Default EventLoopPoolSize: 8 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [BackendWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [GroupRequestWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DiagramRequestWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [StorageRequestWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [DeviceFirmwareRequestWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [EnergyPriceRequestWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [CouplingRequestWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [RegaClientWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [GroupConfigurationPersistenceFileSystem] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: added for deployment [HmIPGatewayManagementRequestWorker] (1) *worker 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: deploying 10 classes to Vert.x 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of BackendWorker succeeded (6aed03b3-9495-4b45-98f9-ab69e81dacb2) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: 10 VertxDeployers initialized 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of CouplingRequestWorker succeeded (5600e480-15a1-4392-8c9e-39d31fbb556a) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of GroupConfigurationPersistenceFileSystem succeeded (eb8f6774-3340-4cc8-ab44-8547de89fe96) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of EnergyPriceRequestWorker succeeded (45a9e7bb-706f-4553-925a-43ef96fb5d4f) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of RegaClientWorker succeeded (16893692-5255-4838-9d5e-3bd1a35d0ec0) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of StorageRequestWorker succeeded (c14610a1-85bc-45f2-b769-8fe093b93afa) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of GroupRequestWorker succeeded (d1e1d02e-6287-41dc-9b50-b3be9432fd17) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of DiagramRequestWorker succeeded (9664fdf8-1bf9-4710-8e65-3376b8f2627f) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (2b526a32-d40d-46f9-a75c-e687f0f6964f) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of HmIPGatewayManagementRequestWorker succeeded (34ca4e52-d158-4d18-a396-4fa435d6ff4c) 
Apr 5 14:52:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-1] SYSTEM: initial deployment complete _____________________________________________________ 
Apr 5 14:52:25 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Starting HMServer at 127.0.0.1:39292 
Apr 5 14:52:25 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Read Configuration 
Apr 5 14:52:26 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create Bidcos Dispatcher 
Apr 5 14:52:26 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] InitBidCosCache 
Apr 5 14:52:27 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create groupDefinitionProvider 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create VirtualDeviceHolder 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create VirtualDeviceHandlerRega 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupAdministrationService 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupDeviceDispatcher 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create GroupDeviceHandler 
Apr 5 14:52:28 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-1] @GroupDeviceHandler - initializing... 
Apr 5 14:52:28 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-1] --> created groupDeviceDispatcher (GroupDeviceService to BidCoS (via Dispatcher)) 
Apr 5 14:52:28 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-1] --> created virtualDeviceHandler (GroupDeviceService to ReGa) 
Apr 5 14:52:28 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-1] --> got groupDefinitionProvider 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create BidCosGroupMemberProvider 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Init groupAdministrationService 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Init Virtual OS Device 
Apr 5 14:52:28 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Init ESHLight Bridge 
Apr 5 14:52:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create RrdDatalogging 
Apr 5 14:52:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create MeasurementService 
Apr 5 14:52:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Init MeasurementService 
Apr 5 14:52:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create HTTP Server 
Apr 5 14:52:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create BidCos context and start handler 
Apr 5 14:52:29 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Create group context and start handler 
Apr 5 14:52:29 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:39292/bidcos 
Apr 5 14:52:29 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] init finished 
Apr 5 14:52:29 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-0] Added InterfaceId: HmIP-RF_java 
Apr 5 14:52:29 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-0] updateDevicesForClient HmIP-RF_java -> 52 device addresses will be added 
Apr 5 14:52:30 de.eq3.ccu.server.BaseHMServer INFO  [Thread-1] Starting HMServer done 
Apr 5 14:52:38 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-4] (un)registerCallback on VirtualDeviceHandlerRega called from url: xmlrpc_bin://127.0.0.1:31999 
Apr 5 14:52:38 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-4] Added InterfaceId: 1008 
Apr 5 14:52:38 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-13] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
Apr 5 14:52:48 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-2] (un)registerCallback on LegacyServiceHandler called from url: xmlrpc_bin://127.0.0.1:31999 
Apr 5 14:52:48 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-2] init finished 
Apr 5 14:52:48 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-1] Added InterfaceId: 2589 
Apr 5 14:57:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 14:57:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 14:57:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:02:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:02:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:02:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:02:17 de.eq3.cbcs.lib.remotecommadapter.device.service.AccessPointWatchdog INFO  [vert.x-eventloop-thread-5] SYSTEM: Access Point Watchdog running periodic connection check... 
Apr 5 15:07:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:07:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:07:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:12:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:12:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:12:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:12:18 de.eq3.cbcs.lib.remotecommadapter.device.service.AccessPointWatchdog INFO  [vert.x-eventloop-thread-5] SYSTEM: Access Point Watchdog running periodic connection check... 
Apr 5 15:17:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:17:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:17:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:22:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:22:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:22:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:22:17 de.eq3.cbcs.lib.remotecommadapter.device.service.AccessPointWatchdog INFO  [vert.x-eventloop-thread-5] SYSTEM: Access Point Watchdog running periodic connection check... 
Apr 5 15:27:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:27:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:27:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:32:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:32:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:32:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:32:18 de.eq3.cbcs.lib.remotecommadapter.device.service.AccessPointWatchdog INFO  [vert.x-eventloop-thread-5] SYSTEM: Access Point Watchdog running periodic connection check... 
Apr 5 15:37:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:37:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:37:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:42:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:42:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:42:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:42:18 de.eq3.cbcs.lib.remotecommadapter.device.service.AccessPointWatchdog INFO  [vert.x-eventloop-thread-5] SYSTEM: Access Point Watchdog running periodic connection check... 
Apr 5 15:47:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:47:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:47:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:52:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:52:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:52:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 15:52:18 de.eq3.cbcs.lib.remotecommadapter.device.service.AccessPointWatchdog INFO  [vert.x-eventloop-thread-5] SYSTEM: Access Point Watchdog running periodic connection check... 
Apr 5 15:57:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 15:57:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 15:57:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 16:02:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 16:02:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 16:02:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 16:02:17 de.eq3.cbcs.lib.remotecommadapter.device.service.AccessPointWatchdog INFO  [vert.x-eventloop-thread-5] SYSTEM: Access Point Watchdog running periodic connection check... 
Apr 5 16:07:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 16:07:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 16:07:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 16:12:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: 0 Accesspoints in Queue 
Apr 5 16:12:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Apr 5 16:12:17 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-7] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Apr 5 16:12:17 de.eq3.cbcs.lib.remotecommadapter.device.service.AccessPointWatchdog INFO  [vert.x-eventloop-thread-5] SYSTEM: Access Point Watchdog running periodic connection check... 

Hilfe wäre Klasse.

Gruß,
Tom

[deimos]

Hi,

im Log:

Code: Alles auswählen

Duty cycle fully used

Ich schreibe jetzt hier erstmal keinen Roman, die Suchfunktion dürfte helfen. Falls nicht, oder konkrete Fragen auftauchen, dann gerne melden.

Viele Grüße
Alex

[Darth.Weber]

Hi, danke, wenn ich es richtig verstanden habe, komme ich wohl um das systematische Herausschmeißen nicht herum, ohne den Übeltäter zu finden.

Einige Fragen dazu:

1. Vorab würde ich gerne das viewtopic.php?f=31&t=35097&hilit=Duty+cycle Script installieren, um den aktuellen Wert zu monitoren. Welche Version ist da für pivccu3 am besten ? Scheinbar brauchen die Diagramme ja einen externen USB Stick, leider habe ich den nicht und alle USB Ports sind belegt :-/ CuxD habe ich installiert, aber ver3 liefert mit abwechseln (im Testmodus) DC=0 und dann DC=100

2. Habe ich es richtig verstanden, dass man die Geräte "nur" in pivccu löschen muss ? Und wie lange muss ich warten, bis sich der DC wieder beruhigt oder reicht dann einfach ein Neustart der pivccu ?

Danke,
Tom

[klassisch]

Ad 1: Ich nutze die Methode über CUxD. Das war für mich die erste, bei der ich diese TCL Scripte vermeiden konnte. Die Scripter hier machen eine prima Arbeit aber ich kenne mich mit TCL nicht aus und vermeide es deshalb. Die Einrichtung ist im CUxD Handbuch beschrieben. Habe hier die Handbuch-Version 2.1 und dort 6.16. Im CuxD ein CUX9000000x wrapper device anlegen und im CUxD Setup

Code: Alles auswählen

STARTUPCMD=extra/dutycycle start

eintragen.
Dann im CCU WebUI das neue Gerät aus dem Postfach holen. Für die CCU und jedes LAN-GW (falls vorhanden) extra.
Das Logging mache ich mit ioBroker. Die Logging-Methoden der CCU kenne ich deshalb nicht persönlich.

Ad 2: Das mit dem Löschen der Geräte habe ich nicht verstanden. Ich würde die Geräte physikalisch nacheinander abschalten. Batterie raus, vom Strom abklemmen. Dann senden die nichts mehr.
Und dann gibt es noch die Möglichkeit, das Logging der CCU auf den rfd (HF-Einheit) zu verstärken. Das könnte auch einen Hinweis geben, wo der Funkverkehr herkommt. Bastler können ein C1101 Modul und einen Arduino als sniffer verwenden. Oder ein SDR.
Bei mir generiert jeder Neustart kumulativ ca. 40% DC. Neustarts sind also kontraproduktiv, wiederholte Neustarts führen zur roten DC-Karte. Und dann gilt game over für ca. 1h. Das ist wohl der Bemessungszeitraum für den DC.

[Fonzo]

wenn ich es richtig verstanden habe, komme ich wohl um das systematische Herausschmeißen nicht herum, ohne den Übeltäter zu

Falls nicht schon geschehen würde ich in einem ersten Schritt Homematic Extended installieren und den Duty Cycle als Variable in IP-Symcon loggen, so das Du zumindest schon mal siehst wann das Phänomen auftritt. Funktioniert ohne Umwege ab IP-Symcon 4.1, bei kleineren IP-Symcon Versionen müsstest Du ein kleines Skript ausführen um den Duty Cycle in IP-Symcon auszulesen und aufzuzeichnen. Danach kannst Du Dich auf die Suche nach dem einzelnen Verursacher machen.

[Darth.Weber]

Irgendwie komme ich nicht weiter. CuxD habe ich gestern installiert und dort wie im Kap 6.16 den DC ausgewertet, aber ich bekomme immer 0%:

Code: Alles auswählen

USB 1-1 - (2514) [HUB] - Sun Apr  7 06:08:16 2019
  USB 1-1.1 - (2514) [HUB] - Sun Apr  7 06:08:16 2019
  USB 1-1.1.1 - (7800) [FF] - no driver - Sun Apr  7 06:08:16 2019
  USB 1-1.1.2 - USB 2.0 Hub [MTT] [HUB] - Sun Apr  7 06:08:16 2019
  USB 1-1.1.2.4 - RTL2838UHIDIR [FF] - no driver - Sun Apr  7 06:08:16 2019
  USB 1-1.2 - FT2232H device [FF] - no tty - Sun Apr  7 06:08:16 2019
  USB 1-1.2+1 - FT2232H device [FF] - no tty - Sun Apr  7 06:08:16 2019
  USB 1-1.3 - ChromoFlex USB [FF] - no tty - Sun Apr  7 06:08:16 2019
  Kein TTY-Device connected!

  Erfolgreich mit HomeMatic-CCU 127.0.0.1:8183 verbunden!

  als RPC-Server(INIT) von HomeMatic-CCU (2760) angefordert!

  Diese Web-Seite wurde aufgerufen von: 192.168.178.21

  CUxD-Uptime(2.2.0):     0 Tag(e) 00:02:30, 49712 Bytes belegt, Compiled Dec  5 2018 16:02:32
  CCU-Uptime(3.43.16):    2 Tag(e) 21:49:38, load-average: 0.34 0.48 0.56, 10s-cpu-load: 8.4%
  Speicher:  Total 949444k  Used 896276k  Free 53168k  (Cached 191204k)
  CPU(1): ARMv7 Processor rev 4 (v7l) [38.40 bogomips]
  CPU(2): ARMv7 Processor rev 4 (v7l) [38.40 bogomips]
  CPU(3): ARMv7 Processor rev 4 (v7l) [38.40 bogomips]
  CPU(4): ARMv7 Processor rev 4 (v7l) [38.40 bogomips]
  Linux version 4.14.98-v7+ (dom@dom-XPS-13-9370) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1200 SMP Tue Feb 12 20:27:48 GMT 2019
  aktive CCU-Prozesse: ReGaHss(1) rfd(1) hs485d(0) java(1)
  RFD-DutyCycle(-132s): (HEQ0400002) (Lan Interface) = 0%
  RFD-DutyCycle(-132s): (IEQ0245542) (Lan Interface) = 0%

  Filesystem: /                  ext4     (rw) Total   15238144k  Used    8935676k (58.6%)  Free    6302468k (41.4%)
  Filesystem: /tmp               tmpfs    (rw) Total     474720k  Used        112k ( 0.0%)  Free     474608k (100.0%)
  Filesystem: /var               ext4     (rw) Total   15238144k  Used    8935676k (58.6%)  Free    6302468k (41.4%)
  Filesystem: /media             ext4     (rw) Total   15238144k  Used    8935676k (58.6%)  Free    6302468k (41.4%)
  Filesystem: /run               tmpfs    (rw) Total     474720k  Used          0k ( 0.0%)  Free     474720k (100.0%)
  Filesystem: /dev/shm           tmpfs    (rw) Total      16384k  Used          0k ( 0.0%)  Free      16384k (100.0%)
  Filesystem: /usr/local         ext4     (rw) Total   15238144k  Used    8935676k (58.6%)  Free    6302468k (41.4%)

  CCU-MAC:     CA:A6:AA:DB:18:4C
  HM-Config:   /etc/config/homematic.regadom(1181560) OK! - Sat Apr  6 19:26:01 2019
  CUxD-Config: /tmp/cuxd.ps.sav(136) - D - Sun Apr  7 06:08:16 2019
               /usr/local/addons/cuxd/cuxd.ps(136) - D - Sun Apr  7 06:08:16 2019
               /usr/local/addons/cuxd/cuxd.ps.bak(136) - D - Sun Apr  7 05:45:17 2019

  aktuelle Parameter: (* = bei Änderung Neustart erforderlich)

	*LISTENPORT      '8700'
	*HM-HOST         '127.0.0.1'
	*HM-SCRIPT-PORT  '' -> (8183)
	*HM-REGA-PORT    '' -> (31999)
	*RPCHOST         '127.0.0.1'
	*RPCPORT         '8701'
	 HTTP-REFRESH    '5'
	 TERMINALLINES   '25'
	 RCVLOGSIZE      '10000'
	 CUXINITCMD      'X21'
	 LOGFILE         ''
	 LOGLEVEL        '1'
	 LOGSIZE         '1000000'
	 LOGFILEMOVE     ''
	 DEVLOGFILE      ''
	 DEVLOGSIZE      '100000'
	 DEVLOGMOVE      ''
	 DEVLOGMOVE-HR   ''
	 DEVLOGEXPORT    ''
	 DEVTIMEFORMAT   '%Y-%m-%dT%X'
	 DEVDATAFORMAT   ''
	 DEVLOGOLDALIAS  '0'
	 SUBSCRIBE-RF    '1'
	 SUBSCRIBE-WR    '1'
	 AUTOSAVE        '1'
	 MOUNTCMD        ''
	 UMOUNTCMD       ''
	 BACKUPCMD       ''
	 SYSLOGMOVE      ''
	 SYSLOGMOVEDAILY ''
	 TH-DIR          ''
	 TH-DIR-FILTER   ''
	 ADDRESS-BUFFER  '120'
	 CLOUDMATIC_CMD  '/etc/config/addons/mh/cloudmatic'
	 WEBCAMCONFIG    '/usr/local/addons/cuxd/webcamconfig.ini'
	 WEBCAMSNAPSHOT  '/tmp/snapshots'
	 WEBCAMCACHE     '/tmp/webcams'
	 SYSLOGFILENAME  '/var/log/messages'
	 CUXD-CHARTS     '/etc/config/addons/www/cuxchart/index.html'
	 DFU_ERASE       './dfu-programmer $TARGET$ erase'
	 DFU_FLASH       './dfu-programmer $TARGET$ flash $HEXFILE$'
	 DFU_START       './dfu-programmer $TARGET$ start'


  Aktuelle Geräteeinstellungen - 1 Gerät(e), 1 Channel(s):

  	CUX9000001:	CCU((null),'OEQ0608343.')-> dp('STATE') samples(2)


  gefundene Adressen (aktuelle zuerst 06:10:46):

Leider bin ich auch gar nicht mehr sicher, ob meine HM-MOD-RPI-PCB eingebunden ist - jedenfalls bekomme ich dafür kein DC (siehe oben). Beißt sich das mit dem Chromoflex-Eintrag ? Der hängt am USB und arbeitet.

pivccu-info

Code: Alles auswählen

piVCCU version: 3.43.16-20
Kernel modules: Available
Raw UART dev:   Available
Rasp.Pi3 UART:  Assigned to GPIO pins
HMRF Hardware:  HM-MOD-RPI-PCB
HMIP Hardware:  HM-MOD-RPI-PCB
Board serial:   OEQ0608343
Radio MAC:      0x59dd79
SGTIN:          3014F711A061A7D70992B057
State:          RUNNING
PID:            19129
IP:             192.168.178.44
IP:             2003:c1:fbca:4700:c8a6:aaff:fedb:184c
CPU use:        495.03 seconds
BlkIO use:      151.79 MiB
Link:           vethDRR2AT
 TX bytes:      64.15 MiB
 RX bytes:      70.68 MiB
 Total bytes:   134.84 MiB

[klassisch]

Seltsam ist, daß bei Dir die beiden Teilnehmer denselben Namen (Lan Interface) haben

Code: Alles auswählen

RFD-DutyCycle(-132s): (HEQ0400002) (Lan Interface) = 0%
  RFD-DutyCycle(-132s): (IEQ0245542) (Lan Interface) = 0%

Bei mir stehen da verschiedene Namen. Und einer davon hat die Seriennummer des HM-MOD-RPI-PCB, was bei Dir nicht der Fall ist.

[Darth.Weber]

Das ist wohl i.O.: Ich habe zwei hmlan Konfigurationsadapter. Allerdings vermisse ich den Eintrag des pcb Moduls, ich habe hier 3 Ausgaben erwartet.

[deimos]

Hi,

hattest du irgendwann mal YAHM im Einsatz? Wie sieht deine /etc/config/rfd.conf aus?

Viele Grüße
Alex

[Darth.Weber]

Sorry, war im Uralub.

ja, yahm war mal drauf - dann aber runtergeschmissen. Die rfd.conf (keys rausgenommen):

# This File was automatically generated
# TCP Port for XmlRpc connections
Listen Port = 32001

Log Destination = Syslog
Log Identifier = rfd

Persist Keys = 1

#PID File = /var/rfd.pid
#UDS File = /var/socket_rfd

Device Description Dir = /firmware/rftypes
Device Files Dir = /etc/config/rfd
Address File = /etc/config/ids
Key File = /etc/config/keys
Firmware Dir = /firmware
Replacemap File = /firmware/rftypes/replaceMap/rfReplaceMap.xml





[Interface 1]
Type = Lan Interface
Name = AZ Sushi
Serial Number = HEQ0400002
Encryption Key = ...
IP Address = 192.168.178.38

[Interface 2]
Type = Lan Interface
Name = Keller
Serial Number = IEQ0245542
Encryption Key = ...