HM Aktoren lassen sich nicht mehr schalten, etliche Freezes im System

chriz · 24 November 2014, 18:10:25

Hallo Zusammen,

heute ab 16:28 war es mal wieder soweit. Es tauchten etliche Freezes meines FHEM Servers auf, welche das gesamte System lahmlegten.

Code Auswählen


2014.11.24 16:28:19 1: Perfmon: possible freeze starting at 16:28:08, delay is 11.96
2014.11.24 16:28:22 1: Perfmon: possible freeze starting at 16:28:21, delay is 1.121
2014.11.24 16:28:24 1: Perfmon: possible freeze starting at 16:28:23, delay is 1.086
2014.11.24 16:28:25 1: HMLAN_Parse: HMLAN1 new condition timeout
2014.11.24 16:28:25 1: 192.168.77.27:1000 disconnected, waiting to reappear (HMLAN1)
2014.11.24 16:28:25 1: HMLAN_Parse: HMLAN1 new condition disconnected
2014.11.24 16:28:26 2: di_hmlanonoff: set Pushover1 msg 'HMLAN1' 'disconnected' ''0'': OK
2014.11.24 16:29:58 1: Perfmon: possible freeze starting at 16:29:31, delay is 27.55
2014.11.24 16:30:06 1: Perfmon: possible freeze starting at 16:30:01, delay is 5.107
2014.11.24 16:30:38 1: Perfmon: possible freeze starting at 16:30:11, delay is 27.996
2014.11.24 16:32:11 3: CUL_HM set SW_HALLEKUGEL on
2014.11.24 16:32:11 3: CUL_HM set SW_HALLEKUGEL on
2014.11.24 16:33:07 1: Perfmon: possible freeze starting at 16:33:02, delay is 5.116
2014.11.24 16:33:58 1: Perfmon: possible freeze starting at 16:33:31, delay is 27.551
2014.11.24 16:34:38 1: Perfmon: possible freeze starting at 16:34:11, delay is 27.946
2014.11.24 16:35:01 1: Perfmon: possible freeze starting at 16:34:51, delay is 10.15
2014.11.24 16:35:04 3: CUL_HM set LS13_Sw on-for-timer 3000
2014.11.24 16:35:30 1: Perfmon: possible freeze starting at 16:35:08, delay is 22.659
2014.11.24 16:36:00 1: Perfmon: possible freeze starting at 16:35:59, delay is 1.215
2014.11.24 16:36:30 1: Perfmon: possible freeze starting at 16:36:07, delay is 23.543
2014.11.24 16:36:50 1: Perfmon: possible freeze starting at 16:36:41, delay is 9.279
2014.11.24 16:37:00 1: Perfmon: possible freeze starting at 16:36:51, delay is 9.607
2014.11.24 16:37:07 1: Perfmon: possible freeze starting at 16:37:02, delay is 5.116
2014.11.24 16:37:07 2: FLUKSO FluksoStromS0: ParseSensorResponse.263 Error while requesting http://192.168.77.39:8080/sensor/aa021f6ed32bbce3c3815588b76014c4?version=1.0&interval=minute&unit=watt&jsonp_callback=realtime - read from http://192.168.77.39:8080 timed out
2014.11.24 16:37:07 1: PERL WARNING: Exiting subroutine via last at ./FHEM/23_FLUKSO.pm line 265.
2014.11.24 16:37:20 1: Perfmon: possible freeze starting at 16:37:11, delay is 9.55
2014.11.24 16:37:50 1: Perfmon: possible freeze starting at 16:37:41, delay is 9.608
2014.11.24 16:38:07 3: CUL_HM set SW_KELLERVORN on
2014.11.24 16:38:07 3: CUL_HM set LS11_Sw on-for-timer 600
2014.11.24 16:38:08 3: CUL_HM set PCB1_HEIZUNG2 on-for-timer 0.75
2014.11.24 16:38:10 1: Perfmon: possible freeze starting at 16:38:07, delay is 3.63
2014.11.24 16:38:30 1: Perfmon: possible freeze starting at 16:38:21, delay is 9.619
2014.11.24 16:39:30 1: Perfmon: possible freeze starting at 16:39:08, delay is 22.647
2014.11.24 16:39:30 3: CUL_HM set LS13_Sw on-for-timer 3000
2014.11.24 16:40:06 1: Perfmon: possible freeze starting at 16:40:01, delay is 5.113
2014.11.24 16:41:01 1: Perfmon: possible freeze starting at 16:40:51, delay is 10.235
2014.11.24 16:41:07 1: Perfmon: possible freeze starting at 16:41:03, delay is 4.141

Danach habe ich verbose=5 zugeschalten und weiter nach Freezes im Log gesucht, wie z.B.:

Code Auswählen


2014.11.24 16:44:06 5: FBAHA/RAW: /0703001c00000040001600000000000c0000000f00040000000000000703002000000040001600000000001000000017000800000000009d000000000703001c00000040001600000000000c0000001300040000000376eb0703001c00000040001600000000000c0000001200040000000000000703001c00000040001600000000000c00000015000400000000d6f30703001c00000040001600000000000c000000160004000000000000
2014.11.24 16:44:06 5: fb7490 dispatch 0703001c00000040001600000000000c0000000f0004000000000000
2014.11.24 16:44:06 4: Payload: 0000000f0004000000000000 -> state: off
2014.11.24 16:44:06 5: FBDECT_Parse for device FBDECT_22 done
2014.11.24 16:44:06 1: Perfmon: possible freeze starting at 16:44:01, delay is 5.096

Code Auswählen


2014.11.24 16:55:30 5: FBAHA/RAW: /0703001c00000040001100000000000c0000000f0004000000000001070300200000004000110000000000100000001700080000000000f1000000000703001c00000040001100000000000c000000130004000000037c870703001c00000040001100000000000c00000012000400000000025f0703001c00000040001100000000000c00000015000400000002285a0703001c00000040001100000000000c00000016000400000000010f
2014.11.24 16:55:30 5: fb7490 dispatch 0703001c00000040001100000000000c0000000f0004000000000001
2014.11.24 16:55:30 4: Payload: 0000000f0004000000000001 -> state: on
2014.11.24 16:55:30 5: FBDECT_Parse for device FBDECT_17 done
2014.11.24 16:55:30 5: fb7490 dispatch 070300200000004000110000000000100000001700080000000000f100000000
2014.11.24 16:55:30 4: Payload: 0000001700080000000000f100000000 -> temperature: 24.1 C (measured)
2014.11.24 16:55:30 5: FBDECT_Parse for device FBDECT_17 done
2014.11.24 16:55:30 5: fb7490 dispatch 0703001c00000040001100000000000c000000130004000000037c87
2014.11.24 16:55:30 4: Payload: 000000130004000000037c87 -> voltage: 228.487 V
2014.11.24 16:55:30 5: FBDECT_Parse for device FBDECT_17 done
2014.11.24 16:55:30 5: Triggering FBDECT_17 (1 changes)
2014.11.24 16:55:30 5: Notify loop for FBDECT_17 voltage: 228.487 V
2014.11.24 16:55:30 1: Perfmon: possible freeze starting at 16:55:08, delay is 22.357

Code Auswählen


2014.11.24 17:06:05 5: HMLAN/RAW: /E251D9A,0000,0822CA82,FF,FFBC,4E845E251D9A0000008010F3000000000008CCFF
2014.11.24 17:06:05 5: HMLAN_Parse: HMLAN1 R:E251D9A   stat:0000 t:0822CA82 d:FF r:FFBC     m:4E 845E 251D9A 000000 8010F3000000000008CCFF
2014.11.24 17:06:05 5: HMLAN1 dispatch A144E845E251D9A0000008010F3000000000008CCFF::-68:HMLAN1
2014.11.24 17:06:05 5: Triggering LS9_KTHERMO_Pwr (1 changes)
2014.11.24 17:06:05 5: Notify loop for LS9_KTHERMO_Pwr eState: E: 433.9 P: 0 I: 0 U: 225.2 f: 49.99
2014.11.24 17:06:05 5: Triggering LS9_KTHERMO_SenF (1 changes)
2014.11.24 17:06:05 5: Notify loop for LS9_KTHERMO_SenF 49.99
2014.11.24 17:06:05 5: Triggering LS9_KTHERMO_SenU (1 changes)
2014.11.24 17:06:05 5: Notify loop for LS9_KTHERMO_SenU 225.2
2014.11.24 17:06:05 1: Perfmon: possible freeze starting at 17:06:03, delay is 2.282

Den Aktor SW_DACH wollte ich dann testhalber anschalten, was nicht mehr funktionierte. Es kam lediglich ein IOerr.

