Neues Modul: 98_FREEZEMON Freezes monitoren und Verursacher identifizieren

Paul.baumann · 16 April 2018, 16:52:52

Ah ok, das sieht schon anders aus... vielen Dank.

andies · 17 April 2018, 20:13:20

Kann mir jemand helfen, ich kriege diese Nachrichten

1 - 2018-04-17: s:19:52:02 e:19:52:05 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:19:53:05 e:19:53:08 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:19:54:08 e:19:54:11 f:3.009 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:19:55:11 e:19:55:14 f:3.009 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:19:56:14 e:19:56:17 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:19:57:17 e:19:57:20 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:19:58:20 e:19:58:23 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:19:59:23 e:19:59:26 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:00:26 e:20:00:29 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:01:29 e:20:01:32 f:3.006 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:02:32 e:20:02:35 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:03:35 e:20:03:38 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:04:38 e:20:04:41 f:3.009 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:05:41 e:20:05:44 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:06:44 e:20:06:47 f:3.009 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:07:47 e:20:07:50 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:08:50 e:20:08:53 f:3.008 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:09:53 e:20:09:56 f:3.009 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:10:56 e:20:10:59 f:3.009 d:tmr-FW_closeInactiveClients(N/A) 
1 - 2018-04-17: s:20:11:59 e:20:12:02 f:3.009 d:tmr-FW_closeInactiveClients(N/A)

und kann damit nichts anfangen, da mir der Prozess nichts sagt (google auch nicht).

KernSani · 18 April 2018, 06:45:24

Das ist auch so ein whitelist-Kandidat (s.o). Auch hier gilt: Versuche mit fm_logFile und ggf. den catch.*-Attributen den wahren Verursacher heraus zu finden.

Kurz, weil mobil...

Inputsammler · 23 April 2018, 13:16:13

Hey,

danke erstmal für dein super Erweiterung. Habe den 99_perfmon.pm nun in Rente geschickt.

Habe nur eine Frage. Bekomme immer beim neustart von FHEM diese Meldung.

Code Auswählen

