Hallo Zusammen,
ich habe das Phänomen, dass ich gelegentlich bei offener readingsGroup regelmäßige (ca. alle zwei Minuten) Freezes von zwei bis drei Sekunden Dauer habe. Der Übeltäter scheint readingsGroup_Notify zu sein:
Log-Auszug:
2017.06.12 05:07:02.147 1: Perfmon: possible freeze starting at 05:07:00, delay is 2.147
2017.06.12 05:11:41.417 1: Perfmon: possible freeze starting at 05:11:38, delay is 3.417
2017.06.12 05:13:52.429 1: Perfmon: possible freeze starting at 05:13:50, delay is 2.428
2017.06.12 05:16:53.692 1: Perfmon: possible freeze starting at 05:16:51, delay is 2.692
2017.06.12 05:18:40.217 1: Perfmon: possible freeze starting at 05:18:39, delay is 1.217
2017.06.12 05:19:40.435 1: Perfmon: possible freeze starting at 05:19:38, delay is 2.435
2017.06.12 05:21:16.679 1: Perfmon: possible freeze starting at 05:21:15, delay is 1.679
2017.06.12 05:22:12.938 1: Perfmon: possible freeze starting at 05:22:11, delay is 1.937
2017.06.12 05:24:31.217 1: Perfmon: possible freeze starting at 05:24:29, delay is 2.217
2017.06.12 05:26:34.438 1: Perfmon: possible freeze starting at 05:26:32, delay is 2.438
2017.06.12 05:29:27.680 1: Perfmon: possible freeze starting at 05:29:25, delay is 2.68
2017.06.12 05:31:27.229 1: Perfmon: possible freeze starting at 05:31:26, delay is 1.229
2017.06.12 05:32:06.441 1: Perfmon: possible freeze starting at 05:32:04, delay is 2.441
2017.06.12 05:34:30.694 1: Perfmon: possible freeze starting at 05:34:28, delay is 2.694
2017.06.12 05:36:40.483 1: Perfmon: possible freeze starting at 05:36:38, delay is 2.482
2017.06.12 05:39:39.969 1: Perfmon: possible freeze starting at 05:39:38, delay is 1.969
2017.06.12 05:42:24.960 1: Perfmon: possible freeze starting at 05:42:23, delay is 1.96
2017.06.12 05:44:55.462 1: Perfmon: possible freeze starting at 05:44:53, delay is 2.462
2017.06.12 05:47:11.688 1: Perfmon: possible freeze starting at 05:47:09, delay is 2.688
2017.06.12 05:49:13.426 1: Perfmon: possible freeze starting at 05:49:11, delay is 2.426
2017.06.12 05:52:04.712 1: Perfmon: possible freeze starting at 05:52:02, delay is 2.712
2017.06.12 05:54:41.718 1: Perfmon: possible freeze starting at 05:54:39, delay is 2.718
2017.06.12 05:57:04.196 1: Perfmon: possible freeze starting at 05:57:02, delay is 2.196
apptime max:
name function max count total average maxDly TS Max call param Max call
HMUART1 HMUARTLGW_Read 2738 2992 58587 19.58 0 12.06. 10:55:46 HASH(HMUART1)
heatingInfo_Bad readingsGroup_Notify 2679 6152 3303 0.54 0 12.06. 10:55:46 HASH(heatingInfo_Bad); HASH(Hzkp_Bad_ClimRT_tr)
myDbLog DbLog_Log 2630 6152 7540 1.23 0 12.06. 10:55:46 HASH(myDbLog); HASH(heatingInfo_Bad)
tmr-SMARTMON_Update HASH(0x586f5f0) 492 4 1873 468.25 5 12.06. 09:23:53 HASH(SM_sda)
Sonos SONOS_Read 450 9 1364 151.56 0 12.06. 09:36:17 HASH(Sonos)
tmr-at_Exec HASH(0x70fedc0) 437 4 1668 417.00 6 12.06. 10:57:45 HASH(at_Valves_avg)
tmr-at_Exec HASH(0x586e818) 400 1 400 400.00 4 12.06. 10:11:03 HASH(at_restore)
FHEM_Worf FHEM2FHEM_Read 351 13 2950 226.92 0 12.06. 09:45:47 HASH(FHEM_Worf)
tmr-SMARTMON_Update HASH(0x58cc150) 341 3 999 333.00 4 12.06. 09:47:54 HASH(SM_sdb)
tmr-SMARTMON_Update HASH(0x58cfe80) 341 3 922 307.33 4 12.06. 10:17:54 HASH(SM_sdd)
tmr-rssFeed_GetUpdate HASH(0x6491058) 337 3 887 295.67 4 12.06. 10:28:09 HASH(rss_Tagesschau100Sek)
tmr-SMARTMON_Update HASH(0x58d0858) 331 3 962 320.67 11 12.06. 09:47:54 HASH(SM_sdc)
HMUART2 HMUARTLGW_Read 287 1761 8061 4.58 0 12.06. 09:40:36 HASH(HMUART2)
HMLAN1 HMLAN_Read 278 1261 14620 11.59 0 12.06. 09:36:24 HASH(HMLAN1)
notify_Thrm_Wohnen_change notify_Exec 229 2 456 228.00 0 12.06. 09:40:36 HASH(notify_Thrm_Wohnen_change); HASH(Thrm_Wohnen_ClimRT_tr)
HMUSB1 HMLAN_Read 210 1232 9285 7.54 0 12.06. 09:40:40 HASH(HMUSB1)
tmr-at_Exec HASH(0x2e4b740) 194 65 5798 89.20 115 12.06. 09:58:30 HASH(Uhrzeit_at)
tmr-at_Exec HASH(0x44d4e78) 185 5 894 178.80 6 12.06. 09:55:05 HASH(checkGDS)
tmr-at_Exec HASH(0x44d4ac0) 168 5 798 159.60 8 12.06. 09:30:05 HASH(readGDS)
RFXTRXUSB TRX_Read 158 2108 18297 8.68 0 12.06. 10:28:10 HASH(RFXTRXUSB)
tmr-FRITZBOX_Readout_Start FritzBox_Wlan.Readout 156 587 13696 23.33 2219 12.06. 09:28:50 FritzBox_Wlan.Readout
(Sind zwar Auszüge zu unterschiedlichen Zeitstempeln, aber inhaltlich ändert das nichts)
Schon ein disable=1 der entsprechenden readingsGroup "behebt" das Problem.
Manchmal tritt das Problem auch auf, wenn kein Frontend geöffnet ist. Dann allerdings bei der readingsGroup, die als letztes offen war. Vermutlich ist da dann noch etwas im "Hintergrund" aktiv.
Hat jemand eine Ahnung woher das kommen kann? Oder kommt das aus DbLog?
Hier gab es wohl schon mal etwas Ähnliches: https://forum.fhem.de/index.php/topic,40635.msg331262.html#msg331262 (https://forum.fhem.de/index.php/topic,40635.msg331262.html#msg331262)
Danke und Gruß
Christoph