(https://lh4.googleusercontent.com/-JF2V0kzl-Zo/VHNmV_IJvbI/AAAAAAAAT2U/x4oDnUGLKk8/s640/2014-11-24_17h44_35.png)

Code Auswählen


2014.11.24 17:07:38 3: CUL_HM set SW_DACH on
2014.11.24 17:07:39 3: CUL_HM set SW_DACH on
2014.11.24 17:07:39 5: HMLAN/RAW: /E2D6611,0000,08243C55,FF,FFB0,6184702D661100000000BE43

2014.11.24 17:07:39 5: HMLAN_Parse: HMLAN1 R:E2D6611   stat:0000 t:08243C55 d:FF r:FFB0     m:61 8470 2D6611 000000 00BE43
2014.11.24 17:07:39 5: HMLAN1 dispatch A0C6184702D661100000000BE43::-80:HMLAN1
2014.11.24 17:07:41 3: CUL_HM set SW_DACH on
2014.11.24 17:07:41 5: HMLAN/RAW: /E22B1E5,0000,0824438E,FF,FFBF,0E861022B1E50000000AA8D80D3919

2014.11.24 17:07:41 5: HMLAN_Parse: HMLAN1 R:E22B1E5   stat:0000 t:0824438E d:FF r:FFBF     m:0E 8610 22B1E5 000000 0AA8D80D3919
2014.11.24 17:07:41 5: HMLAN1 dispatch A0F0E861022B1E50000000AA8D80D3919::-65:HMLAN1
2014.11.24 17:07:41 5: Triggering HEIZ_ELTWOHN (1 changes)
2014.11.24 17:07:41 5: Notify loop for HEIZ_ELTWOHN measured-temp: 21.6
2014.11.24 17:07:41 5: Triggering HEIZ_ELTWOHN_Clima (2 changes)
2014.11.24 17:07:41 5: Notify loop for HEIZ_ELTWOHN_Clima measured-temp: 21.6
2014.11.24 17:07:41 5: Triggering HEIZ_ELTWOHN_Weather (2 changes)
2014.11.24 17:07:41 5: Notify loop for HEIZ_ELTWOHN_Weather measured-temp: 21.6
2014.11.24 17:07:41 3: CUL_HM set SW_DACH on
2014.11.24 17:07:42 5: HMLAN/RAW: /E25526D,0000,08244624,FF,FFD2,AE861025526D0000000A84A70E0818

Danach wollte ich bei einigen Aktoren einen statusRequest anfordern, was auch nicht mehr ging.

Code Auswählen


2014.11.24 17:09:36 5: Cmd: >set SW_HALLE2 statusRequest<
2014.11.24 17:09:36 5: CUL_HM SW_HALLE2 protEvent:CMDs_pending pending:1
2014.11.24 17:09:36 3: CUL_HM set SW_HALLE2 statusRequest
2014.11.24 17:09:36 5: HMLAN_Send:  HMLAN1 S:SE290BD44 stat:  00 t:00000000 d:01 r:E290BD44 m:5B A001 272EA5 20CA59 010E
2014.11.24 17:09:36 5: CUL_HM SW_HALLE2 protEvent:CMDs_processing... pending:0
2014.11.24 17:09:36 4: /fhem?XHR=1&cmd.SW_HALLE2=set%20SW_HALLE2%20statusRequest&room=Favourites / RL:20 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / 
2014.11.24 17:09:36 5: HMLAN/RAW: /E20CA59,0000,08260534,FF,FFBE,5BA41020CA59272EA50601000042

2014.11.24 17:09:36 5: HMLAN_Parse: HMLAN1 R:E20CA59   stat:0000 t:08260534 d:FF r:FFBE     m:5B A410 20CA59 272EA5 0601000042
2014.11.24 17:09:36 5: HMLAN1 dispatch A0E5BA41020CA59272EA50601000042::-66:HMLAN1
2014.11.24 17:09:36 5: HMLAN: Skip ACK
2014.11.24 17:09:36 5: CUL_HM SW_HALLE2 protEvent:CMDs_done
2014.11.24 17:09:36 5: CUL_HM SW_HALLE2 sent ACK:2
2014.11.24 17:09:36 5: HMLAN/RAW: /RE290BD44,0001,08260539,FF,FFBE,5BA41020CA59272EA50601000042

2014.11.24 17:09:36 5: HMLAN_Parse: HMLAN1 R:RE290BD44 stat:0001 t:08260539 d:FF r:FFBE     m:5B A410 20CA59 272EA5 0601000042
2014.11.24 17:09:36 5: HMLAN1 dispatch A0E5BA41020CA59272EA50601000042::-66:HMLAN1
2014.11.24 17:09:36 4: CUL_HM SW_HALLE2 dupe: dont process
2014.11.24 17:09:37 4: HTTP FHEMWEB:192.168.77.25:5871 GET /fhem?XHR=1&cmd.SW_HALLE1=set%20SW_HALLE1%20statusRequest&room=Favourites
2014.11.24 17:09:37 5: Cmd: >set SW_HALLE1 statusRequest<
2014.11.24 17:09:37 5: CUL_HM SW_HALLE1 protEvent:CMDs_pending pending:1
2014.11.24 17:09:37 3: CUL_HM set SW_HALLE1 statusRequest
2014.11.24 17:09:37 5: HMLAN_Send:  HMLAN1 S:+20CA43,00,01,00
2014.11.24 17:09:37 5: HMLAN_Send:  HMLAN1 S:SE290BFA9 stat:  00 t:00000000 d:01 r:E290BFA9 m:5C A001 272EA5 20CA43 010E
2014.11.24 17:09:37 5: CUL_HM SW_HALLE1 protEvent:CMDs_processing... pending:0
2014.11.24 17:09:37 4: /fhem?XHR=1&cmd.SW_HALLE1=set%20SW_HALLE1%20statusRequest&room=Favourites / RL:20 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / 
2014.11.24 17:09:37 5: HMLAN/RAW: /E20CA43,0000,08260799,FF,FFBB,5CA41020CA43272EA50601000045

2014.11.24 17:09:37 5: HMLAN_Parse: HMLAN1 R:E20CA43   stat:0000 t:08260799 d:FF r:FFBB     m:5C A410 20CA43 272EA5 0601000045
2014.11.24 17:09:37 5: HMLAN1 dispatch A0E5CA41020CA43272EA50601000045::-69:HMLAN1
2014.11.24 17:09:37 5: HMLAN: Skip ACK
2014.11.24 17:09:37 5: CUL_HM SW_HALLE1 protEvent:CMDs_done
2014.11.24 17:09:37 5: CUL_HM SW_HALLE1 sent ACK:2
2014.11.24 17:09:37 5: Triggering SW_HALLE1 (1 changes)
2014.11.24 17:09:37 5: Notify loop for SW_HALLE1 deviceMsg: off (to vccu)
2014.11.24 17:09:37 5: HMLAN/RAW: /E270504,0000,082607CB,FF,FFBA,5D8470270504000000009E4F

2014.11.24 17:09:37 5: HMLAN_Parse: HMLAN1 R:E270504   stat:0000 t:082607CB d:FF r:FFBA     m:5D 8470 270504 000000 009E4F
2014.11.24 17:09:37 5: HMLAN1 dispatch A0C5D8470270504000000009E4F::-70:HMLAN1
2014.11.24 17:09:37 5: HMLAN/RAW: /RE290BFA9,0001,0826079E,FF,FFBB,5CA41020CA43272EA50601000045

2014.11.24 17:09:37 5: HMLAN_Parse: HMLAN1 R:RE290BFA9 stat:0001 t:0826079E d:FF r:FFBB     m:5C A410 20CA43 272EA5 0601000045
2014.11.24 17:09:37 5: HMLAN1 dispatch A0E5CA41020CA43272EA50601000045::-69:HMLAN1
2014.11.24 17:09:37 4: CUL_HM SW_HALLE1 dupe: dont process
2014.11.24 17:09:38 4: HTTP FHEMWEB:192.168.77.25:5871 GET /fhem?XHR=1&cmd.SW_DACH=set%20SW_DACH%20statusRequest&room=Favourites
2014.11.24 17:09:38 5: Cmd: >set SW_DACH statusRequest<
2014.11.24 17:09:38 5: CUL_HM SW_DACH protEvent:CMDs_pending pending:1
2014.11.24 17:09:38 3: CUL_HM set SW_DACH statusRequest
2014.11.24 17:09:38 5: HMLAN_Send:  HMLAN1 S:SE290C365 stat:  00 t:00000000 d:01 r:E290C365 m:5D A001 272EA5 20C58C 010E
2014.11.24 17:09:38 5: CUL_HM SW_DACH protEvent:CMDs_processing... pending:0
2014.11.24 17:09:38 4: /fhem?XHR=1&cmd.SW_DACH=set%20SW_DACH%20statusRequest&room=Favourites / RL:20 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / 
2014.11.24 17:09:38 5: HMLAN/RAW: /E20C58C,0000,08260B54,FF,FFD9,5DA41020C58C272EA5060100002A

2014.11.24 17:09:38 5: HMLAN_Parse: HMLAN1 R:E20C58C   stat:0000 t:08260B54 d:FF r:FFD9     m:5D A410 20C58C 272EA5 060100002A
2014.11.24 17:09:38 5: HMLAN1 dispatch A0E5DA41020C58C272EA5060100002A::-39:HMLAN1
2014.11.24 17:09:38 5: HMLAN: Skip ACK
2014.11.24 17:09:38 5: CUL_HM SW_DACH protEvent:CMDs_done
2014.11.24 17:09:38 5: CUL_HM SW_DACH sent ACK:2
2014.11.24 17:09:38 5: HMLAN/RAW: /RE290C365,0001,08260B59,FF,FFD9,5DA41020C58C272EA5060100002A

2014.11.24 17:09:38 5: HMLAN_Parse: HMLAN1 R:RE290C365 stat:0001 t:08260B59 d:FF r:FFD9     m:5D A410 20C58C 272EA5 060100002A
2014.11.24 17:09:38 5: HMLAN1 dispatch A0E5DA41020C58C272EA5060100002A::-39:HMLAN1
2014.11.24 17:09:38 4: CUL_HM SW_DACH dupe: dont process
2014.11.24 17:09:38 4: HTTP FHEMWEB:192.168.77.25:5871 GET /fhem?XHR=1&cmd.LSW_TERRASSENSPOTS=set%20LSW_TERRASSENSPOTS%20statusRequest&room=Favourites
2014.11.24 17:09:38 5: Cmd: >set LSW_TERRASSENSPOTS statusRequest<
2014.11.24 17:09:38 5: CUL_HM LSW_TERRASSENSPOTS protEvent:CMDs_pending pending:1
2014.11.24 17:09:38 3: CUL_HM set LSW_TERRASSENSPOTS statusRequest
2014.11.24 17:09:38 5: HMLAN_Send:  HMLAN1 S:SE290C5B9 stat:  00 t:00000000 d:01 r:E290C5B9 m:5E A001 272EA5 29F2A6 010E
2014.11.24 17:09:38 5: CUL_HM LSW_TERRASSENSPOTS protEvent:CMDs_processing... pending:0
2014.11.24 17:09:38 4: /fhem?XHR=1&cmd.LSW_TERRASSENSPOTS=set%20LSW_TERRASSENSPOTS%20statusRequest&room=Favourites / RL:20 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / 
2014.11.24 17:09:38 5: HMLAN/RAW: /E29F2A6,0000,08260DA8,FF,FFB5,5EA41029F2A6272EA5060100004B

Mein FHEM System ist soweit aktuell:

Code Auswählen

# $Id: fhem.pl 6913 2014-11-08 10:32:44Z rudolfkoenig $ 
# $Id: 10_CUL_HM.pm 7047 2014-11-23 09:52:33Z martinp876 $ 
# $Id: 70_EGPM.pm 5344 2014-03-27 20:06:31Z alexus2033 $ 
# $Id: 17_EGPM2LAN.pm 5344 2014-03-27 20:06:31Z alexus2033 $ 
# $Id: 00_FBAHA.pm 6771 2014-10-15 17:59:23Z rudolfkoenig $ 
# $Id: 10_FBDECT.pm 6771 2014-10-15 17:59:23Z rudolfkoenig $ 
# $Id: 72_FB_CALLMONITOR.pm 6852 2014-11-01 17:23:29Z markusbloch $ 
# $Id: 01_FHEMWEB.pm 7024 2014-11-19 23:07:39Z rudolfkoenig $ 
# $Id: 92_FileLog.pm 7000 2014-11-16 16:51:50Z rudolfkoenig $ 
# $Id: 59_HCS.pm 4433 2013-12-21 05:30:49Z tobiasfaust $ 
# $Id: 00_HMLAN.pm 6471 2014-08-27 12:32:38Z martinp876 $ 
# $Id: 98_HMinfo.pm 7048 2014-11-23 10:49:21Z martinp876 $ 
# $Id: 99_SUNRISE_EL.pm 6765 2014-10-14 18:24:29Z rudolfkoenig $ 
# $Id: 98_SVG.pm 7000 2014-11-16 16:51:50Z rudolfkoenig $ 
# $Id: 99_Utils.pm 6660 2014-10-03 06:35:43Z rudolfkoenig $ 
# $Id: 71_YAMAHA_AVR.pm 6915 2014-11-08 11:14:55Z markusbloch $ 
# $Id: 90_at.pm 7000 2014-11-16 16:51:50Z rudolfkoenig $ 
# $Id: 98_autocreate.pm 6505 2014-09-06 12:24:48Z rudolfkoenig $ 
# $Id: 98_dewpoint.pm 6757 2014-10-12 18:58:57Z joachim09876 $ 
# $Id: 98_dummy.pm 4934 2014-02-15 08:23:12Z rudolfkoenig $ 
# $Id: 91_eventTypes.pm 6792 2014-10-19 16:03:13Z rudolfkoenig $ 
# $Id: 38_netatmo.pm 6876 2014-11-03 18:24:57Z justme1968 $ 
# $Id: 91_notify.pm 7002 2014-11-16 17:23:35Z rudolfkoenig $ 
# $Id: 98_telnet.pm 6611 2014-09-24 07:48:32Z rudolfkoenig $

FHEM läuft bei mir auf einem INTEL NUC via Ubuntu

Code Auswählen

Fhem info: 
  Release  : 5.6 
  Branch   : DEVELOPMENT 
  OS       : linux 
  Arch     : x86_64-linux-gnu-thread-multi 
  Perl     : v5.18.2

Ich weiß langsam echt nicht mehr weiter, kann mir nicht erklären woher die Probleme kommen. Einzige Rettung war ein "shutdown restart", danach funktionierte wieder alles.

Bin für jede Hilfe dankbar,

Grüße
Chris

herrmannj · 24 November 2014, 19:19:11

Hi,

mit apptime kannst Du das evtl weiter eingrenzen, die freeze sind ja deutlich

vg
jörg

chriz · 25 November 2014, 11:54:56

Hi Jörg,

apptime, richtig... oh Mann

das habe ich in aller Aufregung schlicht vergessen. Kann ich beim nächsten mal nachreichen.

Kann man aus den oben geposteten logs evtl. schon einen Anhaltspunkt erkennen?

Grüße
Chris

herrmannj · 25 November 2014, 12:31:14

nicht wirklich, nur das das nicht so richtig flutscht

apptime dient auch nicht zur Prozessbefriedigung, da stehen hoffentlich die einzelnen Laufzeiten drin

vg
jörg

chriz · 28 November 2014, 09:03:59

Guten Morgen

die nächsten Freezes ließen nicht lange auf sich warten. Diesmal legten Sie um 00:47 Uhr bis 08:50 morgens meinen FHEM Server lahm. Man konnte keine HM-Aktoren mehr schalten, das halbe System war lt. ActionDetector tot: alive:42 dead:65 unkn:5 off:0

Die Freezes kann man nur durch ein "shutdown restart" lösen, welches ich heute Früh durchführte. Seitdem läuft es wieder.

Ich habe diesmal apptime, logs und co aufgezeichnet, hier das normale Log der Freezes, etwas gekürzt (übrigens: diese Meldung hatte ich noch nicht: 2014.11.28 02:30:21 1: HMLAN setting owner to 272EA5 from 000000)

Code Auswählen


2014.11.28 00:44:27 1: Perfmon: possible freeze starting at 00:44:26, delay is 1.179
2014.11.28 00:44:32 1: Perfmon: possible freeze starting at 00:44:31, delay is 1.598
2014.11.28 00:44:35 1: Perfmon: possible freeze starting at 00:44:33, delay is 2.093
2014.11.28 00:44:38 1: Perfmon: possible freeze starting at 00:44:37, delay is 1.612
2014.11.28 00:44:51 1: Perfmon: possible freeze starting at 00:44:40, delay is 11.716
2014.11.28 00:45:03 1: Perfmon: possible freeze starting at 00:44:59, delay is 4.432
2014.11.28 00:45:14 1: Perfmon: possible freeze starting at 00:45:13, delay is 1.01
2014.11.28 00:45:22 1: Perfmon: possible freeze starting at 00:45:18, delay is 4.802
2014.11.28 00:45:32 1: Perfmon: possible freeze starting at 00:45:31, delay is 1.16
2014.11.28 00:45:40 1: Perfmon: possible freeze starting at 00:45:36, delay is 4.01
2014.11.28 00:45:47 1: Perfmon: possible freeze starting at 00:45:42, delay is 5.086
2014.11.28 00:45:53 1: Perfmon: possible freeze starting at 00:45:52, delay is 1.842
2014.11.28 00:46:00 1: Perfmon: possible freeze starting at 00:45:59, delay is 1.765
2014.11.28 00:46:06 1: Perfmon: possible freeze starting at 00:46:02, delay is 4.01
2014.11.28 00:46:13 1: Perfmon: possible freeze starting at 00:46:08, delay is 5.677
2014.11.28 00:46:18 1: Perfmon: possible freeze starting at 00:46:15, delay is 3.141
2014.11.28 00:46:26 1: Perfmon: possible freeze starting at 00:46:21, delay is 5.159
2014.11.28 00:46:36 1: HMLAN_Parse: HMLAN1 new condition timeout
2014.11.28 00:46:36 1: 192.168.77.27:1000 disconnected, waiting to reappear (HMLAN1)
2014.11.28 00:46:36 1: HMLAN_Parse: HMLAN1 new condition disconnected
2014.11.28 00:46:51 1: Perfmon: possible freeze starting at 00:46:40, delay is 11.696
2014.11.28 00:48:51 1: Perfmon: possible freeze starting at 00:48:40, delay is 11.716
2014.11.28 00:50:51 1: Perfmon: possible freeze starting at 00:50:40, delay is 11.728
2014.11.28 00:51:19 1: Perfmon: possible freeze starting at 00:51:15, delay is 4.905
2014.11.28 00:52:00 1: Perfmon: possible freeze starting at 00:51:52, delay is 8.728
2014.11.28 00:52:51 1: Perfmon: possible freeze starting at 00:52:40, delay is 11.705

....

2014.11.28 02:06:00 1: Perfmon: possible freeze starting at 02:05:52, delay is 8.729
2014.11.28 02:06:39 1: Perfmon: possible freeze starting at 02:06:11, delay is 28.607
2014.11.28 02:07:20 1: Perfmon: possible freeze starting at 02:07:15, delay is 5.011
2014.11.28 02:08:47 1: Perfmon: possible freeze starting at 02:08:40, delay is 7.288
2014.11.28 02:10:47 1: Perfmon: possible freeze starting at 02:10:40, delay is 7.325
2014.11.28 02:11:20 1: Perfmon: possible freeze starting at 02:11:15, delay is 5.011
2014.11.28 02:11:51 1: Perfmon: possible freeze starting at 02:11:33, delay is 18.919
2014.11.28 02:12:10 1: Perfmon: possible freeze starting at 02:12:01, delay is 9.185
2014.11.28 02:12:47 1: Perfmon: possible freeze starting at 02:12:40, delay is 7.251
2014.11.28 02:13:19 1: Perfmon: possible freeze starting at 02:13:15, delay is 4.993
2014.11.28 02:14:47 1: Perfmon: possible freeze starting at 02:14:40, delay is 7.288
2014.11.28 02:15:20 1: Perfmon: possible freeze starting at 02:15:15, delay is 5.009
2014.11.28 02:15:51 1: Perfmon: possible freeze starting at 02:15:33, delay is 18.908
2014.11.28 02:16:10 1: Perfmon: possible freeze starting at 02:16:01, delay is 9.208
2014.11.28 02:16:47 1: Perfmon: possible freeze starting at 02:16:40, delay is 7.217
2014.11.28 02:17:20 1: Perfmon: possible freeze starting at 02:17:15, delay is 5.011
2014.11.28 02:18:10 1: Perfmon: possible freeze starting at 02:18:01, delay is 9.231
2014.11.28 02:18:47 1: Perfmon: possible freeze starting at 02:18:40, delay is 7.205
2014.11.28 02:22:47 1: Perfmon: possible freeze starting at 02:22:40, delay is 7.216
2014.11.28 02:23:20 1: Perfmon: possible freeze starting at 02:23:15, delay is 5.011
2014.11.28 02:24:00 1: Perfmon: possible freeze starting at 02:23:52, delay is 8.011
2014.11.28 02:24:10 1: Perfmon: possible freeze starting at 02:24:01, delay is 9.208
2014.11.28 02:24:47 1: Perfmon: possible freeze starting at 02:24:40, delay is 7.288
2014.11.28 02:25:20 1: Perfmon: possible freeze starting at 02:25:15, delay is 5.011
2014.11.28 02:25:51 1: Perfmon: possible freeze starting at 02:25:33, delay is 18.919
2014.11.28 02:26:10 1: Perfmon: possible freeze starting at 02:26:01, delay is 9.231
2014.11.28 02:26:47 1: Perfmon: possible freeze starting at 02:26:40, delay is 7.311
2014.11.28 02:27:20 1: Perfmon: possible freeze starting at 02:27:15, delay is 5.011
2014.11.28 02:27:51 1: Perfmon: possible freeze starting at 02:27:33, delay is 18.903
2014.11.28 02:28:10 1: Perfmon: possible freeze starting at 02:28:01, delay is 9.245
2014.11.28 02:28:47 1: Perfmon: possible freeze starting at 02:28:40, delay is 7.228
2014.11.28 02:29:19 1: Perfmon: possible freeze starting at 02:29:15, delay is 4.994
2014.11.28 02:29:51 1: Perfmon: possible freeze starting at 02:29:33, delay is 18.908
2014.11.28 02:29:55 1: HMLAN_Parse: HMLAN1 new condition timeout
2014.11.28 02:29:55 1: 192.168.77.27:1000 disconnected, waiting to reappear (HMLAN1)
2014.11.28 02:29:55 1: HMLAN_Parse: HMLAN1 new condition disconnected
2014.11.28 02:29:56 1: 192.168.77.27:1000 reappeared (HMLAN1)
2014.11.28 02:29:56 1: HMLAN_Parse: HMLAN1 new condition init
2014.11.28 02:29:56 1: HMLAN_Parse: HMLAN1 new condition ok
2014.11.28 02:30:21 1: HMLAN setting owner to 272EA5 from 000000

....

2014.11.28 08:32:06 1: Perfmon: possible freeze starting at 08:32:02, delay is 4.933
2014.11.28 08:32:39 1: Perfmon: possible freeze starting at 08:32:11, delay is 28.622
2014.11.28 08:33:14 1: Perfmon: possible freeze starting at 08:33:02, delay is 12.325
2014.11.28 08:33:52 1: Perfmon: possible freeze starting at 08:33:21, delay is 31.028
2014.11.28 08:34:39 1: Perfmon: possible freeze starting at 08:34:11, delay is 28.642
2014.11.28 08:37:14 1: Perfmon: possible freeze starting at 08:36:40, delay is 34.358
2014.11.28 08:38:10 1: Perfmon: possible freeze starting at 08:38:07, delay is 3.204
2014.11.28 08:39:14 1: Perfmon: possible freeze starting at 08:38:40, delay is 34.386
2014.11.28 08:40:00 1: Perfmon: possible freeze starting at 08:39:53, delay is 7.824
2014.11.28 08:40:06 1: Perfmon: possible freeze starting at 08:40:02, delay is 4.918
2014.11.28 08:40:39 1: Perfmon: possible freeze starting at 08:40:11, delay is 28.622

apptime

Code Auswählen

apptime

                                name             function    max  count    total  average maxDly 
                              fb7490           FBAHA_Read  34709   4517  2836120   627.88      0 HASH(fb7490) 
                              HMLAN1           HMLAN_Read   6671   9236   168446    18.24      0 HASH(HMLAN1) 
                      TuerSpeisalert          notify_Exec    758  21775      758     0.03      0 HASH(TuerSpeisalert); HASH(TUER_SPEISE) 
                           Pushover1         Pushover_Set    754      7      754   107.71      0 HASH(Pushover1); Pushover1; msg; 'Speise'; 'Tuer; wurde; geoeffnet'; ''0'magic' 
                          HalleVenti          notify_Exec    531  21775      531     0.02      0 HASH(HalleVenti); HASH(SW_KELLERVORN) 
                 tmr-CUL_HM_ActCheck       ActionDetector    451     76     1931    25.41  21560 ActionDetector 
                          6FachWohn3          notify_Exec    191  21775      191     0.01      0 HASH(6FachWohn3); HASH(6FACH_WOHN_Btn_03) 
                         AV_Receiver       YAMAHA_AVR_Set    180      7      180    25.71      0 HASH(AV_Receiver); AV_Receiver; on 
                    tmr-netatmo_poll      HASH(0x2836ab8)    125    150      647     4.31  21358 HASH(netatmo_D70:ee:50:03:9e:1a) 
                              HMLAN1          HMLAN_Ready     99  37688      904     0.02      0 HASH(HMLAN1) 
       tmr-netatmo_refreshTokenTimer      HASH(0x2601358)     34      5       45     9.00      3 HASH(Wetter) 
                  tmr-HCS_checkState      HASH(0x2864900)     33    150     2386    15.91  21350 HASH(Heizungcontrol) 
              tmr-FW_closeOldClients                          31    751     4116     5.48  26618 
                                  hm         HMinfo_SetFn     31     10       31     3.10      0 HASH(hm); hm; update 
                   di_yamahaonandoff          DOIF_Notify     29  21775       56     0.00      0 HASH(di_yamahaonandoff); HASH(AV_Receiver) 
            tmr-HMLAN_KeepAliveCheck   keepAliveCk:HMLAN1     26    677       26     0.04   5675 keepAliveCk:HMLAN1 
                tmr-CUL_HM_sndIfOpen     sndIfOpen:HMLAN1     22    843       55     0.07   9323 sndIfOpen:HMLAN1 
            tmr-perfmon_ProcessTimer       HASH(0xde34f8)     19  42619       22     0.00  34386 HASH(0xde34f8) 
                       PCB1_HEIZUNG2           CUL_HM_Set     18     49       25     0.51      0 HASH(PCB1_HEIZUNG2); PCB1_HEIZUNG2; on-for-timer; 0.75 
                            AutoFord            dummy_Set     15     54      357     6.61      0 HASH(AutoFord); AutoFord; present 
                      AutoatHomeFord          notify_Exec     15  21775      379     0.02      0 HASH(AutoatHomeFord); HASH(STEMP_WWOG)

apptime maxDly

Code Auswählen


apptime maxDly



                               name             function    max  count    total  average maxDly 
              tmr-FLUKSO_StatusTimer FluksoStromS0.STATUS      3    745     1104     1.48  34703 FluksoStromS0.STATUS 
              tmr-FLUKSO_StatusTimer   FluksoGasS0.STATUS      2    745     1070     1.44  34701 FluksoGasS0.STATUS 
              tmr-FLUKSO_StatusTimer FluksoWasserS0.STATUS      2    745      838     1.12  34700 FluksoWasserS0.STATUS 
            tmr-YAMAHA_AVR_GetStatus      HASH(0x21042f8)      2    968      890     0.92  34698 HASH(AV_Receiver) 
                tmr-HMLAN_UpdtMsgCnt       UpdtMsg:HMLAN1      0    446        0     0.00  34682 
            tmr-perfmon_ProcessTimer       HASH(0xde34f8)      1  41129        1     0.00  34647 HASH(0xde34f8) 
                    tmr-netatmo_poll      HASH(0x27b7ec0)      4    150      279     1.86  34603 HASH(netatmo_M03:00:00:00:fb:14) 
                    tmr-netatmo_poll      HASH(0x27b8298)      4    150      262     1.75  34603 HASH(netatmo_M03:00:00:00:fa:42) 
                    tmr-netatmo_poll      HASH(0x2836ab8)     41    150      306     2.04  34603 HASH(netatmo_D70:ee:50:03:9e:1a) 
                    tmr-netatmo_poll      HASH(0x2836ea8)      4    150      238     1.59  34603 HASH(netatmo_M02:00:00:03:9a:4c) 
                    tmr-netatmo_poll      HASH(0x2837520)      4    150      287     1.91  34603 HASH(netatmo_M03:00:00:00:fb:a0) 
                  tmr-HCS_checkState      HASH(0x2864900)     33    150     2415    16.10  34594 HASH(Heizungcontrol) 
                    tmr-netatmo_poll      HASH(0x2837160)      3    150      335     2.23  34480 HASH(netatmo_M05:00:00:00:40:40) 
            tmr-HMLAN_KeepAliveCheck   keepAliveCk:HMLAN1     20   1740       20     0.01  34047 keepAliveCk:HMLAN1 
                 tmr-HMLAN_KeepAlive     keepAlive:HMLAN1      1   1733        1     0.00  32340 keepAlive:HMLAN1 
              tmr-FW_closeOldClients                          23    754     3966     5.26  27637 
                 tmr-CUL_HM_ActCheck       ActionDetector     35     76     1584    20.84   9922 ActionDetector 
       tmr-netatmo_refreshTokenTimer      HASH(0x2601358)      3      5       11     2.20   8163 HASH(Wetter) 
               tmr-HttpUtils_ConnErr      HASH(0x3a3f548)     13      1       13    13.00   5573 HASH(0x3a3f548) 
                 tmr-SetExtensionsFn SE FBDECT_22 on-for-timer     11      4       33     8.25   5435 SE FBDECT_22 on-for-timer 
               tmr-HttpUtils_ReadErr      HASH(0x3b4f8f8)      0      2        0     0.00   5233

apptime max all (gekürzt)

Code Auswählen

apptime max all




                                name             function    max  count    total  average maxDly 
                              fb7490           FBAHA_Read  35008   4143  4390524  1059.75      0 HASH(fb7490) 
                              HMLAN1           HMLAN_Read   6135  23249   434954    18.71      0 HASH(HMLAN1) 
                       KellerlichtBW          notify_Exec   1241  39909     1241     0.03      0 HASH(KellerlichtBW); HASH(BEWEGUNG4) 
                           Pushover1         Pushover_Set    929      8     1683   210.38      0 HASH(Pushover1); Pushover1; msg; 'BEWEGUNG'; 'im; Keller'; ''0'siren' 
                      TuerSpeisalert          notify_Exec    758  39909      758     0.02      0 HASH(TuerSpeisalert); HASH(TUER_SPEISE) 
                          HalleVenti          notify_Exec    531  39909     2634     0.07      0 HASH(HalleVenti); HASH(SW_KELLERVORN) 
                          6FachWohn3          notify_Exec    191  39909      191     0.00      0 HASH(6FachWohn3); HASH(6FACH_WOHN_Btn_03) 
                         AV_Receiver       YAMAHA_AVR_Set    180      7      180    25.71      0 HASH(AV_Receiver); AV_Receiver; on 
         FHEMWEB:192.168.77.25:36030              FW_Read    130     19      173     9.11      0 HASH(FHEMWEB:192.168.77.25:36030) 
                    tmr-netatmo_poll      HASH(0x2836ab8)     41    150      306     2.04  34603 HASH(netatmo_D70:ee:50:03:9e:1a) 
                              HMLAN1          HMLAN_Ready     37      1       37    37.00      0 HASH(HMLAN1) 
                 tmr-CUL_HM_ActCheck       ActionDetector     35     76     1584    20.84   9922 ActionDetector 
                  tmr-HCS_checkState      HASH(0x2864900)     33    150     2415    16.10  34594 HASH(Heizungcontrol) 
                                  hm         HMinfo_SetFn     31     10       31     3.10      0 HASH(hm); hm; update 
                   di_yamahaonandoff          DOIF_Notify     29  39909       57     0.00      0 HASH(di_yamahaonandoff); HASH(AV_Receiver) 
         FHEMWEB:192.168.77.25:36032              FW_Read     26     20       87     4.35      0 HASH(FHEMWEB:192.168.77.25:36032) 
              tmr-FW_closeOldClients                          23    754     3966     5.26  27637 
            tmr-HMLAN_KeepAliveCheck   keepAliveCk:HMLAN1     20   1742       20     0.01  34047 keepAliveCk:HMLAN1 
                       PCB1_HEIZUNG2           CUL_HM_Set     18     60      132     2.20      0 HASH(PCB1_HEIZUNG2); PCB1_HEIZUNG2; on-for-timer; 0.75 
                        HKVentilator          notify_Exec     17  39909      104     0.00      0 HASH(HKVentilator); HASH(HEIZ_ELTWOHN) 
                         tmr-at_Exec      HASH(0x1f1be28)     17      1       17    17.00      2 HASH(KugelleuchteAus) 
                       SW_KELLERVORN           CUL_HM_Set     16     91      134     1.47      0 HASH(SW_KELLERVORN); SW_KELLERVORN; off 
                             AutoBus            dummy_Set     15    138      905     6.56      0 HASH(AutoBus); AutoBus; present 
                            AutoFord            dummy_Set     15    147      934     6.35      0 HASH(AutoFord); AutoFord; present 
                       AutoatHomeBus          notify_Exec     15  39909      974     0.02      0 HASH(AutoatHomeBus); HASH(STEMP_WWEG) 
                      AutoatHomeFord          notify_Exec     15  39909      986     0.02      0 HASH(AutoatHomeFord); HASH(STEMP_WWOG) 
                  di_30minsleeptimer          DOIF_Notify     15  39909       22     0.00      0 HASH(di_30minsleeptimer); HASH(AV_Receiver) 
                  act_on_Taste1SEC4B          notify_Exec     14  39909       21     0.00      0 HASH(act_on_Taste1SEC4B); HASH(RC_4B_Btn_02) 
                         tmr-at_Exec      HASH(0x1fcebe8)     14      1       14    14.00     20 HASH(Sonnenaufgang) 
                     DI_FluksoWasser          DOIF_Notify     13  39909      314     0.01      0 HASH(DI_FluksoWasser); HASH(FluksoWasserS0) 
                 FileLog_HEIZ_HALLE1          FileLog_Log     13    155       13     0.08      0 HASH(FileLog_HEIZ_HALLE1); HASH(HEIZ_HALLE1) 
            FileLog_WASSER_KUECHE_EG          FileLog_Log     13  39909       13     0.00      0 HASH(FileLog_WASSER_KUECHE_EG); HASH(STEMP_SONSTIGC_T1_T2) 
                             LS13_Sw           CUL_HM_Set     13     30       13     0.43      0 HASH(LS13_Sw); LS13_Sw; on-for-timer; 3000 
                   LS5_SCHLAFRACK_Sw           CUL_HM_Set     13     30       26     0.87      0 HASH(LS5_SCHLAFRACK_Sw); LS5_SCHLAFRACK_Sw; on 
                   PCB4R_KLEID_Sw_04           CUL_HM_Set     13      7       13     1.86      0 HASH(PCB4R_KLEID_Sw_04); PCB4R_KLEID_Sw_04; on-for-timer; 2.25 
               tmr-HttpUtils_ConnErr      HASH(0x3a3f548)     13      1       13    13.00   5573 HASH(0x3a3f548) 
             BoostModeOn_for10secBad          notify_Exec     12  39909       12     0.00      0 HASH(BoostModeOn_for10secBad); HASH(HEIZ_DACH2_Weather) 
                     Ganglichtautoan          notify_Exec     12  39909      124     0.00      0 HASH(Ganglichtautoan); HASH(TUER_HAUS) 
                          RC8_Taste1          notify_Exec     12  39909       12     0.00      0 HASH(RC8_Taste1); HASH(LS3_BIENE_Pwr) 
            WaterComboPushSirenWasch          notify_Exec     12  39909       20     0.00      0 HASH(WaterComboPushSirenWasch); HASH(HEIZ_DACH2_Clima) 
                           FBDECT_22           FBDECT_Set     11    129       93     0.72      0 HASH(FBDECT_22); FBDECT_22; off 
                       SW_HALLEKUGEL           CUL_HM_Set     11     29       11     0.38      0 HASH(SW_HALLEKUGEL); SW_HALLEKUGEL; off 
            WaterComboPushSirenHalle          notify_Exec     11  39909       11     0.00      0 HASH(WaterComboPushSirenHalle); HASH(FluksoGasS0) 
                 tmr-SetExtensionsFn SE FBDECT_22 on-for-timer     11      4       33     8.25   5435 SE FBDECT_22 on-for-timer 
                   DI_Haustuer_offen          DOIF_Notify      9  39909      137     0.00      0 HASH(DI_Haustuer_offen); HASH(TUER_HAUS) 
                             dew_all      dewpoint_Notify      9  39909        9     0.00      0 HASH(dew_all); HASH(HEIZ_DACH2_Clima) 
                         6FachHalle6          notify_Exec      8  39909        8     0.00      0 HASH(6FachHalle6); HASH(LS3_BIENE_Pwr) 
                       HalleVentiOff          notify_Exec      8  39909       57     0.00      0 HASH(HalleVentiOff); HASH(SW_KELLERVORN) 
                                Hell            dummy_Set      8      7        8     1.14      0 HASH(Hell); Hell; Ja 
                  act_on_Taste2SEC4B          notify_Exec      8  39909       16     0.00      0 HASH(act_on_Taste2SEC4B); HASH(RC_4B_Btn_01) 
                  act_on_Taste4SEC4B          notify_Exec      8  39909       20     0.00      0 HASH(act_on_Taste4SEC4B); HASH(LS3_BIENE_SenPwr) 
               FileLog_netatmo_Regen          FileLog_Log      7  39909        7     0.00      0 HASH(FileLog_netatmo_Regen); HASH(LS9_KTHERMO_SenU) 
                             MP3_BOX           CUL_HM_Set      7      8       14     1.75      0 HASH(MP3_BOX); MP3_BOX; playTone; 003 
                   PCB1_GANGLICHTNEU           CUL_HM_Set      7     16       70     4.38      0 HASH(PCB1_GANGLICHTNEU); PCB1_GANGLICHTNEU; on-for-timer; 1 
                           PCB1_HAUS           CUL_HM_Set      7      7        7     1.00      0 HASH(PCB1_HAUS); PCB1_HAUS; on-for-timer; 1 
                           SW_KELLER           CUL_HM_Set      7     29        7     0.24      0 HASH(SW_KELLER); SW_KELLER; on-for-timer; 180 
                               USW_2           CUL_HM_Set      7     30       14     0.47      0 HASH(USW_2); USW_2; on 
         WaterComboPushSirenKuecheOG          notify_Exec      7  39909        7     0.00      0 HASH(WaterComboPushSirenKuecheOG); HASH(HEIZ_DACH2) 
                                 WEB              FW_Read      6    254       22     0.09      0 HASH(WEB) 
            tmr-CUL_HM_complConfigTO CUL_HM_complConfigTO      6      1        6     6.00      1 CUL_HM_complConfigTO 
                          eventTypes       eventTypes_Get      5      3       15     5.00      0 HASH(eventTypes); eventTypes; list 
                             n_Tag19          notify_Exec      5  39909        5     0.00      0 HASH(n_Tag19); HASH(FluksoGasS0) 
                         6FachHalle2          notify_Exec      4  39909        8     0.00      0 HASH(6FachHalle2); HASH(STEMP_SONSTIGC_T1_T2) 
                         6FachHalle3          notify_Exec      4  39909        4     0.00      0 HASH(6FachHalle3); HASH(STEMP_SONSTIGC_T2_T1) 
           BoostModeOn_for10secHalle          notify_Exec      4  39909        4     0.00      0 HASH(BoostModeOn_for10secHalle); HASH(STEMP_SONSTIGC_T1) 
                     Briefkastenpost          notify_Exec      4  39909        4     0.00      0 HASH(Briefkastenpost); HASH(HEIZ_DACH2) 
                DI_Hallentuer2_offen          DOIF_Notify      4  39909        6     0.00      0 HASH(DI_Hallentuer2_offen); HASH(HEIZ_DACH2_Clima) 
                          RC8_Taste3          notify_Exec      4  39909        4     0.00      0 HASH(RC8_Taste3); HASH(STEMP_SONSTIGC_T2) 
             WaterComboPushSirenDach          notify_Exec      4  39909        8     0.00      0 HASH(WaterComboPushSirenDach); HASH(FluksoGasS0) 
           WaterComboPushSirenKeller          notify_Exec      4  39909        8     0.00      0 HASH(WaterComboPushSirenKeller); HASH(LS3_BIENE_SenI) 
                        dew_fan1_off          notify_Exec      4  39909        4     0.00      0 HASH(dew_fan1_off); HASH(HEIZ_DACH2_Weather) 
                    tmr-netatmo_poll      HASH(0x27b7ec0)      4    150      279     1.86  34603 HASH(netatmo_M03:00:00:00:fb:14) 
                    tmr-netatmo_poll      HASH(0x27b8298)      4    150      262     1.75  34603 HASH(netatmo_M03:00:00:00:fa:42) 
                    tmr-netatmo_poll      HASH(0x2836ea8)      4    150      238     1.59  34603 HASH(netatmo_M02:00:00:03:9a:4c) 
                    tmr-netatmo_poll      HASH(0x2837520)      4    150      287     1.91  34603 HASH(netatmo_M03:00:00:00:fb:a0) 
                            n_Urlaub          notify_Exec      4  39909        4     0.00      0 HASH(n_Urlaub); HASH(FBDECT_22) 
              tmr-FLUKSO_StatusTimer FluksoStromS0.STATUS      3    745     1104     1.48  34703 FluksoStromS0.STATUS 
                    tmr-netatmo_poll      HASH(0x2837160)      3    150      335     2.23  34480 HASH(netatmo_M05:00:00:00:40:40) 
       tmr-netatmo_refreshTokenTimer      HASH(0x2601358)      3      5       11     2.20   8163 HASH(Wetter) 
                         n_Desired17          notify_Exec      3  39909        3     0.00      0 HASH(n_Desired17); HASH(LS9_KTHERMO_SenU) 
                   HEIZ_KUECHE_Clima           CUL_HM_Set      2     45        5     0.11      0 HASH(HEIZ_KUECHE_Clima); HEIZ_KUECHE_Clima; ? 
         WaterComboPushSirenKuecheEG          notify_Exec      2  39909        2     0.00      0 HASH(WaterComboPushSirenKuecheEG); HASH(FBDECT_24) 
              tmr-FLUKSO_StatusTimer   FluksoGasS0.STATUS      2    745     1070     1.44  34701 FluksoGasS0.STATUS 
              tmr-FLUKSO_StatusTimer FluksoWasserS0.STATUS      2    745      838     1.12  34700 FluksoWasserS0.STATUS 
            tmr-YAMAHA_AVR_GetStatus      HASH(0x21042f8)      2    968      890     0.92  34698 HASH(AV_Receiver) 
                 DI_Hallentuer_offen          DOIF_Notify      1  39909        2     0.00      0 HASH(DI_Hallentuer_offen); HASH(TEMP_GARTEN) 
         FHEMWEB:192.168.77.25:36035              FW_Read      1      9        4     0.44      0 HASH(FHEMWEB:192.168.77.25:36035) 
         FHEMWEB:192.168.77.25:36036              FW_Read      1      9        2     0.22      0 HASH(FHEMWEB:192.168.77.25:36036) 
         FHEMWEB:192.168.77.25:36050              FW_Read      1      3        2     0.67      0 HASH(FHEMWEB:192.168.77.25:36050) 
                   FileLog_FBDECT_23          FileLog_Log      1   1030        3     0.00      0 HASH(FileLog_FBDECT_23); HASH(FBDECT_23) 
          FileLog_LS5_SCHLAFRACK_Pwr          FileLog_Log      1    289        1     0.00      0 HASH(FileLog_LS5_SCHLAFRACK_Pwr); HASH(LS5_SCHLAFRACK_Pwr) 
                    HEIZ_WOHN1_Clima           CUL_HM_Set      1     48        3     0.06      0 HASH(HEIZ_WOHN1_Clima); HEIZ_WOHN1_Clima; ? 
                    HEIZ_WOHN2_Clima           CUL_HM_Set      1     44        1     0.02      0 HASH(HEIZ_WOHN2_Clima); HEIZ_WOHN2_Clima; ? 
                   STEMP_SONSTIGC_T1           CUL_HM_Set      1     51        1     0.02      0 HASH(STEMP_SONSTIGC_T1); STEMP_SONSTIGC_T1; ? 
                tmr-CUL_HM_sndIfOpen     sndIfOpen:HMLAN1      1      1        1     1.00      0 sndIfOpen:HMLAN1 
                 tmr-HMLAN_KeepAlive     keepAlive:HMLAN1      1   1734        1     0.00  32340 keepAlive:HMLAN1 
            tmr-perfmon_ProcessTimer       HASH(0xde34f8)      1  41165        1     0.00  34647 HASH(0xde34f8) 
               3FM_BLITZWARNER_BLITZ           CUL_HM_Set      0      6        0     0.00      0 
             3FM_SIEDLEKLINGEL_Sw_01           CUL_HM_Set      0      6        0     0.00      0 
             3FM_SIEDLEKLINGEL_Sw_02           CUL_HM_Set      0      6        0     0.00      0 
                         6FACH_HALLE           CUL_HM_Set      0      6        0     0.00      0 
                          6FACH_WOHN           CUL_HM_Set      0      6        0     0.00      0 
                         6FachHalle1          notify_Exec      0  39909        0     0.00      0 
                         6FachHalle4          notify_Exec      0  39909        0     0.00      0 
                         6FachHalle5          notify_Exec      0  39909        0     0.00      0 
                          6FachWohn1          notify_Exec      0  39909        0     0.00      0 
                          6FachWohn2          notify_Exec      0  39909        0     0.00      0 
                          6FachWohn4          notify_Exec      0  39909        0     0.00      0 
                          6FachWohn5          notify_Exec      0  39909        0     0.00      0 
                          6FachWohn6          notify_Exec      0  39909        0     0.00      0

Ich habe noch verbose=5 eingeschalten und um 8:45:09 Uhr den AKtor SW_DACH zu schalten. Es war kein Schalten möglich (STATE IOerr)

Hier das log

Code Auswählen

2014.11.28 08:45:09 3: CUL_HM set SW_DACH on
2014.11.28 08:45:11 3: CUL_HM set SW_DACH on
2014.11.28 08:45:12 5: HMLAN/RAW: /E5299BC,0000,0157BDF5,FF,FFC6,4D865A5299BC000000A0D937

2014.11.28 08:45:12 5: HMLAN_Parse: HMLAN1 R:E5299BC   stat:0000 t:0157BDF5 d:FF r:FFC6     m:4D 865A 5299BC 000000 A0D937
2014.11.28 08:45:12 5: HMLAN1 dispatch A0C4D865A5299BC000000A0D937::-58:HMLAN1
2014.11.28 08:45:14 5: FBAHA/RAW: /0703001c0000004d001400000000000c0000001400040000000000b90703001c0000004d001400000000000c0000000f0004000000000001070300200000004d00140000000000100000001700080000000000de000000000703001c0000004d001400000000000c000000130004000000037eed0703001c0000004d001400000000000c00000012000400000000005f

ein FBDECT Schalter (FBDECT_22) ließ sich um 8:47:03 einschalten, verursachte aber wohl einen 23 Sekunden Freeze

Code Auswählen


2014.11.28 08:47:02 5: Cmd: >set FBDECT_22 on<
2014.11.28 08:47:02 5: SW: 0703001c0000004d001600000000000c0000000f0004000000000001
2014.11.28 08:47:02 5: Triggering FBDECT_22 (1 changes)
2014.11.28 08:47:02 5: Notify loop for FBDECT_22 set_on
2014.11.28 08:47:02 4: /fhem?XHR=1&cmd.FBDECT_22=set%20FBDECT_22%20on&room=Favourites / RL:20 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / 
2014.11.28 08:47:03 1: Perfmon: possible freeze starting at 08:46:40, delay is 23.055
2014.11.28 08:47:03 5: HMLAN/RAW: /E2D6611,0000,0159703D,FF,FFAD,8484702D661100000000BC3F

2014.11.28 08:47:03 5: HMLAN_Parse: HMLAN1 R:E2D6611   stat:0000 t:0159703D d:FF r:FFAD     m:84 8470 2D6611 000000 00BC3F
2014.11.28 08:47:03 5: HMLAN1 dispatch A0C8484702D661100000000BC3F::-83:HMLAN1
2014.11.28 08:47:04 5: HMLAN/RAW: /E2A4FF8,0000,0159720E,FF,FFCE,23845E2A4FF80000008113BC000000000008E6FE

2014.11.28 08:47:04 5: HMLAN_Parse: HMLAN1 R:E2A4FF8   stat:0000 t:0159720E d:FF r:FFCE     m:23 845E 2A4FF8 000000 8113BC000000000008E6FE
2014.11.28 08:47:04 5: HMLAN1 dispatch A1423845E2A4FF80000008113BC000000000008E6FE::-50:HMLAN1
2014.11.28 08:47:04 5: Triggering LS5_SCHLAFRACK_Pwr (1 changes)

Ein anschließendes FBEDECT_22 devInfo brachte Folgendes:

Code Auswählen

FBAHA_ReadAnswer CONFIG_RSP: Timeout

Hier der Log nach dem FBEDECT_22 devInfo, gab wohl danach einige Probleme:

Code Auswählen

2014.11.28 08:51:16 5: Cmd: >get FBDECT_22 devInfo<
2014.11.28 08:51:16 5: SW: 0503000c0000004d00000000
2014.11.28 08:51:16 5: FBAHA/RAW: /060101680000004d000000000000000000110200000000090000138053616d73756e6720467265657a6572000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000b74303837363120303038353039360000000000000030332e3336000000000000000000000000000000000000000000000200110000000000c00000000f0004000000000001000000230008000000000002000000000000002500400000000000110000000200000001000000140000000500000000000000000000000f0000000000000002000000010000000300000000
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:16 5: FBAHA/RAW: 060101680000004d000000000000000000110200000000090000138053616d73756e6720467265657a6572000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000b74303837363120303038353039360000000000000030332e3336000000000000000000000000000000000000000000000200110000000000c00000000f0004000000000001000000230008000000000002000000000000002500400000000000110000000200000001000000140000000500000000000000000000000f0000000000000002000000010000000300000000/000000000000000200120000000000c00000000f0004000000000001000000230008000000000002000000000000002500400000000000120000000200000001000000140000000500000000000000000000000f0000000000000002000000010000000300000000000000000000000f000000000000001200040000000000960000001300040000000379ac0000001400040000000000000000001500040000000156110000001600040000000000000000001700080000000000f70000000000000017000800000000000000000001060001680000004d00000000000000000013020000000009000013804b75656368652d467265657a65722d546865726d
2014.11.28 08:51:16 5: FBAHA/RAW: 000000000000000f000000000000001200040000000000960000001300040000000379ac0000001400040000000000000000001500040000000156110000001600040000000000000000001700080000000000f70000000000000017000800000000000000000001060001680000004d00000000000000000013020000000009000013804b75656368652d467265657a65722d546865726d/6f2d4b61666665650000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000b74303837363120303038313234330000000000000030332e3336000000000000000000000000000000000000000000000200130000000000c00000000f0004000000000001000000230008000000000002000000000000002500400000000000130000000200000001000000140000000500000000000000000000000f0000000000000002000000010000000300000000000000000000000f00000000000000120004000000000dfe000000130004000000037943000000140004000000001e57
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:16 1: FBDECT: unknown message type 00
2014.11.28 08:51:16 1: PERL WARNING: substr outside of string at ./FHEM/00_FBAHA.pm line 166.
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (94720)
2014.11.28 08:51:16 1: PERL WARNING: Use of uninitialized value in concatenation (.) or string at ./FHEM/00_FBAHA.pm line 166.
2014.11.28 08:51:16 5: FBAHA/RAW: /00400000000000140000000200000001000000140000000500000000000000000000000f0000000000000002000000010000000300000000000000000000000f0000000000000012000400000000005f000000130004000000037c8e0000001400040000000000b900000015000400000003152300000016000400000000035d0000001700080000000000de0000000000000017000800000000000000000001060001680000004d0000000000000000001602000000000900001380436f6c6120467265657a65720000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:16 5: FBAHA/RAW: /0000000000000001060001680000004d000000000000000000170200000000090000138048616c6c6520504300000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000b74303837363120303030383731390000000000000030332e3336000000000000000000000000000000000000000000000200170000000000c00000000f0004000000000001000000230008000000000002000000000000002500400000000000170000000200000001000000140000000500000000000000000000000f000000000000000200000001
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:16 5: FBAHA/RAW: /0000000300000000000000000000000f000000000000001200040000000001f9000000130004000000037c4e0000001400040000000001ed00000015000400000001e25b0000001600040000000001ab0000001700080000000000b50000000000000017000800000000000000000001060001680000004d0000000000000000001802000000000900001380456c7465726e205043000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000b74303837363120303131313532350000000000000030332e333600000000000000
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (6)
2014.11.28 08:51:16 5: FBAHA/RAW: /000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000b74303837363120303131313237390000000000000030332e3336000000000000000000000000000000000000000000000200190000000000c00000000f0004000000000001000000230008000000000002000000000000002500400000000000190000000200000001000000140000000500000000000000000000000f0000000000000002000000010000000300000000000000000000000f000000000000001200040000000003c3000000130004000000037c7200000014
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:16 5: FBAHA/RAW: /0000000000000001
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)
2014.11.28 08:51:19 1: 192.168.77.1:2002 disconnected, waiting to reappear (fb7490)
2014.11.28 08:51:19 5: Triggering fb7490 (1 changes)
2014.11.28 08:51:19 5: Notify loop for fb7490 DISCONNECTED
2014.11.28 08:51:19 4: /fhem&detail=FBDECT_22&dev.getFBDECT_22=FBDECT_22&cmd.getFBDECT_22=get&arg.getFBDECT_22=devInfo&val.getFBDECT_22= / RL:1012 / text/html; charset=UTF-8 / Content-Encoding: gzip
 / 