2018.04.23 13:10:01 1: PERL WARNING: Use of uninitialized value in string ne at ./FHEM/98_freezemon.pm line 322.
2018.04.23 13:10:01 1: [Freezemon] myFreezemon: possible freeze starting at 13:09:58, delay is 3.463 possibly caused by: no bad guy found :-(
2018.04.23 13:10:01 1: PERL WARNING: Use of uninitialized value $FW_ME in concatenation (.) or string at ./FHEM/98_freezemon.pm line 1206.

Habe ich das was falsch gemacht.
Version --> 98_freezemon.pm 16571 2018-04-08 19:57:54Z KernSani

Gruß Gerd

KernSani · 23 April 2018, 22:55:51

Hi Gerd,

die WARNINGS sind komisch... Die erste Warning deutet darauf hin, dass ein Freeze erkannt wird, bevor der freeze-Cycle richtig begonnen hat - das kann eigentlich nicht sein... Und die zweite Warning sagt, dass FHEMWEB noch nicht geladen ist, was eigentlich auch nicht sein sollte, außer du verwendest die Weboberfläche nicht, oder du hast freezemon manuell in der fhem.cfg vor FHEMWEB geschoben... Ist eines davon der Fall?

Grüße,

Oli

Navigator · 06 Mai 2018, 14:38:22

Warum werden bei mir eigentlich manche Timer die definiert werden als Freezes erkannt?

Code Auswählen


13:54:39, delay is 1.729 possibly caused by: tmr-at_Exec(A_Bewaesserung_Next_Kreis_5)

Diese AT werden bei mir aus der myUtils heraus erzeugt.

KernSani · 06 Mai 2018, 23:22:56

Hi Dittel,

die Ausführung des ats (durch die Sub at_Exec des at-Moduls) scheint länger zu dauern. Genaueres bekommst du vermutlich über das logFile (Attribut fm_logFile) heraus.

Grüße,

Oli

Navigator · 08 Mai 2018, 16:45:45

Hmmm, also im Log kann ich richtig "lange" Verzögerungen nur von "createNotifyHash" ausmachen. Das dauert dort immer ca. eine halbe Sekunde. Was passiert hier?

KernSani · 09 Mai 2018, 06:11:39

Was macht denn das AT? Magst du das Log posten (Achtung bei persönlichen Daten)

Kurz, weil mobil...

Navigator · 09 Mai 2018, 19:44:09

So viel passiert da eigentlich gar nicht. Es wird ein Reading geschrieben und ein HM Wired Aktor betätigt.

Code Auswählen

fhem ("define A_Bewaesserung_Ende_Kreis_$durchgang at +00:$dauer setreading Bewaesserung_Kreis_Vorwahl status$durchgang abgeschlossen;;set HMW_Kreis_$durchgang off")

Habe mal das den kompletten Freezelog für diesen Abschnitt per PM geschickt.

arthur_dent_2015 · 25 Mai 2018, 19:49:20

Moin zusammen,
ich habe seit einigen Tagen ständig Meldungen von tmr Aufrufen im Log

Code Auswählen


1 - 2018-05-25 [Log]: s:18:35:35 e:18:35:37 f:2.214 d:tmr-harmony_ping(hub1) tmr-VIERA_GetStatus(Viera_Wz) 
1 - 2018-05-25 [Log]: s:18:37:35 e:18:37:37 f:2.034 d:tmr-VIERA_GetStatus(Viera_Wz) 
1 - 2018-05-25 [Log]: s:18:38:35 e:18:38:39 f:4.411 d:no bad guy found :-(
1 - 2018-05-25 [Log]: s:18:38:47 e:18:38:49 f:2.124 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update...
1 - 2018-05-25 [Log]: s:18:39:35 e:18:39:37 f:2.092 d:tmr-HMUARTLGW_CheckCredits(N/A) tmr-VIERA_GetStatus(Viera_Wz) 
1 - 2018-05-25 [Log]: s:18:41:35 e:18:41:37 f:2.222 d:tmr-VIERA_GetStatus(Viera_Wz) 
1 - 2018-05-25 [Log]: s:18:43:35 e:18:43:37 f:2.177 d:tmr-CUL_HM_procQs(N/A) tmr-VIERA_GetStatus(Viera_Wz) 
1 - 2018-05-25 [Log]: s:18:45:35 e:18:45:37 f:2.18 d:tmr-harmony_ping(hub1) tmr-VIERA_GetStatus(Viera_Wz) 
1 - 2018-05-25 [Log]: s:18:47:35 e:18:47:37 f:2.01 d:tmr-HMLAN_KeepAlive(N/A) tmr-VIERA_GetStatus(Viera_Wz) 
1 - 2018-05-25 [Log]: s:18:48:59 e:18:49:01 f:2.134 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update...
1 - 2018-05-25 [Log]: s:18:59:11 e:18:59:13 f:2.209 d:tmr-at_Exec(heartbeat) tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sdu...
1 - 2018-05-25 [Log]: s:19:01:49 e:19:01:51 f:2.448 d:tmr-HMLAN_KeepAliveCheck(N/A) tmr-CUL_HM_procQs(N/A) tmr-CUL_MAX_BroadcastTime(cm) tmr...
1 - 2018-05-25 [Log]: s:19:04:18 e:19:04:20 f:2.936 d:tmr-HMLAN_KeepAlive(N/A) tmr-WOL_UpdateReadings(NAS542_ping) tmr-SIGNALduino_KeepAlive...
1 - 2018-05-25 [Log]: s:19:10:26 e:19:10:28 f:2.146 d:tmr-PRESENCE_StartLocalScan(IPCam) tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_K...
1 - 2018-05-25 [Log]: s:19:14:31 e:19:14:33 f:2.154 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update...
1 - 2018-05-25 [Log]: s:19:17:36 e:19:17:40 f:4.373 d:tmr-VIERA_GetStatus(Viera_Wz) tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAl...
1 - 2018-05-25 [Log]: s:19:21:43 e:19:21:45 f:2.111 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update...
1 - 2018-05-25 [Log]: s:19:25:48 e:19:25:50 f:2.076 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update...
1 - 2018-05-25 [Log]: s:19:31:55 e:19:31:57 f:2.1 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(R...
1 - 2018-05-25 [Log]: s:19:32:35 e:19:32:38 f:3.409 d:tmr-rssFeed_GetUpdate(My_VMZrss) tmr-rssFeed_GetUpdate(My_NPrss)

List vom freezemon:

Code Auswählen


Internals:
   CFGFN      
   NAME       myFreezemon
   NR         923
   NTFY_ORDER 99-myFreezemon
   STATE      s:19:42:07 e:19:42:09 f:2.1 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(Raspi) 
   TYPE       freezemon
   VERSION    0.0.20
   Helper:
     DBLOG:
       fcDay:
         fhemlogDB:
           TIME       1527270129.17463
           VALUE      194
       freezeDevice:
         fhemlogDB:
           TIME       1527270129.17463
           VALUE      tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(Raspi) 
       freezeTime:
         fhemlogDB:
           TIME       1527270129.17463
           VALUE      2.1
       ftDay:
         fhemlogDB:
           TIME       1527270129.17463
           VALUE      445.639
       state:
         fhemlogDB:
           TIME       1527270129.17463
           VALUE      s:19:42:07 e:19:42:09 f:2.1 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(Raspi) 
   READINGS:
     2018-05-25 19:42:09   fcDay           194
     2018-05-25 00:00:26   fcDayLast       327
     2018-05-25 19:42:09   freezeDevice    tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(Raspi) 
     2018-05-25 19:42:09   freezeTime      2.1
     2018-05-25 19:42:09   ftDay           445.639
     2018-05-25 00:00:26   ftDayLast       755.082
     2018-05-25 19:42:09   state           s:19:42:07 e:19:42:09 f:2.1 d:tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(Raspi) 
   helper:
     DISABLED   0
     TIMER      1527270353
     apptime    
     fn         
     freeze     2.10040211677551
     intCount   26
     msg        [Freezemon] myFreezemon: possible freeze starting at 19:42:07, delay is 2.1 possibly caused by: tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(Raspi) 
     now        1527270129.1004
     bm:
       freezemon_Get:
         cnt        5
         dmx        -1000
         dtot       0
         dtotcnt    0
         mTS        25.05. 19:35:38
         max        0.022130012512207
         tot        0.0885062217712402
         mAr:
           HASH(0x63c69f8)
           myFreezemon
           freeze
       freezemon_Notify:
         cnt        150705
         dmx        -1000
         dtot       0
         dtotcnt    0
         mTS        25.05. 11:26:08
         max        0.00241708755493164
         tot        12.5764615535736
         mAr:
           HASH(0x63c69f8)
           HASH(0x66621e0)
       freezemon_Set:
         cnt        266
         dmx        -1000
         dtot       0
         dtotcnt    0
         mTS        25.05. 06:24:22
         max        0.000212907791137695
         tot        0.0114676952362061
         mAr:
           HASH(0x63c69f8)
           myFreezemon
           ?
     inAt:
       HASH(0x8e45198)
       HASH(0x8c60db8)
       HASH(0x8e8f998)
       HASH(0x91bd438)
       HASH(0x91bcb68)
       HASH(0x91b0488)
       HASH(0x91c5178)
       HASH(0x91b6090)
       HASH(0x91be4d0)
       HASH(0x91b1df8)
       HASH(0x7a853f8)
       HASH(0x91ca6c0)
       HASH(0x91c87b8)
       HASH(0x6b2a990)
       HASH(0x8eabee0)
       HASH(0x91c7bd8)
       HASH(0x8e6cbf8)
       HASH(0x8c148b0)
       HASH(0x91b8140)
       HASH(0x8fc7628)
       HASH(0x91b5fb8)
       HASH(0x8c61760)
       HASH(0x1c33090)
       HASH(0x90fed60)
       HASH(0x80817f0)
       HASH(0x8ebadb8)
       HASH(0x87bdec8)
       HASH(0x8813f78)
       HASH(0x91b09b0)
       HASH(0x90ff3d8)
       HASH(0x91b60f0)
       HASH(0x8227330)
       HASH(0x8fb7a40)
       HASH(0x91c8998)
       HASH(0x8fc6ff8)
       HASH(0x91b9c80)
       HASH(0x8e458a0)
       HASH(0x8c21a00)
       HASH(0x91b30a8)
       HASH(0x89d0c80)
       HASH(0x91b1ee8)
       HASH(0x8601748)
       HASH(0x7812350)
       HASH(0x74c1570)
       HASH(0x8e8ae10)
       HASH(0x6ae9a98)
       HASH(0x8fc23b8)
       HASH(0x8eb5120)
       HASH(0x91a2748)
       HASH(0x8fc20a0)
       HASH(0x8c58288)
       HASH(0x8c6a5a0)
       HASH(0x9050e00)
       HASH(0x9101478)
       HASH(0x849c6d8)
       HASH(0x9019130)
       HASH(0x8a8ab28)
       HASH(0x905eae8)
       HASH(0x8eb6728)
       HASH(0x91b78a0)
       HASH(0x393ef28)
       HASH(0x6b451c8)
       HASH(0x393eac0)
       HASH(0x6a74080)
       HASH(0x832a0f8)
       HASH(0x455f070)
       HASH(0x66e70d8)
       HASH(0x6ae0728)
       HASH(0x1c30668)
       HASH(0x393edd8)
       HASH(0x6a68448)
       HASH(0x6b461c0)
       HASH(0x6b47ac0)
       HASH(0x1d36b88)
       HASH(0x6ae8998)
       HASH(0x1df2ae8)
       HASH(0x6a3da90)
       HASH(0x6b46028)
       HASH(0x6a6a278)
       HASH(0x6a71020)
       HASH(0x6a7c3d8)
       HASH(0x1e0eee0)
       HASH(0x393f0f0)
       HASH(0x1d7f948)
       HASH(0x8e98658)
       HASH(0x6a13c60)
       HASH(0x45c9fe0)
       HASH(0x4f812a0)
       HASH(0x7a082b8)
       HASH(0x21f6680)
       HASH(0x56c35d0)
       HASH(0x43f5198)
       HASH(0x262b680)
       HASH(0x456c958)
       HASH(0x3bd6250)
       HASH(0x3c1e4e0)
       HASH(0x6b48da0)
       HASH(0x1e1f918)
       HASH(0x6ab2ed0)
       HASH(0x6abc670)
       HASH(0x6b43a50)
       HASH(0x6a7c870)
       HASH(0x6b48ae8)
       HASH(0x6b7c190)
       HASH(0x1e19148)
       HASH(0x6b912f8)
       HASH(0x2a3da88)
       HASH(0x6b43df8)
       HASH(0x6b48810)
       HASH(0x6b48ce0)
       HASH(0x6b7c328)
       HASH(0x1bf11b0)
       HASH(0x1d776e0)
       HASH(0x7343f40)
       HASH(0x6779ee8)
       HASH(0x680ff90)
       HASH(0x687c5e8)
       HASH(0x737e3c8)
       HASH(0x73802e0)
       HASH(0x6d34360)
       HASH(0x6f91d28)
       HASH(0x6d3f278)
       HASH(0x765d598)
       HASH(0x69f0b98)
       HASH(0x1c39468)
       HASH(0x76f12f0)
       HASH(0x7740318)
       HASH(0x1d83cd8)
       HASH(0x6c5f800)
       HASH(0x77b6750)
       HASH(0x77bc5f8)
       HASH(0x6b46388)
       HASH(0x7bf5820)
       HASH(0x7bfa5c0)
       HASH(0x77fb058)
       HASH(0x9019bb0)
       HASH(0x68b4f68)
       HASH(0x7b475f8)
       HASH(0x79e8398)
       HASH(0x6a0ad60)
       HASH(0x7bf9e28)
       HASH(0x7b691c8)
       HASH(0x7bcf7c0)
       HASH(0x6a6a518)
       HASH(0x8e79610)
       HASH(0x8e86608)
       HASH(0x903e570)
     logfilequeue:
     logqueue:
       ARRAY(0x91bcd18)
       ARRAY(0x91b78e8)
       ARRAY(0x8fe9c80)
       ARRAY(0x91ca8b8)
       ARRAY(0x91a5028)
       ARRAY(0x91c9028)
       ARRAY(0x8fc3af8)
       ARRAY(0x91a2478)
       ARRAY(0x91b3138)
       ARRAY(0x74bec78)
       ARRAY(0x91cfa48)
       ARRAY(0x91d0498)
Attributes:
   fm_forceApptime 1
   fm_freezeThreshold 2
   fm_log     100
   fm_logFile ./log/freeze-%Y%m%d-%H%M%S.log
   fm_logKeep 100

Echte Verzögerungen sind aber nicht wahrnehmbar. Was muss ich tun damit mir das Log nicht zugemüllt wird?
Danke & Gruß
Arthur

KernSani · 31 Mai 2018, 22:13:49

Hmmm... kannst du vielleicht mal ein Log eines "unechten" Freezes anhängen? Evtl. helfen auch die fm_catch.* Attribute dem Übeltäter auf die Spur zu kommen...

Grüße,

Oli

arthur_dent_2015 · 01 Juni 2018, 16:43:43

Hier mal ein Log von heute Morgen:

Code Auswählen


jump to the end

=========================================================

[Freezemon] myFreezemon: possible freeze starting at 08:19:54, delay is 2.491 possibly caused by: tmr-PRESENCE_StartLocalScan(Raspi2) tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(Raspi) tmr-DbLog_execmemcache(fhemlogDB) tmr-JeeLink_OnTimer(N/A) tmr-JeeLink_OnTimer(N/A) tmr-CUL_HM_procQs(N/A) tmr-HMUARTLGW_CheckCredits(N/A) 

2018.06.01 08:19:53.057 5: PRESENCE (Raspi2) - stopping timer

2018.06.01 08:19:53.058 5: PRESENCE (Raspi2) - starting blocking call for mode lan-ping

2018.06.01 08:19:53.079 4: BlockingCall (PRESENCE_DoLocalPingScan): created child (25504), uses tPortLocal to connect back

2018.06.01 08:19:53.120 4: Connection accepted from tPortLocal_127.0.0.1_47888

2018.06.01 08:19:53.124 5: Cmd: >{BlockingRegisterTelnet($cl,2529)}<

--- log skips     3.282 secs.

2018.06.01 08:19:56.406 4: sduino/keepalive ok, retry = 0

2018.06.01 08:19:56.406 4: sduino3/keepalive ok, retry = 0

2018.06.01 08:19:56.409 5: SYSMON Raspi: updateReadings.1060 

2018.06.01 08:19:56.433 4: BlockingCall (SYSMON_blockingCall): created child (25509), uses tPortLocal to connect back

2018.06.01 08:19:56.440 4: DbLog fhemlogDB -> ################################################################

2018.06.01 08:19:56.440 4: DbLog fhemlogDB -> ###      New database processing cycle - asynchronous        ###

2018.06.01 08:19:56.440 4: DbLog fhemlogDB -> ################################################################

2018.06.01 08:19:56.440 4: DbLog fhemlogDB -> MemCache contains 74 entries to process

2018.06.01 08:19:56.440 4: DbLog fhemlogDB -> DbLogType is: History

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|mapleCUN1|CUL|UNKNOWNCODE N0298C1903D798053EA01B2237B|state|UNKNOWNCODE N0298C1903D798053EA01B2237B|

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03020406795A00FFFFFFFFF759BB1D7D26102E1C65E190C09149F03391D8DEDC6B|state|UNKNOWNCODE N03020406795A00FFFFFFFFF759BB1D7D26102E1C65E190C09149F03391D8DEDC6B|

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03020406795A00000000067764AAF4C8DCC967CB13FF6D377674FD17BD2B89DB77|state|UNKNOWNCODE N03020406795A00000000067764AAF4C8DCC967CB13FF6D377674FD17BD2B89DB77|

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|BM_HM_Kueche|CUL_HM|state: noMotion|state|noMotion|

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|log_all_events|DOIF|cmd_nr: 1|cmd_nr|1|

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|log_all_events|DOIF|cmd: 1|cmd|1|

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|log_all_events|DOIF|cmd_event: BM_HM_Kueche|cmd_event|BM_HM_Kueche|

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|log_all_events|DOIF|state: cmd_1|state|cmd_1|

2018.06.01 08:19:56.442 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:23|mapleCUN1|CUL|UNKNOWNCODE N0299065243BB802E7C0C1C2E48|state|UNKNOWNCODE N0299065243BB802E7C0C1C2E48|

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:25|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03010426E3B600FFFFFFFF64E81CEF9C4A7C6211218E9CB5AC3BB31CD4604608EF|state|UNKNOWNCODE N03010426E3B600FFFFFFFF64E81CEF9C4A7C6211218E9CB5AC3BB31CD4604608EF|

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:26|mapleCUN1|CUL|UNKNOWNCODE N029086396AA806149884C904F6|state|UNKNOWNCODE N029086396AA806149884C904F6|

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:26|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03070406CF3300FFFFFFFF12170253D03BE7E26AA15E2FEB7E712A79A6A6EEBCD6|state|UNKNOWNCODE N03070406CF3300FFFFFFFF12170253D03BE7E26AA15E2FEB7E712A79A6A6EEBCD6|

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:27|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03030426E3C600FFFFFFFFA4B73A61EFF77E27B25993D88159ABE21AACE37BFBE8|state|UNKNOWNCODE N03030426E3C600FFFFFFFFA4B73A61EFF77E27B25993D88159ABE21AACE37BFBE8|

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:27|mapleCUN1|CUL|UNKNOWNCODE N029A06334520311637C60332B8|state|UNKNOWNCODE N029A06334520311637C60332B8|

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:27|HMS100TF_4328_Balkon|HMS|temperature: 23.3|temperature|23.3|°C

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:29|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N0304040384EC00FFFFFFFF05542CDB577765FCDB043E2F933069F82FCCC5A7452F|state|UNKNOWNCODE N0304040384EC00FFFFFFFF05542CDB577765FCDB043E2F933069F82FCCC5A7452F|

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:31|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03030426E3C600FFFFFFFFA4B79A720C56551BCA34031E8F8A5E17028A9AD6C8BF|state|UNKNOWNCODE N03030426E3C600FFFFFFFFA4B79A720C56551BCA34031E8F8A5E17028A9AD6C8BF|

2018.06.01 08:19:56.443 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:31|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03030426E3C600000000C6260AAAA3F8F80890C64067FC1A63B00FEFF24DDC6AA3|state|UNKNOWNCODE N03030426E3C600000000C6260AAAA3F8F80890C64067FC1A63B00FEFF24DDC6AA3|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:31|mapleCUN1|CUL|UNKNOWNCODE N029984791138E32C86EC188402|state|UNKNOWNCODE N029984791138E32C86EC188402|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:31|Kuehlschrank|LACROSSE|temperature: 7.9|temperature|7.9|°C

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:31|Kuehlschrank|LACROSSE|ttstemp: 7,9|ttstemp|7,9|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:32|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03080426D9FC00FFFFFFFF8DBBDBE88EB5725F72A43A90F1A196E99E893C149DD7|state|UNKNOWNCODE N03080426D9FC00FFFFFFFF8DBBDBE88EB5725F72A43A90F1A196E99E893C149DD7|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:32|mapleCUN1|CUL|UNKNOWNCODE N029846653B8FE168A3AF4E2072|state|UNKNOWNCODE N029846653B8FE168A3AF4E2072|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:32|mapleCUN1|CUL|UNKNOWNCODE N029A06334520FA8153148A8D0C|state|UNKNOWNCODE N029A06334520FA8153148A8D0C|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:32|mapleCUN1|CUL|UNKNOWNCODE N029806583E7A901D08E23E23EE|state|UNKNOWNCODE N029806583E7A901D08E23E23EE|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:33|mapleCUN1|CUL|UNKNOWNCODE N0298C1903D7606940A34A431AC|state|UNKNOWNCODE N0298C1903D7606940A34A431AC|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:33|mapleCUN1|CUL|UNKNOWNCODE N0299065243BBA02E0A277CCAA7|state|UNKNOWNCODE N0299065243BBA02E0A277CCAA7|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:34|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03080426D9FC00FFFFFFFF8DBB2F0086AC26FBFC95B77302C39FA28B38B5BEAEB2|state|UNKNOWNCODE N03080426D9FC00FFFFFFFF8DBB2F0086AC26FBFC95B77302C39FA28B38B5BEAEB2|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:34|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03080426D9FC00000000808E91AAAA394DD996C3FD4A0C0CE64CBD73767BD44534|state|UNKNOWNCODE N03080426D9FC00000000808E91AAAA394DD996C3FD4A0C0CE64CBD73767BD44534|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:34|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03080406DDF300FFFFFFFFA138BE3AA68E2E71322B6C600000000010001EFAFCFF|state|UNKNOWNCODE N03080406DDF300FFFFFFFFA138BE3AA68E2E71322B6C600000000010001EFAFCFF|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:36|mapleCUN1|CUL|UNKNOWNCODE N029086396AA800854E24D84180|state|UNKNOWNCODE N029086396AA800854E24D84180|

2018.06.01 08:19:56.444 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:37|mapleCUN1|CUL|UNKNOWNCODE N029A06334520EF07864E80F53C|state|UNKNOWNCODE N029A06334520EF07864E80F53C|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:38|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03080406B91000FFFFFFFF4B96E0E2792E60321C325B9B3ADF7D1E9A85C3823DCE|state|UNKNOWNCODE N03080406B91000FFFFFFFF4B96E0E2792E60321C325B9B3ADF7D1E9A85C3823DCE|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:38|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03080426D9AE00FFFFFFFFFDEDB1AAB284100C0CE99799DFC3CAB36BFF8F6CD196|state|UNKNOWNCODE N03080426D9AE00FFFFFFFFFDEDB1AAB284100C0CE99799DFC3CAB36BFF8F6CD196|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:38|PCA301Statistics|STATISTICS|state: Updated stats for: PCA301_9|state|Updated stats for|PCA301_9

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:38|PCA301_9|PCA301|power: 23.9|power|23.9|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:38|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03080426D9AE0100EF0C31D855AAFCA0AE1FBE896E4A4A30FB03A1AE923E1CD35D|state|UNKNOWNCODE N03080426D9AE0100EF0C31D855AAFCA0AE1FBE896E4A4A30FB03A1AE923E1CD35D|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:41|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N030804078A9600FFFFFFFF7B2E936C18B7FF8526F9903176683BCFF869CDF9EA66|state|UNKNOWNCODE N030804078A9600FFFFFFFF7B2E936C18B7FF8526F9903176683BCFF869CDF9EA66|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:41|PCA301Statistics|STATISTICS|state: Updated stats for: PCA301_7|state|Updated stats for|PCA301_7

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:41|PCA301_7|PCA301|power: 243.5|power|243.5|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:41|mapleCUN1|CUL|UNKNOWNCODE N0299847911389880F51E00556F|state|UNKNOWNCODE N0299847911389880F51E00556F|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03050406977200FFFFFFFFF7FB043C0A785003805A6FAEBB1FDF0C8AF9562E6E8A|state|UNKNOWNCODE N03050406977200FFFFFFFFF7FB043C0A785003805A6FAEBB1FDF0C8AF9562E6E8A|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N030504069772000000000077D2AA4475966FDADFA93F21C93D3D8EADC79FA6C5FB|state|UNKNOWNCODE N030504069772000000000077D2AA4475966FDADFA93F21C93D3D8EADC79FA6C5FB|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|mapleCUN1|CUL|UNKNOWNCODE N029846653B8FDD35A73E31194A|state|UNKNOWNCODE N029846653B8FDD35A73E31194A|

2018.06.01 08:19:56.445 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|mapleCUN1|CUL|UNKNOWNCODE N029A0634458E61C68F3AC74C55|state|UNKNOWNCODE N029A0634458E61C68F3AC74C55|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|HMS100TF_4328_Balkon|HMS|temperature: 23.4|temperature|23.4|°C

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|Thermo_Balkon|LACROSSE|temperature: 23.4|temperature|23.4|°C

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|Thermo_Balkon|LACROSSE|ttstemp: 23,4|ttstemp|23,4|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|heating_Ku|DOIF|cmd_nr: 3|cmd_nr|3|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|heating_Ku|DOIF|cmd: 3|cmd|3|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|heating_Ku|DOIF|cmd_event: Thermo_Balkon|cmd_event|Thermo_Balkon|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|heating_Ku|DOIF|state: 5.0|state|5.0|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:42|mapleCUN1|CUL|UNKNOWNCODE N029806583E7AE540F80B03D48A|state|UNKNOWNCODE N029806583E7AE540F80B03D48A|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:43|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03070426D9C300FFFFFFFF054462D261573F05884CD971417E032315B31B487F7E|state|UNKNOWNCODE N03070426D9C300FFFFFFFF054462D261573F05884CD971417E032315B31B487F7E|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:43|PCA301Statistics|STATISTICS|state: Updated stats for: PCA301_15|state|Updated stats for|PCA301_15

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:43|PCA301_15|PCA301|power: 11.3|power|11.3|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:43|mapleCUN1|CUL|UNKNOWNCODE N0298C1903D60E0115645913D56|state|UNKNOWNCODE N0298C1903D60E0115645913D56|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:43|mapleCUN1|CUL|UNKNOWNCODE N0299065243BB50170701A80001|state|UNKNOWNCODE N0299065243BB50170701A80001|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:46|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03010426E40500FFFFFFFFEB2386DCFBCB72ED48EE73CFABA6F0DB3730F9F9459F|state|UNKNOWNCODE N03010426E40500FFFFFFFFEB2386DCFBCB72ED48EE73CFABA6F0DB3730F9F9459F|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:46|mapleCUN1|CUL|UNKNOWNCODE N029086396AA8016A0BB8331114|state|UNKNOWNCODE N029086396AA8016A0BB8331114|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:47|mapleCUN1|CUL|UNKNOWNCODE N029A06334520EF871C84942218|state|UNKNOWNCODE N029A06334520EF871C84942218|

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:47|HMS100TF_4328_Balkon|HMS|temperature: 23.3|temperature|23.3|°C

2018.06.01 08:19:56.446 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:47|Thermo_Balkon|LACROSSE|temperature: 23.3|temperature|23.3|°C

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:47|Thermo_Balkon|LACROSSE|ttstemp: 23,3|ttstemp|23,3|

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:48|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03010426DADE00FFFFFFFF1E171C6E841BE6B768AF7E6C539350329F9C198DD7F2|state|UNKNOWNCODE N03010426DADE00FFFFFFFF1E171C6E841BE6B768AF7E6C539350329F9C198DD7F2|

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:48|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03010426DADE00000000C71CAFAAAB84F7401F2CB38BCFA4F2D7A2EE38F8E9CFE3|state|UNKNOWNCODE N03010426DADE00000000C71CAFAAAB84F7401F2CB38BCFA4F2D7A2EE38F8E9CFE3|

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:51|mapleCUN1|CUL|UNKNOWNCODE N0299847911380193C1294E3DDD|state|UNKNOWNCODE N0299847911380193C1294E3DDD|

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:52|mapleCUN1|CUL|UNKNOWNCODE N029846653B8F82717FA270D081|state|UNKNOWNCODE N029846653B8F82717FA270D081|

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:52|mapleCUN4|STACKABLE_CC|UNKNOWNCODE N03050426D98C00FFFFFFFFED270004B9C994561D2AC91D62E47A158E2BACEE2736|state|UNKNOWNCODE N03050426D98C00FFFFFFFFED270004B9C994561D2AC91D62E47A158E2BACEE2736|

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:52|mapleCUN1|CUL|UNKNOWNCODE N029A0634458EE0C5E601E5C08B|state|UNKNOWNCODE N029A0634458EE0C5E601E5C08B|

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:52|HMS100TF_4328_Balkon|HMS|temperature: 23.4|temperature|23.4|°C

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:52|Thermo_Balkon|LACROSSE|temperature: 23.4|temperature|23.4|°C

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:52|Thermo_Balkon|LACROSSE|ttstemp: 23,4|ttstemp|23,4|

2018.06.01 08:19:56.447 5: DbLog fhemlogDB -> MemCache contains: 2018-06-01 08:19:52|mapleCUN1|CUL|UNKNOWNCODE N029806583E7A9185D9B0F9DFBE|state|UNKNOWNCODE N029806583E7A9185D9B0F9DFBE|

2018.06.01 08:19:56.475 4: BlockingCall (DbLog_PushAsync): created child (25510), uses tPortLocal to connect back

2018.06.01 08:19:56.476 5: DbLog fhemlogDB -> DbLog_PushAsync called with timeout: 86400

2018.06.01 08:19:56.485 5: HMUARTLGW WLAN_CUL_HM checking credits (from timer)

2018.06.01 08:19:56.487 5: HMUARTLGW WLAN_CUL_HM send: 00 08

2018.06.01 08:19:56.488 5: HMUARTLGW WLAN_CUL_HM send: (8): fd0003009408603a

2018.06.01 08:19:56.488 5: SW: fd0003009408603a

2018.06.01 08:19:56.492 5: [Freezemon] myFreezemon: ----------- Starting Freeze handling at 2018.06.01 08:19:56.491 ---------------------

[Freezemon] myFreezemon: possible freeze starting at 08:19:54, delay is 2.491 possibly caused by: tmr-PRESENCE_StartLocalScan(Raspi2) tmr-SIGNALduino_KeepAlive(sduino) tmr-SIGNALduino_KeepAlive(sduino3) tmr-SYSMON_Update(Raspi) tmr-DbLog_execmemcache(fhemlogDB) tmr-JeeLink_OnTimer(N/A) tmr-JeeLink_OnTimer(N/A) tmr-CUL_HM_procQs(N/A) tmr-HMUARTLGW_CheckCredits(N/A) 


jump to the top

Die fm_catch.* Atrribute hab ich mal beide aktiviert.
Gruß
Arthur

WhyTea · 07 Juni 2018, 10:00:24

Hallo
Ich habe immer wieder (2--3 mal am Tag) Freezes mit diesem Inhalt.

Code Auswählen


[Freezemon] Freezemon: possible freeze starting at 09:19:52, delay is 3.401 possibly caused by: tmr-HMUARTLGW_SendKeepAlive(LGW1) 

2018.06.07 09:19:51.102 5: HMUARTLGW LGW1:keepAlive send (3): K3c

2018.06.07 09:19:51.102 5: SW: K3c



2018.06.07 09:19:51.103 5: HMUARTLGW LGW1:keepAlive read raw (6): 3e4b33630d0a

2018.06.07 09:19:51.103 5: HMUARTLGW LGW1:keepAlive read (4): >K3c

--- log skips     4.299 secs.

2018.06.07 09:19:55.401 5: [Freezemon] Freezemon: ----------- Starting Freeze handling at 2018.06.07 09:19:55.401 ---------------------

[Freezemon] Freezemon: possible freeze starting at 09:19:52, delay is 3.401 possibly caused by: tmr-HMUARTLGW_SendKeepAlive(LGW1)

Hat jemand eine Idee was diese verursachen könnte? Und wie ich das abstellen kann.

Gruß
Daniel

Marlen · 09 Juni 2018, 08:05:34

Guten Morgen,

ich hab minütlich diese Meldung:

Code Auswählen

2018.06.09 08:01:22 1: [Freezemon] freeze: possible freeze starting at 08:01:19, delay is 3.012 possibly caused by: tmr-CUL_HM_procQs(N/A) tmr-FW_closeInactiveClients(N/A)

Habt ihr eine Idee?

LG
Marlen

Gesendet von meinem Aquaris U Plus mit Tapatalk