Rückmeldung Geräte erfolgt nicht

thomassch21 · Beitrag von **thomassch21** » 21.01.2018, 14:19

Hallo Ihr,

Ich habe seit einigen Tages das Problem, dass Geräte die über Programme geschalten werden keinen Status mehr liefern.
So habe ich einen Lichtschalter der über ein Programm einen Schaltaktor einschaltet. Das Einschalten geht, allerdings liefert der
Schaltaktor HM-LC-Sw1-FM keine Rückmeldung EIN ! und damit können einige andere Programme das nicht mehr erkennen.

Ich habe versucht das neueste Image zu nehmen - genau der gleiche Effekt!

Kann mir jemand einen Tipp geben wo ich als nächsten suchen muss????

Rasp. Version: 2.2923.2017-1118
Rasp. Version: 2.3125.2018-0120

lg
Thomas

Familienvater · Beitrag von **Familienvater** » 21.01.2018, 15:59

Hi,

es klingt ein bisschen danach, das der Schnittstellenprozess neu gestartet wurde, und die Rega keine Events mehr bekommt, das Schalten an sich ist aber unabhängig davon, ob die Rega sauber als Abonnent registriert ist oder nicht (ich weiß nicht genau, ob die Schnittstellenprozesse evtl. die Verbindung zur Rega trennen könnten, wenn die Rega sich temporär in "Endlosschleifen" festbeißt, und die Events nicht mehr beantwortet, die Rega hängt über BinRPC am rfd, bei XMLRPC wird AFAIK bei 10 nacheinander nicht quittierten Events bekommt der Abonnent keine weiteren Events mehr).
Ich würde mal einen sauberen Neustart der Zentrale über die WebUI machen, und daruf hoffen, das es danach wieder funktioniert. Müsste man mal in das Syslog kurz nach dem Start schauen, ob dort irgendwelche Fehler vom rfd zu sehen sind.

Hast Du irgendwelche Sensoren (z.B. Temperatur), die eigentlich alle 2-3 Minuten Werte melden? Aktualisiert sich da der Zeitstempel in der WebUI?

Der Familienvater

thomassch21 · Beitrag von **thomassch21** » 21.01.2018, 17:27

Danke für den Tipp schaue gleich mal nach...

Ich werde nochmal sauber mit Image installieren und dann mein Backup einspielen. Dann aber erst mal alle Programme deaktivieren um zu sehen ob eines der Scripte in den Programmen Ursache sein kann.

Mir fiel grad auf dass ich in der WebUI auch kein Protokoll sehe obwohl ich Temperatur auf Protokoll gestellt habe.
Die Zeiten bei Änderungen tauchen nur Beisein paar Messwerte auf der Zeitstempel ist aber nicht wirklich aktuell.

Mehr wenn ich nochmal aufgesetzt habe.

Gruß
Thomas

Gesendet von iPhone mit Tapatalk

thomassch21 · Beitrag von **thomassch21** » 21.01.2018, 17:30

Was ich öfters finde:

Code: Alles auswählen

Jan 21 16:45:51 homematic-ccu2 local0.info ReGaHss: Info: error page sent by id #1HTTP/1.1 500 Internal Server Error^M Server: ise GmbH HTTP-Server v2.0^M Accept-Ranges: bytes^M Cache-Control: no-store, no-cache^M Content-Type: text/html; charset=iso-8859-1^M ^M <html><head></head><body><p>Sitzung ungültig oder abgelaufen!^M </p><p><a href="/index.htm">Weiter</a></p></body></html> [httpServer.cpp:168]

Und einmal:

Code: Alles auswählen

Jan 21 16:54:45 homematic-ccu2 daemon.warn cuxd[3736]: rpc_handler() - len(-1) read error!

Familienvater · Beitrag von **Familienvater** » 21.01.2018, 18:06

Hi,

cuxd ist aktuell?

Da die Rega nicht zu meinen Favoriten gehört, würde ich einfach mal tippen, das irgendwo bei Dir noch Browser-Sessions mit alten Session-Ids offen sind, oder hast Du zufällig in Deinem Router eine Portweiterleitung auf die Zentrale eingerichtet?

Der Familienvater

thomassch21 · Beitrag von **thomassch21** » 21.01.2018, 18:38

Ich habe nun alle Programme mit Scripte deaktiviert.
Aktuelles RaspberryMatic Image ganz neu ausgespielt
CuxD ist die aktuelle Version.

Nach dem Start ganz frisch das Log file gezogen und hier abgelegt.
Was mich etwas wundert "XmlRpc transport failed":

Jan 21 18:34:02 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0100446:1","BRIGHTNESS"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:34:02 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:34:02 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:34:04 homematic-raspi user.err rfd: HSSParameter::SetValue() false Put failed
Jan 21 18:34:04 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =setValue Params = {"MEQ0594466:1","STATE",false} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:34:04 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallSetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1502]
Jan 21 18:34:04 homematic-raspi local0.err ReGaHss: Error: IseHssDP::WriteValue: CallSetValue failed; address = MEQ0594466:1 [iseDOMdpHSS.cpp:77]
Jan 21 18:34:09 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...

Code: Alles auswählen