2014.11.28 08:51:19 1: 192.168.77.1:2002 reappeared (fb7490)
2014.11.28 08:51:19 1: 192.168.77.1:2002 reappeared (fb7490)
2014.11.28 08:51:19 5: SW: 0003000c0000000000022005
2014.11.28 08:51:19 5: FBAHA/RAW: /010300100000004e0000004e00022005
2014.11.28 08:51:19 1: FBAHA fb7490 registered with handle: 0000004e
2014.11.28 08:51:19 5: SW: 030300100000004e0000038200000000
2014.11.28 08:51:19 5: Triggering fb7490 (1 changes)
2014.11.28 08:51:19 5: Notify loop for fb7490 CONNECTED
2014.11.28 08:51:19 1: Perfmon: possible freeze starting at 08:51:17, delay is 2.908
2014.11.28 08:51:19 4: Connection closed for FHEMWEB:192.168.77.25:36117
2014.11.28 08:51:20 5: FBAHA/RAW: /0703001c0000004e001700000000000c0000001400040000000001e6
2014.11.28 08:51:20 5: fb7490 dispatch 0703001c0000004e001700000000000c0000001400040000000001e6

Grüße
Chris

martinp876 · 29 November 2014, 17:07:01

und was sit jetzt FBAHA? Das Blockiert so 34sec.

