Hallo zusammen,
Seit einigen Tagen habe ich das Problem, dass der IPS Dienst 100% CPU Last hat.
Es hilft nur, den Dienst zu beenden ggf noch zu killen und neu zu starten.
Irgendwelche Ideen?
Irgendwelche Skripte, die nicht richtig laufen. Oder alte Treiber … hatte wir in Verbindung mit irgendeinem Versionssprung schon mal besprochen.
in der PHP thread Anzeige sehe ich keine Langläufer
Das Einzige, was mir noch dazu einfällt:
Ich habe meinen ZWave Stick über einen Lantronix LAN Adapter dran und über einen virtuellen COM Port eingebunden.
Dieser hat im gleichen Zusammenhang auch Timeouuts. Hatte dem COM Port geschlossen und wieder aufgemacht, allerdings hilft das nicht. Muss den Dienst komplett neu starten.
Läuft die Meldungsliste nach wenn die Last bei 100% ist? Soll heissen - sind die Zeiten der angezeigten Ereignisse aktuell?
Hallo,
also heute morgen hatte ich wieder mal 100% und gleich nachgeschaut, was IPS macht:
-> Meldungslog läuft nach
-> PHP Threads keine langläufer bzw. alles leer.
Interessant ist folgendes:
Wenn ich den Dienst beende, dann geht die CPU Last runter, allerdings lässt sich der Dienst nicht komplett beenden sondern muß zum Schluß gekillt werden. (Das ist auch in dem BugThread für die 2.7 vermerkt, Dienst lässt sich nicht beenden!)
Folgendes ist mir noch aufgefallen wenn ich das Ereignis-Log prüfe:
Der Network Link ging ungefähr vor dem Anstieg der CPU Last kurzzeitig down 15 Sekunden oder so.
Dann ungefähr schaukelt sich die CPU Last langsam auf 100%.
Wenn die Meldungsliste nachläuft müllt irgend etwas Deine Message Queue voll. Er kommt dann mit dem abarbeiten nicht mehr nach und läuft der Zeit immer weiter hinterher. Aktiviere Im IPS-Tray bei den Spezialschaltern mal alle Debug-Optionen und schau Dir dann mal Meldungsfenster bzw. Logfile an. Vielleicht siehst Du dann schon den Schuldigen.
hi kronos, habe ich mal aktiviert.
kann man sich die queue irgendwo anschauen bzw. abfragen?
So, hatte die Netzwerktreiber Aktualisiert und an dem COMPort Redirector ein AutoConnect eingestellt.
Heute morgen ab Ca. 5:00 Uhr geht’s wieder nach oben - Netzwerk war wohl wieder kurzzeitig weg. Lt EventLog um 05:25
CPU-Last
Hier mal die Logs (Variablenänderungen deaktiviert)
Detail-Log:
26.03.2013 05:14:06.318 | 26875 | WARNING | TimerID #4, TimerThread #4 | [Objekte\1-Wire\Helligkeitssensor] = 1-Wire Operation failed: CRC Error
26.03.2013 05:14:18.685 | 57391 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 57391.ips.php ~ Absender: Ereignis #23441, Variable #50103, Auslöser: OnChange
26.03.2013 05:14:18.712 | 57391 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 27 ms
26.03.2013 05:14:19.316 | 0 | DEBUG | KernelMT | Message VM_UPDATE for ID 41674 took 54 ms (InstanceForward)
26.03.2013 05:14:19.316 | 0 | DEBUG | KernelMT | Message VM_UPDATE for ID 41674 took 55 ms
26.03.2013 05:14:20.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:14:20.031 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 31 ms
26.03.2013 05:14:40.499 | 48575 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:14:40.532 | 48575 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 32 ms
26.03.2013 05:15:00.499 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:15:00.531 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 32 ms
26.03.2013 05:15:01.000 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:15:01.032 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 32 ms
26.03.2013 05:15:07.000 | 11958 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:15:07.077 | 11958 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 77 ms
26.03.2013 05:15:20.001 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:15:20.036 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 34 ms
26.03.2013 05:15:40.499 | 48575 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:15:40.530 | 48575 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 31 ms
26.03.2013 05:16:00.001 | 36597 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:16:00.033 | 36597 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 32 ms
26.03.2013 05:16:00.529 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:16:00.563 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 34 ms
26.03.2013 05:16:17.000 | 48961 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48961.ips.php ~ Absender: Ereignis #35577, Zeit Ereignis
26.03.2013 05:16:19.473 | 48961 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 2473 ms
26.03.2013 05:16:20.000 | 48575 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:16:20.035 | 48575 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 35 ms
26.03.2013 05:16:40.000 | 48575 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:16:40.079 | 48575 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 78 ms
26.03.2013 05:17:00.499 | 48575 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:17:00.543 | 48575 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 44 ms
26.03.2013 05:17:01.011 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:17:01.042 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 31 ms
26.03.2013 05:17:07.000 | 11958 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:17:07.050 | 11958 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 50 ms
26.03.2013 05:17:20.009 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:17:20.041 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 32 ms
26.03.2013 05:17:40.000 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:17:40.076 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 76 ms
26.03.2013 05:18:00.000 | 36597 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:18:00.032 | 36597 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 31 ms
26.03.2013 05:18:00.535 | 48575 | DEBUG | ExecuteThreadID #1 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:18:00.569 | 48575 | DEBUG | ExecuteThreadID #1 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 34 ms
26.03.2013 05:18:20.000 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:18:20.030 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 30 ms
26.03.2013 05:18:40.000 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:18:40.074 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 74 ms
26.03.2013 05:19:00.001 | 36597 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:19:00.032 | 36597 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 31 ms
26.03.2013 05:19:00.535 | 48575 | DEBUG | ExecuteThreadID #7 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:19:00.570 | 48575 | DEBUG | ExecuteThreadID #7 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 35 ms
26.03.2013 05:19:07.001 | 11958 | DEBUG | ExecuteThreadID #7 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:19:07.081 | 11958 | DEBUG | ExecuteThreadID #7 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 80 ms
26.03.2013 05:19:09.460 | 57391 | DEBUG | ExecuteThreadID #7 | Skriptausführung: 57391.ips.php ~ Absender: Ereignis #23441, Variable #50103, Auslöser: OnChange
26.03.2013 05:19:09.487 | 57391 | DEBUG | ExecuteThreadID #7 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 27 ms
26.03.2013 05:19:20.028 | 48575 | DEBUG | ExecuteThreadID #7 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:19:20.070 | 48575 | DEBUG | ExecuteThreadID #7 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 41 ms
26.03.2013 05:19:40.000 | 48575 | DEBUG | ExecuteThreadID #7 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:19:40.070 | 48575 | DEBUG | ExecuteThreadID #7 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 69 ms
26.03.2013 05:20:00.499 | 22462 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 22462.ips.php ~ Absender: Ereignis #51782, Zeit Ereignis
26.03.2013 05:20:00.733 | 22462 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 234 ms
26.03.2013 05:20:01.009 | 13805 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 13805.ips.php ~ Absender: Ereignis #23051, Zeit Ereignis
26.03.2013 05:20:01.510 | 37029 | DEBUG | ExecuteThreadID #2 | Skriptausführung: 37029.ips.php ~ Absender: Ereignis #21004, Zeit Ereignis
26.03.2013 05:20:01.662 | 37029 | DEBUG | ExecuteThreadID #2 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 152 ms
26.03.2013 05:20:02.050 | 11138 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 11138.ips.php ~ Absender: Ereignis #19670, Zeit Ereignis
26.03.2013 05:20:02.107 | 11138 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 57 ms
26.03.2013 05:20:02.551 | 36597 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:20:02.582 | 36597 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 31 ms
26.03.2013 05:20:03.066 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:20:03.098 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 32 ms
26.03.2013 05:20:03.614 | 22652 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 22652.ips.php ~ Absender: Ereignis #11310, Zeit Ereignis
26.03.2013 05:20:14.274 | 13805 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 13265 ms
26.03.2013 05:20:20.017 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:20:20.048 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 31 ms
26.03.2013 05:20:24.643 | 22652 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 21029 ms
26.03.2013 05:20:40.000 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:20:40.066 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 66 ms
26.03.2013 05:20:46.455 | 26875 | WARNING | TimerID #4, TimerThread #2 | [Objekte\1-Wire\Helligkeitssensor] = 1-Wire Operation failed: CRC Error
26.03.2013 05:21:00.499 | 48575 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:21:00.543 | 48575 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 44 ms
26.03.2013 05:21:01.001 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:21:01.033 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 32 ms
26.03.2013 05:21:05.198 | 57391 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 57391.ips.php ~ Absender: Ereignis #42210, Variable #47121, Auslöser: OnChange
26.03.2013 05:21:05.226 | 57391 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 28 ms
26.03.2013 05:21:07.428 | 11958 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:21:07.472 | 11958 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 44 ms
26.03.2013 05:25:12.502 | 0 | WARNING | Kernel | Hauptthread war länger als 5 Sekunden blockiert. Dauer: 243121ms
26.03.2013 05:25:14.887 | 48961 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48961.ips.php ~ Absender: Ereignis #35577, Zeit Ereignis
26.03.2013 05:25:14.891 | 48575 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:25:16.741 | 36597 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:25:16.840 | 36597 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 99 ms
26.03.2013 05:25:17.280 | 48575 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 2389 ms
26.03.2013 05:25:17.290 | 11958 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:25:17.328 | 11958 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 38 ms
26.03.2013 05:25:17.931 | 0 | DEBUG | KernelMT | Message VM_UPDATE for ID 45561 took 83 ms (InstanceForward)
26.03.2013 05:25:17.931 | 0 | DEBUG | KernelMT | Message VM_UPDATE for ID 45561 took 83 ms
26.03.2013 05:25:17.932 | 57391 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 57391.ips.php ~ Absender: Ereignis #23441, Variable #50103, Auslöser: OnChange
26.03.2013 05:25:17.947 | 57391 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 15 ms
26.03.2013 05:25:18.216 | 0 | DEBUG | KernelMT | Message VM_UPDATE for ID 50103 took 283 ms (InstanceForward)
26.03.2013 05:25:18.216 | 0 | DEBUG | KernelMT | Message VM_UPDATE for ID 50103 took 284 ms
26.03.2013 05:25:19.228 | 48961 | ERROR | ExecuteThreadID #5 | [Scripts\Computer Scripts\Anruferliste\Auslese-Skript] =
Warning: file_get_contents(): in C:\IP-Symcon\scripts\48961.ips.php on line 35
Warning: file_get_contents(http://fritz.box/cgi-bin/webcm?getpage=../html/login_sid.xml): in C:\IP-Symcon\scripts\48961.ips.php on line 35
Fehler beim einlesen der XML Daten. Wahrscheinlich ist eine zu alte Firmware installiert
26.03.2013 05:25:19.228 | 48961 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 0, Erfolgreich: False, Zeit: 4341 ms
26.03.2013 05:25:20.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:25:20.037 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 37 ms
26.03.2013 05:25:22.117 | 47129 | NOTIFY | Serial Port | 2449ms, Instance: 16776
26.03.2013 05:25:27.247 | 34117 | WARNING | TimerID #70, TimerThread #2 | [Objekte\Heizung\Thermostat Büro] = (RF) Zeitüberschreitung beim Warten auf Antwort
26.03.2013 05:25:32.954 | 34117 | WARNING | TimerID #70, TimerThread #2 | [Objekte\Heizung\Thermostat Büro] = (RF) Zeitüberschreitung beim Warten auf Antwort
26.03.2013 05:25:40.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:25:40.051 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 51 ms
26.03.2013 05:25:40.620 | 47129 | NOTIFY | Serial Port | 312ms, Instance: 16776
26.03.2013 05:26:00.001 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:26:00.019 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 18 ms
26.03.2013 05:26:00.501 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:26:00.518 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 17 ms
26.03.2013 05:26:17.002 | 48961 | DEBUG | ExecuteThreadID #2 | Skriptausführung: 48961.ips.php ~ Absender: Ereignis #35577, Zeit Ereignis
26.03.2013 05:26:19.668 | 48961 | DEBUG | ExecuteThreadID #2 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 2666 ms
26.03.2013 05:26:20.118 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:26:20.240 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 122 ms
26.03.2013 05:26:25.997 | 57391 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 57391.ips.php ~ Absender: Ereignis #42210, Variable #47121, Auslöser: OnChange
26.03.2013 05:26:26.032 | 57391 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 34 ms
26.03.2013 05:26:40.002 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:26:40.067 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 65 ms
26.03.2013 05:27:00.000 | 36597 | DEBUG | ExecuteThreadID #2 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:27:00.031 | 36597 | DEBUG | ExecuteThreadID #2 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 31 ms
26.03.2013 05:27:00.500 | 48575 | DEBUG | ExecuteThreadID #1 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:27:00.522 | 48575 | DEBUG | ExecuteThreadID #1 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 22 ms
26.03.2013 05:27:17.002 | 11958 | DEBUG | ExecuteThreadID #2 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:27:17.040 | 11958 | DEBUG | ExecuteThreadID #2 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 38 ms
26.03.2013 05:27:20.000 | 48575 | DEBUG | ExecuteThreadID #2 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:27:20.071 | 48575 | DEBUG | ExecuteThreadID #2 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 71 ms
26.03.2013 05:27:40.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:27:40.070 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 70 ms
26.03.2013 05:28:00.001 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:28:00.041 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 40 ms
26.03.2013 05:28:00.502 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:28:00.520 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 18 ms
26.03.2013 05:28:20.001 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:28:20.083 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 83 ms
26.03.2013 05:28:40.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:28:40.069 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 69 ms
26.03.2013 05:29:00.002 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:29:00.019 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 17 ms
26.03.2013 05:29:00.503 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:29:00.519 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 17 ms
26.03.2013 05:29:17.000 | 11958 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:29:17.097 | 11958 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 97 ms
26.03.2013 05:29:20.001 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:29:20.029 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 28 ms
26.03.2013 05:29:40.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:29:40.057 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 57 ms
26.03.2013 05:30:00.001 | 51205 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 51205.ips.php ~ Absender: Ereignis #52006, Zeit Ereignis
26.03.2013 05:30:00.311 | 33841 | DEBUG | MediaManager | File changed: media\Unwetterkarte.gif
26.03.2013 05:30:00.311 | 33841 | DEBUG | MediaManager | File changed: media\Unwetterkarte.gif
26.03.2013 05:30:00.482 | 51205 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 481 ms
26.03.2013 05:30:00.500 | 0 | DEBUG | KernelMT | Message Queue: 4 items, Delay 203 ms, Last Message: MM_UPDATE
26.03.2013 05:30:00.578 | 18842 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 18842.ips.php ~ Absender: Ereignis #30051, Zeit Ereignis
26.03.2013 05:30:01.078 | 22462 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 22462.ips.php ~ Absender: Ereignis #51782, Zeit Ereignis
26.03.2013 05:30:01.378 | 22462 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 300 ms
26.03.2013 05:30:01.629 | 13805 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 13805.ips.php ~ Absender: Ereignis #23051, Zeit Ereignis
26.03.2013 05:30:02.172 | 37029 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 37029.ips.php ~ Absender: Ereignis #21004, Zeit Ereignis
26.03.2013 05:30:02.263 | 37029 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 91 ms
26.03.2013 05:30:02.538 | 18842 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 1960 ms
26.03.2013 05:30:02.702 | 11138 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 11138.ips.php ~ Absender: Ereignis #19670, Zeit Ereignis
26.03.2013 05:30:02.888 | 11138 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 187 ms
26.03.2013 05:30:03.202 | 22652 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 22652.ips.php ~ Absender: Ereignis #11310, Zeit Ereignis
26.03.2013 05:30:03.715 | 36597 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:30:03.735 | 36597 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 20 ms
26.03.2013 05:30:04.244 | 48575 | DEBUG | ExecuteThreadID #7 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:30:04.332 | 48575 | DEBUG | ExecuteThreadID #7 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 88 ms
26.03.2013 05:30:09.729 | 57391 | DEBUG | ExecuteThreadID #7 | Skriptausführung: 57391.ips.php ~ Absender: Ereignis #23441, Variable #50103, Auslöser: OnChange
26.03.2013 05:30:09.744 | 57391 | DEBUG | ExecuteThreadID #7 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 15 ms
26.03.2013 05:30:09.802 | 0 | DEBUG | KernelMT | Message VM_UPDATE for ID 50103 took 76 ms (InstanceForward)
26.03.2013 05:30:09.802 | 0 | DEBUG | KernelMT | Message VM_UPDATE for ID 50103 took 76 ms
26.03.2013 05:30:15.672 | 13805 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 14043 ms
26.03.2013 05:30:20.002 | 48575 | DEBUG | ExecuteThreadID #9 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:30:20.248 | 48575 | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 246 ms
26.03.2013 05:30:24.221 | 22652 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 21019 ms
26.03.2013 05:30:40.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:30:40.077 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 77 ms
26.03.2013 05:31:00.026 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:31:00.046 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 20 ms
26.03.2013 05:31:00.546 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:31:00.565 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 19 ms
26.03.2013 05:31:17.002 | 48961 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48961.ips.php ~ Absender: Ereignis #35577, Zeit Ereignis
26.03.2013 05:31:17.503 | 11958 | DEBUG | ExecuteThreadID #8 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:31:17.592 | 11958 | DEBUG | ExecuteThreadID #8 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 89 ms
26.03.2013 05:31:19.340 | 48961 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 2338 ms
26.03.2013 05:31:20.002 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:31:20.105 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 103 ms
26.03.2013 05:31:40.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:31:40.073 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 72 ms
26.03.2013 05:31:47.477 | 57391 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 57391.ips.php ~ Absender: Ereignis #42210, Variable #47121, Auslöser: OnChange
26.03.2013 05:31:47.503 | 57391 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 27 ms
26.03.2013 05:32:00.001 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:32:00.021 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 20 ms
26.03.2013 05:32:00.501 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:32:00.518 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 17 ms
26.03.2013 05:32:20.000 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:32:20.242 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 242 ms
26.03.2013 05:32:40.001 | 48575 | DEBUG | ExecuteThreadID #2 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:32:40.250 | 48575 | DEBUG | ExecuteThreadID #2 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 249 ms
26.03.2013 05:33:00.000 | 36597 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 36597.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
26.03.2013 05:33:00.017 | 36597 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 17 ms
26.03.2013 05:33:00.500 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
26.03.2013 05:33:00.517 | 48575 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 17 ms
26.03.2013 05:33:17.001 | 11958 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
26.03.2013 05:33:17.058 | 11958 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 57 ms
26.03.2013 05:33:20.001 | 48575 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48575.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
Interessant finde ich:
26.03.2013 05:25:12.502 | 0 | WARNING | Kernel | Hauptthread war länger als 5 Sekunden blockiert. Dauer: 243121ms
Habe mal meine Logs druchforstet und diese Meldung kommt bisher immer wenn CPU Last danach anstieg!
So kurzes Update:
Nachdem ich ein paar Tipps von Kronos bekommen hatte:
[ul]
[li]Global Internet /Netzwerk online variable[/li][li]SetValue nur bei Änderung (vorher mit GetValue überprüfen)[/li][li]nur wirklich notwendige Scripts nachts laufen lassen[/li][/ul]
Hatte es leider immer noch einen Hänger gegeben.
Ich habe ein paar Tests gemacht und konnte folgendes Feststellen: Hatte meine Fritz box rebootet -> direkt nachdem das Netzwerkkabel weg war, stieg die CPU last deutlich an und wurde nicht wieder weniger.
Leider konnte ich den Fall nicht direkt wieder nachstellen - vermutlich gibt es aber irgendeine interne Aktion im Kernel, die sich aufhängt, wenn kein Netz mehr da ist…
Hier mal ein Log Auszug
habe mal die IDs ersetzt:
NETWC = Network Monitoring Script alle 20 sek.
DRUCK = 20 Sekündlich: Spooler MOnitoring
ZWMON = Script zum Monitoring der letzten Updates am ZWAVE Stick - liest nur ein paar werte der variablen.
48070 = Script zum Emailversand, wenn best. Ereignisse auftreten
----------- VORHER WAR DAS NETZWERK OBEN ----------------------------------
27.03.2013 20:24:01.000 | NETWC | DEBUG | ExecuteThreadID #4 | Skriptausführung: NETWC.ips.php ~ Absender: Ereignis #18838, Zeit Ereignis
-----------------------------------------------DOWN ---------------------------------------------------------------------------------------
27.03.2013 20:24:01.500 | ZWMON | DEBUG | ExecuteThreadID #2 | Skriptausführung: ZWMON.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
27.03.2013 20:24:01.518 | ZWMON | DEBUG | ExecuteThreadID #2 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 18 ms
27.03.2013 20:24:04.091 | 16776 | WARNING | TimerID #8, TimerThread #1 | [Z-Wave Gateway (TRICKLESTAR)] = Zeitüberschreitung beim Warten auf Antwort
27.03.2013 20:24:20.064 | DRUCK | DEBUG | ExecuteThreadID #5 | Skriptausführung: DRUCK.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
27.03.2013 20:24:20.377 | DRUCK | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 313 ms
-----------------------------------------------DOWN HOHE CPU LAST! -----------------------------------------------------------
27.03.2013 20:24:20.579 | NETWC | DEBUG | ExecuteThreadID #5 | Skriptausführung: NETWC.ips.php ~ Absender: Ereignis #18838, Zeit Ereignis
27.03.2013 20:24:35.290 | 48070 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48070.ips.php ~ Absender: Ereignis #45866, Variable #36301, Auslöser: OnChange
27.03.2013 20:24:35.411 | 48070 | MESSAGE | ExecuteThreadID #3 | [Scripts\Alarm und Benachrichtigungen\PRIO 2 - Email Versand] =
Warning: Socket Error # 11004
in [Scripts\Alarm und Benachrichtigungen\PRIO 2 - Email Versand] on line 35
27.03.2013 20:24:35.411 | 48070 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 120 ms
27.03.2013 20:24:40.096 | DRUCK | DEBUG | ExecuteThreadID #3 | Skriptausführung: DRUCK.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
27.03.2013 20:24:40.301 | DRUCK | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 205 ms
27.03.2013 20:24:40.447 | 48070 | DEBUG | ExecuteThreadID #6 | Skriptausführung: 48070.ips.php ~ Absender: Ereignis #47088, Variable #48936, Auslöser: OnChange
27.03.2013 20:24:40.463 | 48070 | DEBUG | ExecuteThreadID #6 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 15 ms
27.03.2013 20:24:40.611 | NETWC | DEBUG | ExecuteThreadID #9 | Skriptausführung: NETWC.ips.php ~ Absender: Ereignis #18838, Zeit Ereignis
27.03.2013 20:24:42.015 | NETWC | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 21437 ms
27.03.2013 20:24:42.721 | 0 | DEBUG | KernelMT | Message Queue: 2 items, Delay 2106 ms, Last Message: EM_UPDATE
27.03.2013 20:24:43.051 | 48070 | DEBUG | ExecuteThreadID #5 | Skriptausführung: 48070.ips.php ~ Absender: Ereignis #37522, Variable #39223, Auslöser: OnChange
27.03.2013 20:24:43.066 | 48070 | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 15 ms
27.03.2013 20:24:48.207 | NETWC | DEBUG | ExecuteThreadID #4 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 47208 ms
27.03.2013 20:25:00.045 | ZWMON | DEBUG | ExecuteThreadID #7 | Skriptausführung: ZWMON.ips.php ~ Absender: Ereignis #30075, Zeit Ereignis
27.03.2013 20:25:00.064 | ZWMON | DEBUG | ExecuteThreadID #7 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 18 ms
27.03.2013 20:25:00.634 | DRUCK | DEBUG | ExecuteThreadID #5 | Skriptausführung: DRUCK.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
27.03.2013 20:25:00.838 | DRUCK | DEBUG | ExecuteThreadID #5 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 205 ms
27.03.2013 20:25:01.170 | NETWC | DEBUG | ExecuteThreadID #5 | Skriptausführung: NETWC.ips.php ~ Absender: Ereignis #18838, Zeit Ereignis
27.03.2013 20:25:03.116 | 11958 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 11958.ips.php ~ Absender: Ereignis #48318, Zeit Ereignis
27.03.2013 20:25:03.510 | NETWC | DEBUG | ExecuteThreadID #9 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 22900 ms
27.03.2013 20:25:03.542 | 11958 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 427 ms
27.03.2013 20:25:07.036 | 48961 | DEBUG | ExecuteThreadID #3 | Skriptausführung: 48961.ips.php ~ Absender: Ereignis #35577, Zeit Ereignis
27.03.2013 20:25:07.052 | 48961 | DEBUG | ExecuteThreadID #3 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 17 ms
27.03.2013 20:25:09.347 | 16776 | WARNING | TimerID #8, TimerThread #8 | [Z-Wave Gateway (TRICKLESTAR)] = Zeitüberschreitung beim Warten auf Antwort
27.03.2013 20:25:11.968 | 0 | DEBUG | ExecuteThreadID #1 | Skriptausführung: ajax.php ~ Absender: WebInterface
27.03.2013 20:25:11.984 | 0 | DEBUG | ExecuteThreadID #1 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 16 ms
27.03.2013 20:25:12.054 | 0 | DEBUG | ExecuteThreadID #1 | Skriptausführung: ajax.php ~ Absender: WebInterface
27.03.2013 20:25:12.069 | 0 | DEBUG | ExecuteThreadID #1 | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 15 ms
27.03.2013 20:25:20.145 | DRUCK | DEBUG | ExecuteThreadID #7 | Skriptausführung: DRUCK.ips.php ~ Absender: Ereignis #36421, Zeit Ereignis
27.03.2013 20:25:20.236 | 0 | DEBUG | KernelMT | Message Queue: 2 items, Delay 468 ms, Last Message: VM_UPDATE
Auch mal nach ISDN. Das ist ein bekanntes Problem, dass die CAPI Verbindungsabbrüche genau so quittiert. Das passiert nur mit der CAPI über LAN. Mit einer normalen FritzUSB oder Karte passiert dies nicht.
Wir können dieses Problem auch nicht fixen. Wenn du ISDN nicht dringend brauchst, würde ich auf die FB Anrufliste wechseln.
paresy
Hallo paresy,
gerade hatte ich wieder solch einen Fall:
Hier mal eine Info aus dem ProcessExplorer:
dh. es hat sich intern ein Thread aufgehangen, bei irgendwelchen CAPI Dingen. Korrekt CAPI over LAN.
Ich bin ins ISDN Modul rein und habe den CAPI Port mal geändert auf 0 (vorher 5) übernehmen gedrückt und schon sank die CPU Last Rapide wieder auf Normalzustand.
Da ich das CAPI Modul verwende um Text2Speech zu nutzen ist die Anruferliste keine Option.
Da aber sobald ich den Port gewechselt habe IPS wohl normal weiter läuft und die CPU last sinkt, Könntest du bitte nicht mal in Eurem Coding prüfen, ob der da in einer Endlossschleife oder sonst wo hängt?
Hallo zusammen,
habe vermutlich das Problem gefunden:
Irgendwie wurde die Ruhezustand Einstellung gesetzt, so dass sich der Server ab und zu in den Ruhezustand versetzt hat.
Minütliche geplante Tasks hatten ihn dazu wieder aufgeweckt - weshalb mir das nicht aufgefallen war.
Häufig nach der Rückkehr aus dem Ruhezustand stieg die CPU Last in Verbindung mit dem ISDN Modul.
Habe den RZ jetzt komplette deaktiviert und alles läuft seither wieder problemlos - danke allen!