***** messages *****
Jan  1 01:00:15 homematic-raspi syslog.info syslogd started: BusyBox v1.27.2
Jan  1 01:00:15 homematic-raspi user.notice kernel: klogd started: BusyBox v1.27.2 (2018-01-20 09:31:31 CET)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] Booting Linux on physical CPU 0x0
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000] Linux version 4.9.77-v7 (damato@bilbo) (gcc version 6.4.0 (Buildroot 2017.11.1-00806-gd8d7d4e-dirty) ) #1 SMP PREEMPT Sat Jan 20 09:52:03 CET 2018
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] CPU: div instructions available: patching division code
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] OF: fdt:Machine model: Raspberry Pi 3 Model B Rev 1.2
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] cma: Reserved 8 MiB at 0x3ac00000
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] Memory policy: Data cache writealloc
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    0.000000] On node 0 totalpages: 242688
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    0.000000] free_area_init_node: node 0, pgdat 80c6f380, node_mem_map ba3a1000
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    0.000000]   Normal zone: 2133 pages used for memmap
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    0.000000]   Normal zone: 0 pages reserved
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    0.000000]   Normal zone: 242688 pages, LIFO batch:31
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] percpu: Embedded 14 pages/cpu @ba35b000 s25804 r8192 d23348 u57344
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    0.000000] pcpu-alloc: s25804 r8192 d23348 u57344 alloc=14*4096
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 240555
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000] Kernel command line: 8250.nr_uarts=1 bcm2708_fb.fbwidth=1920 bcm2708_fb.fbheight=1080 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  dwc_otg.lpm_enable=0 console=tty2 root=PARTUUID=adab393a-02 ro noswap rootfstype=ext4 elevator=deadline fsck.repair=yes lapic sdhci_bcm2708.enable_llm=0 rootwait rootdelay=5 consoleblank=0 logo.nologo quiet
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] Memory: 940380K/970752K available (7168K kernel code, 469K rwdata, 2012K rodata, 1024K init, 768K bss, 22180K reserved, 8192K cma-reserved)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000] Virtual kernel memory layout:
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]     vmalloc : 0xbb800000 - 0xff800000   (1088 MB)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]     lowmem  : 0x80000000 - 0xbb400000   ( 948 MB)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]     modules : 0x7f000000 - 0x80000000   (  16 MB)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]       .text : 0x80008000 - 0x80800000   (8160 kB)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]       .init : 0x80b00000 - 0x80c00000   (1024 kB)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]       .data : 0x80c00000 - 0x80c75510   ( 470 kB)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.000000]        .bss : 0x80c77000 - 0x80d37274   ( 769 kB)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] Preemptible hierarchical RCU implementation.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] 	Build-time adjustment of leaf fanout to 32.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] NR_IRQS:16 nr_irqs:16 16
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] arm_arch_timer: Architected cp15 timer(s) running at 19.20MHz (phys).
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000006] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000019] Switching to timer-based delay loop, resolution 52ns
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000284] Console: colour dummy device 80x30
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000303] console [tty2] enabled
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000327] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000345] pid_max: default: 32768 minimum: 301
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000659] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.000671] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.001657] Disabling memory control group subsystem
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.001731] CPU: Testing write buffer coherency: ok
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.001769] ftrace: allocating 22264 entries in 66 pages
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.049717] CPU0: update cpu_capacity 1024
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.049733] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.049769] Setting up static identity map for 0x100000 - 0x100034
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.219768] CPU1: update cpu_capacity 1024
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.219777] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.289879] CPU2: update cpu_capacity 1024
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.289886] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.360008] CPU3: update cpu_capacity 1024
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.360016] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.360120] Brought up 4 CPUs
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.360133] SMP: Total of 4 processors activated (153.60 BogoMIPS).
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.360139] CPU: All CPU(s) started in HYP mode.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.360144] CPU: Virtualization extensions available.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.361008] devtmpfs: initialized
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.373963] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.374264] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.374282] futex hash table entries: 1024 (order: 4, 65536 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.374857] pinctrl core: initialized pinctrl subsystem
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.375848] NET: Registered protocol family 16
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.378423] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.388168] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.388176] hw-breakpoint: maximum watchpoint size is 8 bytes.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.390431] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    0.391817] irq: no irq domain found for /soc/aux@0x7e215000 !
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.481338] bcm2835-dma 3f007000.dma: DMA legacy API manager at bb80f000, dmachans=0x1
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.483360] SCSI subsystem initialized
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.483531] usbcore: registered new interface driver usbfs
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.483616] usbcore: registered new interface driver hub
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.483723] usbcore: registered new device driver usb
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.490167] raspberrypi-firmware soc:firmware: Attached to firmware from 2018-01-17 17:13
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.491831] clocksource: Switched to clocksource arch_sys_counter
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.547551] VFS: Disk quotas dquot_6.6.0
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.547633] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.547866] FS-Cache: Loaded
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.548133] CacheFiles: Loaded
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.561859] NET: Registered protocol family 2
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.562838] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.562948] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.563134] TCP: Hash tables configured (established 8192 bind 8192)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.563226] UDP hash table entries: 512 (order: 2, 16384 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.563269] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.563494] NET: Registered protocol family 1
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.563978] RPC: Registered named UNIX socket transport module.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.563984] RPC: Registered udp transport module.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.563990] RPC: Registered tcp transport module.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.563995] RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.565205] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.567732] workingset: timestamp_bits=14 max_order=18 bucket_order=4
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.585207] FS-Cache: Netfs 'nfs' registered for caching
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.586278] NFS: Registering the id_resolver key type
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.586310] Key type id_resolver registered
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    0.586316] Key type id_legacy registered
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.588953] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.589078] io scheduler noop registered
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.589086] io scheduler deadline registered (default)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.589364] io scheduler cfq registered
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.595704] BCM2708FB: allocated DMA memory fad10000
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.595731] BCM2708FB: allocated DMA channel 0 @ bb80f000
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.647976] Console: switching to colour frame buffer device 240x67
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.678620] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
Jan  1 01:00:15 homematic-raspi user.err kernel: [    0.680332] bcm2835-aux-uart 3f215040.serial: could not get clk: -517
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.681714] bcm2835-rng 3f104000.rng: hwrng registered
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.681926] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.682529] vc-sm: Videocore shared memory driver
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.699278] brd: module loaded
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.709031] loop: module loaded
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.709046] Loading iSCSI transport class v2.0-870.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.709629] usbcore: registered new interface driver smsc95xx
Jan  1 01:00:15 homematic-raspi user.info kernel: [    0.709647] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    0.937760] Core Release: 2.80a
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    0.937777] Setting default values for core params
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    0.937806] Finished setting default values for core params
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138213] Using Buffer DMA mode
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138220] Periodic Transfer Interrupt Enhancement - disabled
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138226] Multiprocessor Interrupt Enhancement - disabled
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138234] OTG VER PARAM: 0, OTG VER FLAG: 0
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138244] Dedicated Tx FIFOs mode
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138675] WARN::dwc_otg_hcd_init:1032: FIQ DMA bounce buffers: virt = 0xbad04000 dma = 0xfad04000 len=9024
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138702] FIQ FSM acceleration enabled for :
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138702] Non-periodic Split Transactions
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138702] Periodic Split Transactions
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138702] High-Speed Isochronous Endpoints
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138702] Interrupt/Control Split Transaction hack enabled
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    1.138710] dwc_otg: Microframe scheduler enabled
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138763] WARN::hcd_init_fiq:459: FIQ on core 1 at 0x8059bb7c
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138774] WARN::hcd_init_fiq:460: FIQ ASM at 0x8059bedc length 36
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138786] WARN::hcd_init_fiq:486: MPHI regs_base at 0xbb87a000
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.138852] dwc_otg 3f980000.usb: DWC OTG Controller
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.138889] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.138923] dwc_otg 3f980000.usb: irq 62, io mem 0x00000000
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138973] Init: Port Power? op_state=1
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.138978] Init: Power Port (0)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.139234] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.139247] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.139256] usb usb1: Product: DWC OTG Controller
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.139265] usb usb1: Manufacturer: Linux 4.9.77-v7 dwc_otg_hcd
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.139274] usb usb1: SerialNumber: 3f980000.usb
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.140222] hub 1-0:1.0: USB hub found
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.140268] hub 1-0:1.0: 1 port detected
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    1.140957] dwc_otg: FIQ enabled
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    1.140964] dwc_otg: NAK holdoff enabled
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    1.140969] dwc_otg: FIQ split-transaction FSM enabled
Jan  1 01:00:15 homematic-raspi user.debug kernel: [    1.140984] Module dwc_common_port init
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.141253] usbcore: registered new interface driver usb-storage
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.141505] mousedev: PS/2 mouse device common for all mice
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.142657] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.142963] bcm2835-cpufreq: min=600000 max=1200000
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.143524] sdhci: Secure Digital Host Controller Interface driver
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.143530] sdhci: Copyright(c) Pierre Ossman
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.143841] sdhost-bcm2835 3f202000.sdhost: could not get clk, deferring probe
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.146068] mmc-bcm2835 3f300000.mmc: could not get clk, deferring probe
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.146175] sdhci-pltfm: SDHCI platform and OF driver helper
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.149922] hidraw: raw HID events driver (C) Jiri Kosina
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.150031] usbcore: registered new interface driver usbhid
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.150034] usbhid: USB HID core driver
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.150638] vchiq: vchiq_init_state: slot_zero = 0xbad80000, is_master = 0
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.152676] [vc_sm_connected_init]: start
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.161714] [vc_sm_connected_init]: end - returning 0
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.161996] ip_tables: (C) 2000-2006 Netfilter Core Team
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.162035] Initializing XFRM netlink socket
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.162052] NET: Registered protocol family 17
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    1.162130] Key type dns_resolver registered
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    1.162431] Registering SWP/SWPB emulation handler
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.162863] registered taskstats version 1
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.168351] 3f215040.serial: ttyS0 at MMIO 0x0 (irq = 220, base_baud = 31250000) is a 16550
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.168812] sdhost: log_buf @ bad07000 (fad07000)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.241843] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.243907] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.243912] mmc-bcm2835 3f300000.mmc: DMA channel allocated
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.321915] of_cfs_init
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.321992] of_cfs_init: OK
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.322487] Waiting 5 sec before mounting root device...
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.339478] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.340989] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.342500] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.345212] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.351925] Indeed it is in host mode hprt0 = 00021501
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.372910] mmc0: host does not support reading read-only switch, assuming write-enable
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.375898] mmc0: new high speed SDHC card at address aaaa
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.376421] mmcblk0: mmc0:aaaa SC16G 14.8 GiB
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.378701]  mmcblk0: p1 p2 p3
Jan  1 01:00:15 homematic-raspi user.notice kernel: [    1.395396] random: fast init done
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.435632] mmc1: new high speed SDIO card at address 0001
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.551848] usb 1-1: new high-speed USB device number 2 using dwc_otg
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    1.551987] Indeed it is in host mode hprt0 = 00001101
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.782152] usb 1-1: New USB device found, idVendor=0424, idProduct=9514
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.782165] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.783058] hub 1-1:1.0: USB hub found
Jan  1 01:00:15 homematic-raspi user.info kernel: [    1.783154] hub 1-1:1.0: 5 ports detected
Jan  1 01:00:15 homematic-raspi user.info kernel: [    2.101866] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
Jan  1 01:00:15 homematic-raspi user.info kernel: [    2.232154] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
Jan  1 01:00:15 homematic-raspi user.info kernel: [    2.232166] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jan  1 01:00:15 homematic-raspi user.info kernel: [    2.235008] smsc95xx v1.0.5
Jan  1 01:00:15 homematic-raspi user.info kernel: [    2.325894] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:40:e1:c1
Jan  1 01:00:15 homematic-raspi user.info kernel: [    6.411115] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Jan  1 01:00:15 homematic-raspi user.info kernel: [    6.411171] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Jan  1 01:00:15 homematic-raspi user.info kernel: [    6.414658] devtmpfs: mounted
Jan  1 01:00:15 homematic-raspi user.info kernel: [    6.416314] Freeing unused kernel memory: 1024K
Jan  1 01:00:15 homematic-raspi user.warn kernel: [    6.954042] EXT4-fs: Warning: mounting with data=journal disables delayed allocation and O_DIRECT support!
Jan  1 01:00:15 homematic-raspi user.info kernel: [    6.985110] EXT4-fs (mmcblk0p3): mounted filesystem with journalled data mode. Opts: data=journal
Jan  1 01:00:15 homematic-raspi user.info kernel: [    7.143668] i2c /dev entries driver
Jan  1 01:00:15 homematic-raspi user.info kernel: [    7.187235] tun: Universal TUN/TAP device driver, 1.6
Jan  1 01:00:15 homematic-raspi user.info kernel: [    7.187245] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
Jan  1 01:00:15 homematic-raspi user.warn kernel: [   11.975632] bcm2835_raw_uart: loading out-of-tree module taints kernel.
Jan  1 01:00:15 homematic-raspi user.info kernel: [   11.977568] bcm2835_raw_uart: Driver successfully loaded for uart0_base=0x3f201000, uart0_irq=87.
Jan  1 01:00:15 homematic-raspi daemon.info kernel: [   15.932815] udevd[233]: starting version 3.2.4
Jan  1 01:00:15 homematic-raspi daemon.info kernel: [   15.962704] udevd[234]: starting eudev-3.2.4
Jan  1 01:00:16 homematic-raspi user.info kernel: [   16.092168] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
Jan  1 01:00:16 homematic-raspi user.info kernel: [   16.295982] usbcore: registered new interface driver brcmfmac
Jan  1 01:00:16 homematic-raspi user.info kernel: [   16.408800] brcmfmac: Firmware version = wl0: Aug 29 2016 20:48:16 version 7.45.41.26 (r640327) FWID 01-4527cfab
Jan  1 01:00:16 homematic-raspi user.err kernel: [   16.409467] brcmfmac: brcmf_c_preinit_dcmds: CLM version = API: 12.2 Data: 7.11.15 Compiler: 1.24.2 ClmImport: 1.24.1 Creation: 2014-05-26 10:53:55 Inc Data: 9.6.3 Inc Compiler: 1.29.4 Inc ClmImport: 1.31.4 Creation: 2016-08-29 20:46:38 
Jan  1 01:00:16 homematic-raspi user.notice kernel: [   16.616904] random: crng init done
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.352520] Bluetooth: Core ver 2.22
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.352618] NET: Registered protocol family 31
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.352625] Bluetooth: HCI device and connection manager initialized
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.352648] Bluetooth: HCI socket layer initialized
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.352663] Bluetooth: L2CAP socket layer initialized
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.352709] Bluetooth: SCO socket layer initialized
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.363704] Bluetooth: HCI UART driver ver 2.3
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.363721] Bluetooth: HCI UART protocol H4 registered
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.363728] Bluetooth: HCI UART protocol Three-wire (H5) registered
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.363944] Bluetooth: HCI UART protocol Broadcom registered
Jan  1 01:00:21 homematic-raspi daemon.info bluetoothd[322]: Bluetooth daemon 5.47
Jan  1 01:00:21 homematic-raspi daemon.info bluetoothd[322]: Starting SDP server
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.501234] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.501249] Bluetooth: BNEP filters: protocol multicast
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.501274] Bluetooth: BNEP socket layer initialized
Jan  1 01:00:21 homematic-raspi daemon.info bluetoothd[322]: Bluetooth management interface 1.14 initialized
Jan  1 01:00:21 homematic-raspi daemon.err bluetoothd[322]: Failed to set privacy: Rejected (0x0b)
Jan  1 01:00:21 homematic-raspi user.info kernel: [   21.634353] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
Jan  1 01:00:23 homematic-raspi user.info kernel: [   23.142212] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0xC1E1
Jan  1 01:00:26 homematic-raspi daemon.err udhcpc[363]: started, v1.27.2
Jan  1 01:00:26 homematic-raspi daemon.err udhcpc[363]: sending discover
Jan  1 01:00:26 homematic-raspi daemon.err udhcpc[363]: sending select for 192.168.2.112
Jan  1 01:00:26 homematic-raspi daemon.err udhcpc[363]: lease of 192.168.2.112 obtained, lease time 864000
Jan  1 01:00:27 homematic-raspi user.info kernel: [   27.155161] NET: Registered protocol family 10
Jan  1 01:00:27 homematic-raspi user.info kernel: [   27.338024] ip6_tables: (C) 2000-2006 Netfilter Core Team
Jan  1 01:00:27 homematic-raspi user.info firewall: configuration set
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(eth0)[433]: ifplugd 0.28 initializing.
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(eth0)[433]: Using interface eth0/B8:27:EB:40:E1:C1 with driver <smsc95xx> (version: 22-Aug-2005)
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(eth0)[433]: Using detection mode: SIOCETHTOOL
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(eth0)[433]: Initialization complete, link beat detected.
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(wlan0)[437]: ifplugd 0.28 initializing, using NETLINK device monitoring.
Jan  1 01:00:27 homematic-raspi user.info kernel: [   27.586850] brcmfmac: power management disabled
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(wlan0)[437]: Using interface wlan0/B8:27:EB:15:B4:94 with driver <brcmfmac> (version: 7.45.41.26)
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(wlan0)[437]: Using detection mode: wireless extension
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(wlan0)[437]: Initialization complete, link beat not detected, interface enabled.
Jan  1 01:00:27 homematic-raspi user.info kernel: [   27.594382] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(eth0)[433]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Jan  1 01:00:27 homematic-raspi daemon.warn ifplugd(eth0)[433]: client: ifup: interface eth0 already configured
Jan  1 01:00:27 homematic-raspi daemon.err ifplugd(wlan0)[437]: NLAPI: Packet too small or truncated!
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(wlan0)[437]: Exiting.
Jan  1 01:00:27 homematic-raspi daemon.info ifplugd(eth0)[433]: Program executed successfully.
Jan 21 18:32:39 homematic-raspi daemon.notice ntpdate[444]: step time server 85.220.190.246 offset 1516555924.927007 sec
Jan 21 18:32:39 homematic-raspi daemon.notice ntpd[446]: ntpd 4.2.8p10@1.3728-o Sat Jan 20 08:44:06 UTC 2018 (1): Starting
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[446]: Command line: /usr/sbin/ntpd -g 0.de.pool.ntp.org
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[448]: proto: precision = 1.093 usec (-20)
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[448]: Listen and drop on 0 v6wildcard [::]:123
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[448]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[448]: Listen normally on 2 lo 127.0.0.1:123
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[448]: Listen normally on 3 eth0 192.168.2.112:123
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[448]: Listen normally on 4 lo [::1]:123
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[448]: Listen normally on 5 eth0 [fe80::ba27:ebff:fe40:e1c1%2]:123
Jan 21 18:32:39 homematic-raspi daemon.info ntpd[448]: Listening on routing socket on fd #22 for interface updates
Jan 21 18:32:39 homematic-raspi daemon.err xinetd[469]: Unable to read included directory: /etc/config/xinetd.d [file=/etc/xinetd.conf] [line=14]
Jan 21 18:32:39 homematic-raspi daemon.crit xinetd[469]: 469 {init_services} no services. Exiting...
Jan 21 18:32:39 homematic-raspi auth.info sshd[493]: Server listening on 0.0.0.0 port 22.
Jan 21 18:32:39 homematic-raspi auth.info sshd[493]: Server listening on :: port 22.
Jan 21 18:32:39 homematic-raspi user.info root: Updating RF Lan Gateway Coprocessor Firmware
Jan 21 18:32:40 homematic-raspi user.debug update-coprocessor: firmware filename is: coprocessor_update_hm_only.eq3
Jan 21 18:32:40 homematic-raspi user.info update-coprocessor: performGatewayCoproUpdate(): updating LEQ0602292
Jan 21 18:32:42 homematic-raspi user.info update-coprocessor: Lan Device Information: Protocol-Version: 1 Product-ID: eQ3-HM-LGW Firmware-Version: 1.1.5 Serial Number: LEQ0602292
Jan 21 18:32:42 homematic-raspi user.info update-coprocessor: Lan Device Information: Protocol-Version: 1 Product-ID: eQ3-HM-LGW Firmware-Version: 1.1.5 Serial Number: LEQ0602292
Jan 21 18:32:43 homematic-raspi user.debug update-coprocessor: (LEQ0602292) CCU2CommControllerMod::handleIdentifyEvent(): Coprocessor is in application.
Jan 21 18:32:43 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::CCU2CoprocessorCommandMod(): System frame
Jan 21 18:32:43 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::isResponseStatusOk(): System status OK
Jan 21 18:32:43 homematic-raspi user.debug update-coprocessor: CCU2CommControllerMod::handleIncomingResponse() System response OK
Jan 21 18:32:43 homematic-raspi user.debug update-coprocessor: (LEQ0602292) CCU2CommControllerMod::handleIdentifyEvent(): Coprocessor is in application.
Jan 21 18:32:43 homematic-raspi user.debug update-coprocessor: CoprocessorUpdate::startApplication():Coprocessor entered application.
Jan 21 18:32:44 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::CCU2CoprocessorCommandMod(): System frame
Jan 21 18:32:44 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::isResponseStatusOk(): System status OK
Jan 21 18:32:44 homematic-raspi user.debug update-coprocessor: CCU2CommControllerMod::handleIncomingResponse() System response OK
Jan 21 18:32:44 homematic-raspi user.info update-coprocessor: Version: 1.4.1
Jan 21 18:32:44 homematic-raspi user.info update-coprocessor: Coprocessor firmware not necessary.
Jan 21 18:32:44 homematic-raspi user.info update-coprocessor: performGatewayCoproUpdate(): updating OEQ0016327
Jan 21 18:32:45 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::CCU2CoprocessorCommandMod(): Bidcos frame
Jan 21 18:32:46 homematic-raspi user.info update-coprocessor: Lan Device Information: Protocol-Version: 1 Product-ID: eQ3-HM-LGW Firmware-Version: 1.1.5 Serial Number: OEQ0016327
Jan 21 18:32:46 homematic-raspi user.info update-coprocessor: Lan Device Information: Protocol-Version: 1 Product-ID: eQ3-HM-LGW Firmware-Version: 1.1.5 Serial Number: OEQ0016327
Jan 21 18:32:47 homematic-raspi user.debug update-coprocessor: (OEQ0016327) CCU2CommControllerMod::handleIdentifyEvent(): Coprocessor is in application.
Jan 21 18:32:47 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::CCU2CoprocessorCommandMod(): System frame
Jan 21 18:32:47 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::isResponseStatusOk(): System status OK
Jan 21 18:32:47 homematic-raspi user.debug update-coprocessor: CCU2CommControllerMod::handleIncomingResponse() System response OK
Jan 21 18:32:47 homematic-raspi user.debug update-coprocessor: (OEQ0016327) CCU2CommControllerMod::handleIdentifyEvent(): Coprocessor is in application.
Jan 21 18:32:47 homematic-raspi user.debug update-coprocessor: CoprocessorUpdate::startApplication():Coprocessor entered application.
Jan 21 18:32:48 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::CCU2CoprocessorCommandMod(): System frame
Jan 21 18:32:48 homematic-raspi user.debug update-coprocessor: CCU2CoprocessorCommandMod::isResponseStatusOk(): System status OK
Jan 21 18:32:48 homematic-raspi user.debug update-coprocessor: CCU2CommControllerMod::handleIncomingResponse() System response OK
Jan 21 18:32:48 homematic-raspi user.info update-coprocessor: Version: 1.4.1
Jan 21 18:32:48 homematic-raspi user.info update-coprocessor: Coprocessor firmware not necessary.
Jan 21 18:32:48 homematic-raspi user.info root: Updating RF Lan Gateway Firmware
Jan 21 18:32:48 homematic-raspi user.info update-lgw-firmware: LAN Gateway Firmware Update...
Jan 21 18:32:48 homematic-raspi user.info update-lgw-firmware: Gateway LEQ0602292
Jan 21 18:32:50 homematic-raspi user.info update-lgw-firmware: Gateway type is eQ3-HM-LGW-App
Jan 21 18:32:50 homematic-raspi user.info update-lgw-firmware: Available Firmware Version:   1.1.5
Jan 21 18:32:50 homematic-raspi user.info update-lgw-firmware: Lan Gateway Firmware Version: 1.1.5
Jan 21 18:32:50 homematic-raspi user.info update-lgw-firmware: Firmware is up to date
Jan 21 18:32:50 homematic-raspi user.info update-lgw-firmware: LAN Gateway Firmware Update...
Jan 21 18:32:50 homematic-raspi user.info update-lgw-firmware: Gateway OEQ0016327
Jan 21 18:32:52 homematic-raspi user.info update-lgw-firmware: Gateway type is eQ3-HM-LGW-App
Jan 21 18:32:52 homematic-raspi user.info update-lgw-firmware: Available Firmware Version:   1.1.5
Jan 21 18:32:52 homematic-raspi user.info update-lgw-firmware: Lan Gateway Firmware Version: 1.1.5
Jan 21 18:32:52 homematic-raspi user.info update-lgw-firmware: Firmware is up to date
Jan 21 18:32:52 homematic-raspi user.info root: Updating Wired Lan Gateway Firmware
Jan 21 18:32:52 homematic-raspi user.info update-lgw-firmware: No gateway found in config file /etc/config/hs485d.conf
Jan 21 18:32:55 homematic-raspi daemon.info snmpd[611]: Created directory: /var/lib/snmp
Jan 21 18:32:55 homematic-raspi daemon.info snmpd[611]: Created directory: /var/lib/snmp/cert_indexes
Jan 21 18:32:55 homematic-raspi daemon.info snmpd[611]: Created directory: /var/lib/snmp/mib_indexes
Jan 21 18:32:55 homematic-raspi daemon.info snmpd[611]: Turning on AgentX master support.
Jan 21 18:32:55 homematic-raspi daemon.info snmpd[613]: NET-SNMP version 5.7.3
Jan 21 18:32:56 homematic-raspi user.info kernel: [   51.176862] eq3loop: created slave ttyS0
Jan 21 18:32:56 homematic-raspi user.info kernel: [   51.177708] eq3loop: created slave mmd_bidcos
Jan 21 18:33:02 homematic-raspi user.info kernel: [   57.579418] eq3loop: eq3loop_open_slave() mmd_bidcos
Jan 21 18:33:05 homematic-raspi cron.err crond[218]: time disparity of 25275932 minutes detected
Jan 21 18:33:21 homematic-raspi user.info kernel: [   76.921212] eq3loop: eq3loop_open_slave() ttyS0
Jan 21 18:33:21 homematic-raspi user.info kernel: [   76.921385] eq3loop: eq3loop_close_slave() ttyS0
Jan 21 18:33:21 homematic-raspi user.info kernel: [   76.931029] eq3loop: eq3loop_open_slave() ttyS0
Jan 21 18:33:21 homematic-raspi user.info kernel: [   76.931165] eq3loop: eq3loop_close_slave() ttyS0
Jan 21 18:33:21 homematic-raspi user.info kernel: [   76.945857] eq3loop: eq3loop_open_slave() ttyS0
Jan 21 18:33:21 homematic-raspi user.notice kernel: [   76.948407] eq3loop: eq3loop_ioctl_slave() ttyS0: unhandled ioctl 0x5459
Jan 21 18:33:21 homematic-raspi user.notice kernel: [   76.948421] eq3loop: eq3loop_ioctl_slave() ttyS0: unhandled ioctl 0x545D
Jan 21 18:33:34 homematic-raspi user.info kernel: [   89.861480] EXT4-fs (mmcblk0p2): re-mounted. Opts: data=ordered
Jan 21 18:33:34 homematic-raspi user.info kernel: [   89.903657] EXT4-fs (mmcblk0p2): re-mounted. Opts: data=ordered
Jan 21 18:33:34 homematic-raspi daemon.info cuxd[855]: write_pid /var/run/cuxd.pid [855]
Jan 21 18:33:34 homematic-raspi user.info homematic: started cux-daemon
Jan 21 18:33:34 homematic-raspi user.notice root: dutycycle.tcl[872] /var/cache/cuxd_dutycycle.txt 120 started
Jan 21 18:33:34 homematic-raspi daemon.info cuxd[855]: system(extra/dutycycle start)
Jan 21 18:33:34 homematic-raspi daemon.info cuxd[855]: CUx-Daemon(1.12) on CCU(2.31.25.20180120) start PID:855
Jan 21 18:33:34 homematic-raspi daemon.info cuxd[855]: load paramsets(/usr/local/addons/cuxd/cuxd.ps) size:882 update(-6081s):Sun Jan 21 16:52:13 2018
Jan 21 18:33:34 homematic-raspi daemon.info cuxd[855]: 2 device-paramset(s) loaded ok!
Jan 21 18:33:34 homematic-raspi daemon.info cuxd[855]: write_proxy /var/cache/cuxd_proxy.ini (855 /usr/local/addons/cuxd/ 1.12 2.31.25.20180120 0)
Jan 21 18:33:34 homematic-raspi daemon.info cuxd[855]: add interface 'CUxD'
Jan 21 18:33:34 homematic-raspi daemon.info cuxd[855]: write 4 interfaces to /usr/local/etc/config/InterfacesList.xml
Jan 21 18:33:44 homematic-raspi user.warn multimac: Coprocessor is busy. Max response retry attempts reached.
Jan 21 18:33:45 homematic-raspi user.warn multimac: Coprocessor is busy. Max response retry attempts reached.
Jan 21 18:33:47 homematic-raspi user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET
Jan 21 18:33:47 homematic-raspi user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.
Jan 21 18:33:47 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0648142:1","STATE"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:47 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:47 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:51 homematic-raspi user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET
Jan 21 18:33:51 homematic-raspi user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0648142:2","STATE"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:51 homematic-raspi user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET
Jan 21 18:33:51 homematic-raspi user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0648142:3","STATE"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:51 homematic-raspi user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET
Jan 21 18:33:51 homematic-raspi user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0648142:4","STATE"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:51 homematic-raspi user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET
Jan 21 18:33:51 homematic-raspi user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0648142:5","STATE"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:51 homematic-raspi user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET
Jan 21 18:33:51 homematic-raspi user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0648142:6","STATE"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:51 homematic-raspi user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET
Jan 21 18:33:51 homematic-raspi user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0648142:7","STATE"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:51 homematic-raspi user.err rfd: RFPhysicalDataInterfaceCommand::GetData SendFrame failed for LEVEL_GET
Jan 21 18:33:51 homematic-raspi user.err rfd: HSSParameter::GetValue() id=STATE failed getting physical value.
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0648142:8","STATE"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:51 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =setValue Params = {"000397098A39EC:1","CONTROL_MODE",0} result= [faultCode:-1,faultString:"Generic error (TIMEOUT)"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallSetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1502]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::WriteValue: CallSetValue failed; address = 000397098A39EC:1 [iseDOMdpHSS.cpp:77]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000C17099A044B:1","PRESENCE_DETECTION_STATE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: PRESENCE_DETECTION_STATE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000915699D3766:0","SABOTAGE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: SABOTAGE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D69:6","CURRENT"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: CURRENT"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi daemon.info cuxd[855]: INIT 'xmlrpc_bin://127.0.0.1:1999' '25914'
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"00109709A3BD83:1","STATE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: STATE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000915699D3772:0","SABOTAGE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: SABOTAGE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D69:6","ENERGY_COUNTER"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:0","DUTY_CYCLE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: DUTY_CYCLE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D69:6","ENERGY_COUNTER_OVERFLOW"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER_OVERFLOW"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:0","LOW_BAT"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: LOW_BAT"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D69:6","FREQUENCY"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: FREQUENCY"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:0","OPERATING_VOLTAGE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: OPERATING_VOLTAGE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D69:6","POWER"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: POWER"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:0","RSSI_DEVICE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: RSSI_DEVICE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D69:6","VOLTAGE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: VOLTAGE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:0","RSSI_PEER"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: RSSI_PEER"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","CURRENT"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: CURRENT"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:0","UNREACH"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: UNREACH"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","ENERGY_COUNTER"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","ENERGY_COUNTER_OVERFLOW"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER_OVERFLOW"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","FREQUENCY"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: FREQUENCY"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","SET_POINT_TEMPERATURE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: SET_POINT_TEMPERATURE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","POWER"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: POWER"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","ACTUAL_TEMPERATURE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: ACTUAL_TEMPERATURE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","VOLTAGE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: VOLTAGE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","SET_POINT_MODE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: SET_POINT_MODE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","PARTY_TIME_START"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: PARTY_TIME_START"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal =  [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","PARTY_TIME_END"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: PARTY_TIME_END"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal =  [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","PARTY_SET_POINT_TEMPERATURE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: PARTY_SET_POINT_TEMPERATURE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","PARTY_MODE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: PARTY_MODE"] [iseXmlRpc.cpp:2605]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:33:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:34:02 homematic-raspi user.err rfd: HSSParameter::GetValue() id=BRIGHTNESS failed getting physical value.
Jan 21 18:34:02 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"MEQ0100446:1","BRIGHTNESS"} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:34:02 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:34:02 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:34:04 homematic-raspi user.err rfd: HSSParameter::SetValue() false Put failed
Jan 21 18:34:04 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =setValue Params = {"MEQ0594466:1","STATE",false} result= [faultCode:-1,faultString:"Failure"] [iseXmlRpc.cpp:2605]
Jan 21 18:34:04 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallSetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1502]
Jan 21 18:34:04 homematic-raspi local0.err ReGaHss: Error: IseHssDP::WriteValue: CallSetValue failed; address = MEQ0594466:1 [iseDOMdpHSS.cpp:77]
Jan 21 18:34:09 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...