chriz · 29 November 2014, 19:18:33

Hallo Martin,

das FBAHA Modul verbindet sich mit dem AHA (AVM Home Automation) Server auf der FRITZ!Box. Es dient als "physikalisches" Gegenstück zum FBDECT Modul.

Ich betreibe so einige Fritz DECT!200 Schaltsteckdosen.

Grüße
Chris

martinp876 · 29 November 2014, 20:36:03

jedenfalls bracht der einmal 31sec - das ist zu lang.
wenn du den weglässt, klappt dann alles andere?

chriz · 29 November 2014, 21:05:11

Die Freezes kommen leider nur sporadisch, nicht reproduzierbar. Von daher kann ich FBAHA nicht direkt verurteilen - zumal es ja Monate vorher absolut problemlos funktionierte. Ich steuere momentan 8 DECT Schaltsteckdosen über FBAHA, die dringend benötigt werden.

Kannst du aus den geposteten Logs evtl. noch eine andere Fehlerquelle ausmachen?

Grüße
Chris

rudolfkoenig · 30 November 2014, 10:09:38

FBAHA ist "mein" Modul, deswegen habe ich das jetzt nochmal naeher angeschaut:

- ich weiss nicht was Martin mit "31sec" meint, wenn er den Eintrag mit 34.709 aus apptime meint, dann bin ich erstmal ratlos. Es kann dann auftreten, falls select eine Aktivitaet meldet, und sysread einen definierten String der Laenge 0 zurueckliefert. Sowas hielt ich bisher bei TCP/IP fuer unmoeglich. Ich habe DevIo modifiziert, so dass in diesem Fall ein select vor dem "ungluecklichen" sysread vorgeschaltet wird.

- Die Meldung

Code Auswählen

2014.11.28 08:51:16 5: FBAHA/RAW: /06010168...
2014.11.28 08:51:16 1: FBAHA: resetting buffer as we are out of sync (0)

kann ich nur mit einem kaputten perl oder mit einem geaenderten FBAHA.pm erklaeren: "bei out of sync" wird im Klammer der nach dezimal gewandelte und mit 2 multiplizierte 4. bis 8. Stelle des direkt vorher ausgegebenen Strings gemeldet. Sollte in diesem Fall 720 und nicht 0 sein, und deswegen gar keine Meldung kommen.

- generell kann "out of sync" dann kommen, falls der AHA Server auf dem Fritzbox lange Datensaetze meldet (> 256 Byte), und der FHEM Server so stark belastet/blockiert ist, dass es die weiteren Strings erst nach 1 Sekunde abholt. Ich habe jetzt die auf einmal abgeholten Daten von 256 Byte auf 4096 erhoeht, und den Timeout von 1 auf 5 Sekunden geaendert. Achtung: im beigefuegten Log war das nicht der Fall, d.h. meine Aenderung sollte keine Auswirkung haben.

Zitatein FBDECT Schalter (FBDECT_22) ließ sich um 8:47:03 einschalten, verursachte aber wohl einen 23 Sekunden Freeze