***** hmserver.log *****
Jan 21 18:33:15 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] @GenericFactory 
Jan 21 18:33:15 de.eq3.lib.util.dynamics.GenericFactory INFO  [main] creating instance of HMServerConfiguration with no-arg constructor 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [HMIPTRXWriterWorker] (1) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KeyServerWorker] (1) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [KryoPersistenceWorker] (1) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [TransactionSubsystemHandler] (1) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [FirmwareLoaderFileSystem] (1) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerPersistentDataLoader] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerAdapterInitialization] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [BackendCommandHandler] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionAcceptHandler] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [IncomingHMIPFrameHandler] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceBackgroundUpdateSubsystem] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [DeviceInclusionDefaultConfigurationChanger] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [CyclicSmokeDetectorAwakening] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LocalServerFirmwareUpdateInitialization] (1)  
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyNotificationHandler] (1) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyAPIWorker] (1) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBackendNotificationHandler] (3) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyBlindLevelCorrectionHandler] (1) *worker 
Jan 21 18:33:19 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: added for deployment [LegacyInitializion] (1)  
Jan 21 18:33:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: deploying 19 classes to Vert.x 
Jan 21 18:33:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: 19 VertxDeployers initialized 
Jan 21 18:33:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of CyclicSmokeDetectorAwakening succeeded (20c0454a-ac7d-4212-b729-7dde57780136) 
Jan 21 18:33:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-7] SYSTEM: start of DeviceInclusionDefaultConfigurationChanger succeeded (66c9823a-12f8-4bc8-ad3b-5384b5024f37) 
Jan 21 18:33:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LegacyBlindLevelCorrectionHandler succeeded (0f830d19-5421-4f9b-9f83-b6c0cabce553) 
Jan 21 18:33:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of TransactionSubsystemHandler succeeded (7f588451-e6f5-43da-aaee-199a3a4dbabf) 
Jan 21 18:33:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of HMIPTRXWriterWorker succeeded (f52081ff-7d93-438c-b342-81bf6cdd69e5) 
Jan 21 18:33:20 de.eq3.cbcs.server.core.vertx.KeyServerWorker ERROR [vert.x-worker-thread-2] Missing key server configuration parameter (Network.Key) for  mode: KEYSERVER_LOCAL 
Jan 21 18:33:20 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of KeyServerWorker succeeded (aac149f9-3969-49f9-9e7f-d391e5a2ddcd) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of DeviceBackgroundUpdateSubsystem succeeded (538345d6-6b13-4483-8065-72e2eb38411a) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of KryoPersistenceWorker succeeded (01e9506e-dfdb-493d-966c-0e85f5c98737) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of LocalServerPersistentDataLoader succeeded (37bd728e-8243-4e8a-84f7-e2fccf248738) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-6] SYSTEM: start of DeviceInclusionAcceptHandler succeeded (29071b70-be16-4f72-99d7-4888ed850781) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-1] SYSTEM: start of IncomingHMIPFrameHandler succeeded (f4a7f839-a9f4-4f9e-92d1-3c435ba3a2e8) 
Jan 21 18:33:21 de.eq3.cbcs.server.core.otau.util.FirmwareLoaderFileSystem INFO  [vert.x-worker-thread-4] SYSTEM: Firmware update directory is set to /etc/config/firmware 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of FirmwareLoaderFileSystem succeeded (7cf5d549-f960-431a-970e-78564dd93a2f) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of LegacyBackendNotificationHandler succeeded (bebc45f5-7956-4a26-95d4-d3b3b22ae3f9) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of BackendCommandHandler succeeded (36fd255b-db40-416d-b975-26ab277b4aa3) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of LegacyAPIWorker succeeded (0ab8d2d6-ed34-43c7-bc17-f565c624baf9) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-3] SYSTEM: start of LegacyNotificationHandler succeeded (e34d495d-06d5-44f4-a838-0ed9d873db79) 
Jan 21 18:33:21 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LocalServerAdapterInitialization succeeded (57da8ed1-bbc1-43a4-9db3-f6e6804156fc) 
Jan 21 18:33:21 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter state 1: HMIP_TRX_App 
Jan 21 18:33:21 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter application is already running 
Jan 21 18:33:21 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] No NWK, try to set address ... 
Jan 21 18:33:21 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Try to set radio address 11943538... 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Set max send attempts for 3014F711A061A7D7098E0839 to 3 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Try to get application version... 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Application version 2.8.6 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Bootloader version 1.0.3 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] hmos version 1.20.3 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] MCU type: Si1002_8051 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Duty Cycle: 1.0 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] set DutyCycle limit to ffffffc8 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Set Duty Cycle Limit 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Current Security Counter: 196188160 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Update security counter to calculation: 196236312 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] TRX adapter has no linkpartner 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.HMIPTRXInitialResponseListener INFO  [Thread-6] Adapter with Access Point id 3014F711A061A7D7098E0839 initialized 
Jan 21 18:33:22 de.eq3.cbcs.server.local.base.internal.LocalServerAdapterInitialization INFO  [Thread-6] HMIPTRXInitialResponseListener said that Adapter was initialized 
Jan 21 18:33:23 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of LegacyInitializion succeeded (8351a6e4-a3ee-4383-bf07-e623667b0ef3) 
Jan 21 18:33:23 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of LocalServerFirmwareUpdateInitialization succeeded (85d2d14b-f1ad-4ea8-b0ea-bba47332ad41) 
Jan 21 18:33:23 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: Checking all devices on all accesspoints for updates 
Jan 21 18:33:23 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-2] SYSTEM: There are 0 APs queued with updatable devices 
Jan 21 18:33:23 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-0] SYSTEM: initial deployment complete _____________________________________________________ 
Jan 21 18:33:25 de.eq3.ccu.server.HMServer INFO  [Thread-2] Default MaxEventLoopExecuteTime: 2000000000 
Jan 21 18:33:25 de.eq3.ccu.server.HMServer INFO  [Thread-2] Default BlockedThreadCheckInterval: 1000 
Jan 21 18:33:25 de.eq3.ccu.server.HMServer INFO  [Thread-2] Default MaxWorkerExecuteTime: 60000000000 
Jan 21 18:33:25 de.eq3.ccu.server.HMServer INFO  [Thread-2] Default EventLoopPoolSize: 8 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [BackendWorker] (1) *worker 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [GroupRequestWorker] (1) *worker 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [DiagramRequestWorker] (1) *worker 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [StorageRequestWorker] (1) *worker 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [DeviceFirmwareRequestWorker] (1) *worker 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [EnergyPriceRequestWorker] (1) *worker 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: added for deployment [CouplingRequestWorker] (1) *worker 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: deploying 7 classes to Vert.x 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: 7 VertxDeployers initialized 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of EnergyPriceRequestWorker succeeded (5ac36bc0-bda4-49dc-b557-c7283bc8a081) 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-4] SYSTEM: start of BackendWorker succeeded (451a3d52-a9e2-4028-b08e-2cbeecc0b46e) 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of StorageRequestWorker succeeded (23ac5425-cc97-400f-965e-566173d31f5b) 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of CouplingRequestWorker succeeded (75966528-39be-4b37-ae28-ee8be6bfd92d) 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-2] SYSTEM: start of DiagramRequestWorker succeeded (b813bf21-f85b-4d11-8598-87e3239d1710) 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-5] SYSTEM: start of GroupRequestWorker succeeded (b538affc-79bb-47ca-9456-168385c516fe) 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [vert.x-eventloop-thread-0] SYSTEM: start of DeviceFirmwareRequestWorker succeeded (b625298a-8e66-440e-9d0a-55cc63533e87) 
Jan 21 18:33:25 de.eq3.cbcs.vertx.management.VertxManager INFO  [Thread-2] SYSTEM: initial deployment complete _____________________________________________________ 
Jan 21 18:33:25 de.eq3.ccu.server.HMServer INFO  [Thread-2] Starting HMServer at 127.0.0.1:9292 
Jan 21 18:33:25 de.eq3.ccu.server.HMServer INFO  [Thread-2] Read Configuration 
Jan 21 18:33:26 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create Bidcos Dispatcher 
Jan 21 18:33:26 de.eq3.ccu.server.HMServer INFO  [Thread-2] InitBidCosCache 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create groupDefinitionProvider 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create VirtualDeviceHolder 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create VirtualDeviceHandlerRega 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create GroupAdministrationService 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create GroupDeviceDispatcher 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create GroupDeviceHandler 
Jan 21 18:33:28 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] @GroupDeviceHandler - initializing... 
Jan 21 18:33:28 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created groupDeviceDispatcher (GroupDeviceService to BidCoS (via Dispatcher)) 
Jan 21 18:33:28 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> created virtualDeviceHandler (GroupDeviceService to ReGa) 
Jan 21 18:33:28 de.eq3.ccu.groupdevice.service.GroupDeviceHandler INFO  [Thread-2] --> got groupDefinitionProvider 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create BidCosGroupMemberProvider 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Init groupAdministrationService 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Init Virtual OS Device 
Jan 21 18:33:28 de.eq3.ccu.server.HMServer INFO  [Thread-2] Init ESHLight Bridge 
Jan 21 18:33:29 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create RrdDatalogging 
Jan 21 18:33:29 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create MeasurementService 
Jan 21 18:33:29 de.eq3.ccu.server.HMServer INFO  [Thread-2] Init MeasurementService 
Jan 21 18:33:29 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create HTTP Server 
Jan 21 18:33:29 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create BidCos context and start handler 
Jan 21 18:33:29 de.eq3.ccu.server.HMServer INFO  [Thread-2] Create group context and start handler 
Jan 21 18:33:30 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:9292/bidcos 
Jan 21 18:33:30 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] init finished 
Jan 21 18:33:30 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-1] Added InterfaceId: HmIP-RF_java 
Jan 21 18:33:30 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-1] updateDevicesForClient HmIP-RF_java -> 139 device addresses will be added 
Jan 21 18:33:30 de.eq3.ccu.server.HMServer INFO  [Thread-2] Starting HMServer done 
Jan 21 18:33:43 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-1] (un)registerCallback on VirtualDeviceHandlerRega called from url: xmlrpc_bin://127.0.0.1:1999 
Jan 21 18:33:43 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-1] Added InterfaceId: 1236 
Jan 21 18:33:43 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-7] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
Jan 21 18:33:59 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-1] (un)registerCallback on LegacyServiceHandler called from url: xmlrpc_bin://127.0.0.1:1999 
Jan 21 18:33:59 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-1] init finished 
Jan 21 18:33:59 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-0] Added InterfaceId: 1237 
Jan 21 18:33:59 de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil INFO  [vert.x-worker-thread-0] updateDevicesForClient 1237 -> 32 device addresses will be deleted

Vielleicht kann mir jemand weiterhelfen?

Gruss
Thomas

thomassch21 · Beitrag von **thomassch21** » 21.01.2018, 18:50

Es scheint tatsächlich etwas mit Rega zu tun zu haben, siehe unten
DutyCycle ist es aber nicht, CuxD sagt folgendes:
RFD-DutyCycle(-52s): (LEQ0602292) (HMLGW2) = 11%
RFD-DutyCycle(-52s): (OEQ0016327) (HMLGW2) = 9%
RFD-DutyCycle(-52s): (OEQ0303161) (CCU2) = 33%

Code: Alles auswählen

Jan 21 18:43:51 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...
Jan 21 18:43:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","CURRENT"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: CURRENT"] [iseXmlRpc.cpp:2605]
Jan 21 18:43:59 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:43:59 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:01 homematic-raspi user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"1007","OEQ0174405:1","STATE",false}],[methodName:"event",params:{"1007","OEQ0174405:1","WORKING",false}],[methodName:"event",params:{"1007","MEQ1890305:1","STATE",false}],[methodName:"event",params:{"1007","MEQ1890305:1","WORKING",false}],[methodName:"event",params:{"1007","MEQ1890305:2","STATE",false}],[methodName:"event",params:{"1007","MEQ1890305:2","WORKING",false}],[methodName:"event",params:{"1007","NEQ0115181:2","BOOT",true}],[methodName:"event",params:{"1007","NEQ0115181:2","ENERGY_COUNTER",20135.200000}],[methodName:"event",params:{"1007","NEQ0115181:2","POWER",0.000000}],[methodName:"event",params:{"1007","NEQ0115181:2","CURRENT",0.000000}],[methodName:"event",params:{"1007","NEQ0115181:2","VOLTAGE",233.500000}],[methodName:"event",params:{"1007","NEQ0115181:2","FREQUENCY",49.970000}],[methodName:"event",params:{"1007","NEQ0115181:1","STATE",true}],[methodName:"event",params:{"1007","NEQ0115181:1","WORKING",fals
Jan 21 18:44:01 homematic-raspi user.err rfd: XmlRpc transport error
Jan 21 18:44:11 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...
Jan 21 18:44:11 homematic-raspi user.info kernel: [  213.037046] TCP: request_sock_TCP: Possible SYN flooding on port 1999. Sending cookies.  Check SNMP counters.
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","ENERGY_COUNTER"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","ENERGY_COUNTER_OVERFLOW"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER_OVERFLOW"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","FREQUENCY"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: FREQUENCY"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","POWER"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: POWER"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:19 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"0001D709900D87:6","VOLTAGE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: VOLTAGE"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000B9569A512CB:5","CURRENT"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: CURRENT"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000B9569A512CB:5","ENERGY_COUNTER_OVERFLOW"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: ENERGY_COUNTER_OVERFLOW"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000B9569A512CB:5","FREQUENCY"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: FREQUENCY"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000B9569A512CB:5","VOLTAGE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: VOLTAGE"] [iseXmlRpc.cpp:2605]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:44:20 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]
Jan 21 18:44:21 homematic-raspi user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"1007","LEQ1520564:4","CONTROL_MODE",0}],[methodName:"event",params:{"1007","LEQ1520564:4","FAULT_REPORTING",0}],[methodName:"event",params:{"1007","LEQ1520564:4","BATTERY_STATE",2.500000}],[methodName:"event",params:{"1007","LEQ1520564:4","VALVE_STATE",0}],[methodName:"event",params:{"1007","LEQ1520564:4","BOOST_STATE",0}],[methodName:"event",params:{"1007","LEQ1520564:4","ACTUAL_TEMPERATURE",24.700000}],[methodName:"event",params:{"1007","LEQ1520564:4","SET_TEMPERATURE",20.000000}],[methodName:"event",params:{"1007","LEQ1520564:4","PARTY_TEMPERATURE",5.000000}],[methodName:"event",params:{"1007","LEQ1520564:4","PARTY_START_TIME",0}],[methodName:"event",params:{"1007","LEQ1520564:4","PARTY_START_DAY",1}],[methodName:"event",params:{"1007","LEQ1520564:4","PARTY_START_MONTH",1}],[methodName:"event",params:{"1007","LEQ1520564:4","PARTY_START_YEAR",0}],[methodName:"event",params:{"1007","LEQ1520564:4","PARTY_STOP_TIME",0}],[m
Jan 21 18:44:21 homematic-raspi user.err rfd: XmlRpc transport error
Jan 21 18:44:31 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...
Jan 21 18:44:41 homematic-raspi user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"1007","NEQ0532064:1","TEMPERATURE",22.500000}],[methodName:"event",params:{"1007","NEQ0532064:2","TEMPERATURE",22.500000}],[methodName:"event",params:{"1007","NEQ0532064:3","TEMPERATURE",0.000000}],[methodName:"event",params:{"1007","NEQ0532064:4","TEMPERATURE",0.000000}],[methodName:"event",params:{"1007","NEQ0532064:0","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0532064:1","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0532064:2","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0532064:3","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0532064:4","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0532064:5","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0115604:2","BOOT",true}],[methodName:"event",params:{"1007","NEQ0115604:2","ENERGY_COUNTER",295390.700000}],[methodName:"event",params:{"1007","NEQ0115604:2","POWER",47.890000}],[methodName:"event",params:{"1007","NEQ0115
Jan 21 18:44:41 homematic-raspi user.err rfd: XmlRpc transport error
Jan 21 18:44:51 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...
Jan 21 18:45:01 homematic-raspi user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"1007","NEQ0774213:1","TEMPERATURE",57.100000}],[methodName:"event",params:{"1007","NEQ0774213:2","TEMPERATURE",51.000000}],[methodName:"event",params:{"1007","NEQ0774213:3","TEMPERATURE",6.100000}],[methodName:"event",params:{"1007","NEQ0774213:4","TEMPERATURE",-6.100000}],[methodName:"event",params:{"1007","NEQ0774213:0","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0774213:1","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0774213:2","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0774213:3","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0774213:4","LOWBAT",false}],[methodName:"event",params:{"1007","NEQ0774213:5","LOWBAT",false}],[methodName:"event",params:{"1007","LTK0114523:1","BRIGHTNESS",34}],[methodName:"event",params:{"1007","LTK0114523:1","ERROR",0}],[methodName:"event",params:{"1007","NEQ0115496:2","BOOT",true}],[methodName:"event",params:{"1007","NEQ0115496:2","ENERGY_COUNTER
Jan 21 18:45:01 homematic-raspi user.err rfd: XmlRpc transport error
Jan 21 18:45:11 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...
Jan 21 18:45:21 homematic-raspi user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"1007","NEQ0115496:2","BOOT",true}],[methodName:"event",params:{"1007","NEQ0115496:2","ENERGY_COUNTER",155254.800000}],[methodName:"event",params:{"1007","NEQ0115496:2","POWER",213.160000}],[methodName:"event",params:{"1007","NEQ0115496:2","CURRENT",1135.000000}],[methodName:"event",params:{"1007","NEQ0115496:2","VOLTAGE",236.900000}],[methodName:"event",params:{"1007","NEQ0115496:2","FREQUENCY",49.990000}],[methodName:"event",params:{"1007","LTK0114550:1","BRIGHTNESS",33}],[methodName:"event",params:{"1007","LTK0114550:1","ERROR",0}],[methodName:"event",params:{"1007","MEQ0703827:1","IEC_ENERGY_COUNTER",26207.400000}],[methodName:"event",params:{"1007","MEQ0703827:1","IEC_POWER",0.000000}],[methodName:"event",params:{"1007","MEQ0703827:2","IEC_ENERGY_COUNTER",35509.300000}],[methodName:"event",params:{"1007","MEQ0703827:2","IEC_POWER",0.000000}],[methodName:"event",params:{"1007","NEQ0115496:2","BOOT",true}],[methodName:"
Jan 21 18:45:21 homematic-raspi user.err rfd: XmlRpc transport error
Jan 21 18:45:31 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...
Jan 21 18:45:41 homematic-raspi user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"1007","NEQ0115496:2","BOOT",true}],[methodName:"event",params:{"1007","NEQ0115496:2","ENERGY_COUNTER",155255.900000}],[methodName:"event",params:{"1007","NEQ0115496:2","POWER",213.270000}],[methodName:"event",params:{"1007","NEQ0115496:2","CURRENT",1135.000000}],[methodName:"event",params:{"1007","NEQ0115496:2","VOLTAGE",237.300000}],[methodName:"event",params:{"1007","NEQ0115496:2","FREQUENCY",49.990000}],[methodName:"event",params:{"1007","NEQ1492026:4","CONTROL_MODE",0}],[methodName:"event",params:{"1007","NEQ1492026:4","FAULT_REPORTING",0}],[methodName:"event",params:{"1007","NEQ1492026:4","BATTERY_STATE",2.700000}],[methodName:"event",params:{"1007","NEQ1492026:4","VALVE_STATE",0}],[methodName:"event",params:{"1007","NEQ1492026:4","BOOST_STATE",0}],[methodName:"event",params:{"1007","NEQ1492026:4","ACTUAL_TEMPERATURE",24.300000}],[methodName:"event",params:{"1007","NEQ1492026:4","SET_TEMPERATURE",21.000000}],[methodN
Jan 21 18:45:41 homematic-raspi user.err rfd: XmlRpc transport error
Jan 21 18:45:51 homematic-raspi user.warn rfd: XmlRpc transport failed (first try), retrying...
Jan 21 18:46:01 homematic-raspi user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"1007","NEQ0115496:2","BOOT",true}],[methodName:"event",params:{"1007","NEQ0115496:2","ENERGY_COUNTER",155257.200000}],[methodName:"event",params:{"1007","NEQ0115496:2","POWER",213.830000}],[methodName:"event",params:{"1007","NEQ0115496:2","CURRENT",1138.000000}],[methodName:"event",params:{"1007","NEQ0115496:2","VOLTAGE",236.800000}],[methodName:"event",params:{"1007","NEQ0115496:2","FREQUENCY",49.980000}],[methodName:"event",params:{"1007","NEQ0115496:2","BOOT",true}],[methodName:"event",params:{"1007","NEQ0115496:2","ENERGY_COUNTER",155257.600000}],[methodName:"event",params:{"1007","NEQ0115496:2","POWER",213.570000}],[methodName:"event",params:{"1007","NEQ0115496:2","CURRENT",1138.000000}],[methodName:"event",params:{"1007","NEQ0115496:2","VOLTAGE",236.700000}],[methodName:"event",params:{"1007","NEQ0115496:2","FREQUENCY",49.980000}],[methodName:"event",params:{"1007","NEQ0115496:2","BOOT",true}],[methodName:"event",pa
Jan 21 18:46:01 homematic-raspi user.err rfd: XmlRpc transport error
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","PARTY_TIME_START"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: PARTY_TIME_START"] [iseXmlRpc.cpp:2605]
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal =  [iseDOMdpHSS.cpp:130]
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","PARTY_TIME_END"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: PARTY_TIME_END"] [iseXmlRpc.cpp:2605]
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal =  [iseDOMdpHSS.cpp:130]
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallXmlrpcMethod: execute result isFault; method =getValue Params = {"000397098A39EC:1","PARTY_SET_POINT_TEMPERATURE"} result= [faultCode:-5,faultString:"Unknown Parameter value for value key: PARTY_SET_POINT_TEMPERATURE"] [iseXmlRpc.cpp:2605]
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseXmlRpc::CallGetValue: CallXmlrpcMethod failed [iseXmlRpc.cpp:1432]
Jan 21 18:48:10 homematic-raspi local0.err ReGaHss: Error: IseHssDP::ReadValue: CallGetValue failed; sVal = 0.000000 [iseDOMdpHSS.cpp:130]