Das kann man mAn aus dem gezeigten Log nicht folgern: das FBDECT Modul hat den Befehl um 08:47:02 erhalten, und innerhalb dieser Sekunde war es auch fertig damit. Apropos: beim debuggen dieser Detailtiefe hilft ein "attr global mseclog".

@chriz:
- verwendest du noch weitere Geraete, die auf dem AHA@FB zugreifen, z.Bsp. Dect-Telefone?
- welches OS hat die FritzBox?
- was ist das fuer ein Perl bzw. Hardware was du fuer FHEM verwendest? Die "out of sync" Meldung finde ich sehr verstoerend. Btw. ich habe auf meinem System noch nie ein "out of sync" gesehen.

chriz · 30 November 2014, 11:48:25

Hallo Rudolf,

meine aktuellen FHEM Module sind

Code Auswählen


# $Id: fhem.pl 6913 2014-11-08 10:32:44Z rudolfkoenig $ 
# $Id: 10_CUL_HM.pm 7047 2014-11-23 09:52:33Z martinp876 $ 
# $Id: 70_EGPM.pm 5344 2014-03-27 20:06:31Z alexus2033 $ 
# $Id: 17_EGPM2LAN.pm 5344 2014-03-27 20:06:31Z alexus2033 $ 
# $Id: 00_FBAHA.pm 6771 2014-10-15 17:59:23Z rudolfkoenig $ 
# $Id: 10_FBDECT.pm 6771 2014-10-15 17:59:23Z rudolfkoenig $ 
# $Id: 72_FB_CALLMONITOR.pm 6852 2014-11-01 17:23:29Z markusbloch $ 
# $Id: 01_FHEMWEB.pm 7024 2014-11-19 23:07:39Z rudolfkoenig $ 
# $Id: 92_FileLog.pm 7062 2014-11-25 09:15:57Z rudolfkoenig $ 
# $Id: 59_HCS.pm 4433 2013-12-21 05:30:49Z tobiasfaust $ 
# $Id: 00_HMLAN.pm 6471 2014-08-27 12:32:38Z martinp876 $ 
# $Id: 98_HMinfo.pm 7048 2014-11-23 10:49:21Z martinp876 $ 
# $Id: 99_SUNRISE_EL.pm 6765 2014-10-14 18:24:29Z rudolfkoenig $ 
# $Id: 98_SVG.pm 7075 2014-11-27 20:59:58Z rudolfkoenig $ 
# $Id: 99_Utils.pm 6660 2014-10-03 06:35:43Z rudolfkoenig $ 
# $Id: 71_YAMAHA_AVR.pm 6915 2014-11-08 11:14:55Z markusbloch $ 
# $Id: 98_apptime.pm 6126 2014-06-17 05:44:54Z martinp876 $ 
# $Id: 90_at.pm 7000 2014-11-16 16:51:50Z rudolfkoenig $ 
# $Id: 98_autocreate.pm 6505 2014-09-06 12:24:48Z rudolfkoenig $ 
# $Id: 98_dewpoint.pm 6757 2014-10-12 18:58:57Z joachim09876 $ 
# $Id: 98_dummy.pm 4934 2014-02-15 08:23:12Z rudolfkoenig $ 
# $Id: 91_eventTypes.pm 6792 2014-10-19 16:03:13Z rudolfkoenig $ 
# $Id: 38_netatmo.pm 6876 2014-11-03 18:24:57Z justme1968 $ 
# $Id: 91_notify.pm 7002 2014-11-16 17:23:35Z rudolfkoenig $ 
# $Id: 98_telnet.pm 6611 2014-09-24 07:48:32Z rudolfkoenig $ 
# $Id: 98_update.pm 6784 2014-10-18 09:12:57Z rudolfkoenig $