thomassch21 · Beitrag von **thomassch21** » 21.01.2018, 21:09

Ich könnte mal rega im debug starten via ssh

irgendwie war das doch folgende Anweisung???
/etc/init.d/S70ReGaHss stop
/bin/ReGaHss -f /etc/rega.conf -l 0

Aktuell habe ich keinen Ahnung wie ich weiter komme, die WebUI Anzeige zeigt immer noch nicht den richtigen Status nach einem Schaltbefehl an und auch die Programme schalten die Aktoren nicht, weil sie vermutlich nicht richtige Statis intern haben.

WebUI Anzeige des Systemprotokolls zeigt immer keine Einträge, auch hier war es damals so, dass ich z.B. Werte oder debugs sehen konnte.

Bin über jede Hilfe dankbar - soll ich auf alte raspberrymatic Version zurück, soll ich alle Geräte neu anlernen?
Debug?

Gruss
THomas

thomassch21 · Beitrag von **thomassch21** » 22.01.2018, 08:41

Ich habe nun mal ALLE Programme deaktiviert, auch die die eigentlich keine Scripte haben.
Nach 2 mal Start habe ich nun wenigstens mal die Möglichkeit dass ich über die WebUI Aktoren steuern können.

Beim durchsehen des Logs habe ich ein Gerät gefunden dass in der Geräte Liste nicht mehr auftaucht.
Soweit ich das sehe handelt es sich um ein IP Thermostat, dass ich vorher aber in einer Gruppe hatte und dass nun einfach verschwunden ist!
Weiterhin vermisse ich einen IP Unterputz Schalter der nur noch als Direktverschaltung vorhanden ist, nicht mehr als Gerät!

Es scheinen Geräte (bisher vermutlich nur IP Geräte) zu verschwinden!

Nachtrag: nachdem ich mal Geräte anlernen angeklickt habe, ist mir aufgefallen, dass ich einige Geräte im Posteingang habe und das waren genau die die plötzlich verschwunden sind!

Ich denke ich gehe heute Abend mal wieder auf eine alte RaspberryMatic Version.

Gruss
Thomas

jmaus · Beitrag von **jmaus** » 22.01.2018, 09:47

Hast du zufällig vor dem RaspberryMatic Update auch ein Firmware Update dieser HmIP Geräte durchgeführt. Bei HmIP mit einer CCU ist es noch üblich das man die HmIP Geräte komplett ablernen+anlernen muss damit die wieder korrekt funktionieren.

HomeMatic-Forum / FHZ-Forum