Ich nutze via FHEM noch den FB_CALLMONITOR, der greift aber wohl nicht auf FBAHA zu.
An meiner Fritzbox 7490 (aktuelles FritzOS 6.20) sind noch 5 normale Fritz DECT Telefone sowie 1 Fritz DECT Repeater angemeldet.

Als Hardware für den FHEM Server nutze ich einen Intel NUC mit Ubuntu (Ubuntu 14.04.1 LTS GNU/Linux 3.13.0-24-generic x86_64).
In einer Verzweiflungstat bin ich die Tage testweise von einem Intel NUC (Dualcore Celeron N2820 CPU, 4GB RAM, SSD) auf einen wesentlich leistungsstärkeren Intel NUC i3 (Dualcore Core i3-4010U CPU, 8GB RAM, SSD) umgezogen.

Code Auswählen


Fhem info: 
  Release  : 5.6 
  Branch   : DEVELOPMENT 
  OS       : linux 
  Arch     : x86_64-linux-gnu-thread-multi 
  Perl     : v5.18.2

Hier noch meine devList und Internals der FBDECT Schaltsteckdosen

Code Auswählen


NAME:Samsung Freezer, ID:17, active, TYPE:AVM FRITZ!Dect 200 PROP:powerMeter,switch 
NAME:Geschirrspueler Siemens, ID:18, active, TYPE:AVM FRITZ!Dect 200 PROP:powerMeter,switch 
NAME:Kueche-Freezer-Thermo-Kaffee, ID:19, active, TYPE:AVM FRITZ!Dect 200 PROP:powerMeter,switch 
NAME:Wasserbett, ID:20, active, TYPE:AVM FRITZ!Dect 200 PROP:powerMeter,switch 
NAME:Cola Freezer, ID:22, active, TYPE:AVM FRITZ!Dect 200 PROP:powerMeter,switch 
NAME:Halle PC, ID:23, active, TYPE:AVM FRITZ!Dect 200 PROP:powerMeter,switch 
NAME:Eltern PC, ID:24, active, TYPE:AVM FRITZ!Dect 200 PROP:powerMeter,switch 
NAME:Eltern TV, ID:25, active, TYPE:AVM FRITZ!Dect 200 PROP:powerMeter,switch 
NAME:FRITZ!DECT Rep 100 #1, ID:16, active, TYPE:unknown(10) PROP:0,0 

---

Clients
:FBDECT:
DEF	
192.168.77.1:2002
DeviceName
192.168.77.1:2002
FD
177
HANDLE
00000001
NAME
fb7490
NR
1238
PARTIAL
RAWMSG
0703001c00000001001100000000000c000000160004000000000163
STATE
Initialized
TYPE
FBAHA
fb7490_MSGCNT
2768
fb7490_TIME
2014-11-30 11:46:56

Und danke für den Tipp "attr global mseclog", werde ich bei den nächsten Freezes mit einsetzen.

Grüße
Chris