Out of Memory

axbigo · 19. November 2013 um 16:58

Hallo zusammen,

ich aheb sei einer Woche das folgede Problem: der Dienst verabscheidet sich regelmaessig, wenn ich mich ueber Wbfront verbinden will bekomme ich die Meldung ‚Out of Memory‘ und die Konsole will auch nicht mehr. Ein Neustart des IPS Dienstes hilft fuer einige Zeit.

Im Log steht Folgendes:




11/19/2013 16:40:15.370 | 47660 | WARNING | TimerID #16, TimerThread #21 | 
[Webfront\VideoPTZ\Image\Image Grabber (WebCams)] = Thread creation error: Not enough storage is available to process this command
11/19/2013 16:45:15.394 | 47660 | WARNING | TimerID #16, TimerThread #32 | 
[Webfront\VideoPTZ\Image\Image Grabber (WebCams)] = Thread creation error: Not enough storage is available to process this command

Zu dem Zeitpunkt hatte der Zerver etwa 4GB RAM und 22 GB HDD frei, daran kann’s also nicht liegen.

Den betroffenen Imagegrabber gibt es in unveraenderter Form seit 2 - 3 Jahren.

Ich habe die IPS #3007 unlimited.

Irgendeine Idee, woran das liegen kann?

Danke

Adrian

ipsnewbie · 20. November 2013 um 23:01

Hallo,
ich hab das gleiche Problem.
Nach Aktualisierung der CCU1 und IPS update auf 3.0 hängt es sich nach einigen Stunden auch auf ,die CPU Auslastung von meinem XP-MiniPC steht bei 100 Prozent.Dazu jede Menge Fehlermeldungen in der log-Datei.

Weiß hier niemand einen Ansatz?

Gruß Frank

axbigo · 23. November 2013 um 09:45

Hallo zusammen,

obwohl ich den Image Grabber geloescht habe, ist das Problem immer noch da. Hier die relevanten Log-Entraege:


11/23/2013 01:36:32.866 |     0 | ERROR   | InstanceManager      | Error Processing Message: VM_UPDATE, Instance #26915, Message: Out of memory
11/23/2013 01:36:32.882 |     0 | ERROR   | InstanceManager      | Error Processing Message: VM_UPDATE, Instance #26915, Message: Out of memory
11/23/2013 01:36:32.897 |     0 | ERROR   | InstanceManager      | Error Processing Message: VM_UPDATE, Instance #26915, Message: Out of memory
11/23/2013 01:36:37.250 |     0 | ERROR   | Settings             | Error updating on message VM_UPDATE for Sender 53176. Error: Out of memory
11/23/2013 01:36:43.646 |     0 | WARNING | TimerID #20, TimerThread #29 | [None] = Out of memory
11/23/2013 01:36:44.114 |     0 | WARNING | ReadThread           | Out of memory
11/23/2013 01:36:44.114 | 16169 | MESSAGE | HomeMatic Socket     | Socket (Data Radio) - Disconnected
11/23/2013 01:36:44.676 |     0 | WARNING | TimerID #20, TimerThread #7 | [None] = Out of memory
11/23/2013 01:36:45.705 |     0 | WARNING | TimerID #20, TimerThread #20 | [None] = Out of memory
11/23/2013 01:36:46.735 |     0 | WARNING | TimerID #20, TimerThread #45 | [None] = Out of memory
11/23/2013 01:36:47.764 |     0 | WARNING | TimerID #20, TimerThread #43 | [None] = Out of memory
11/23/2013 01:36:48.794 |     0 | WARNING | TimerID #20, TimerThread #36 | [None] = Out of memory
11/23/2013 01:36:49.106 | 13072 | WARNING | ExecuteThreadID #7   | Error executing Script (13072.ips.php): Out of memory
11/23/2013 01:36:49.824 |     0 | WARNING | TimerID #20, TimerThread #26 | [None] = Out of memory
11/23/2013 01:36:50.854 |     0 | WARNING | TimerID #20, TimerThread #7 | [None] = Out of memory
11/23/2013 01:36:51.884 |     0 | WARNING | TimerID #20, TimerThread #49 | [None] = Out of memory
11/23/2013 01:36:52.913 |     0 | WARNING | TimerID #20, TimerThread #50 | [None] = Out of memory
11/23/2013 01:36:53.942 |     0 | WARNING | TimerID #20, TimerThread #40 | [None] = Out of memory
11/23/2013 01:36:54.972 |     0 | WARNING | TimerID #20, TimerThread #7 | [None] = Out of memory
11/23/2013 01:36:56.002 |     0 | WARNING | TimerID #20, TimerThread #27 | [None] = Out of memory
11/23/2013 01:36:57.031 |     0 | WARNING | TimerID #20, TimerThread #45 | [None] = Out of memory
11/23/2013 01:36:58.061 |     0 | WARNING | TimerID #20, TimerThread #5 | [None] = Out of memory
11/23/2013 01:36:59.091 |     0 | WARNING | TimerID #20, TimerThread #27 | [None] = Out of memory
11/23/2013 01:37:00.120 |     0 | WARNING | TimerID #20, TimerThread #16 | [None] = Out of memory
11/23/2013 01:37:01.197 |     0 | WARNING | TimerID #20, TimerThread #11 | [None] = Out of memory
11/23/2013 01:37:01.743 |     0 | ERROR   | InstanceManager      | Error Processing Message: VM_UPDATE, Instance #26915, Message: Out of memory
11/23/2013 01:37:07.031 |     0 | ERROR   | KernelMT             | Error in message loop: Out of memory
11/23/2013 01:37:07.047 |     0 | ERROR   | KernelMT             | Error in message loop: Out of memory
11/23/2013 01:37:07.062 |     0 | ERROR   | KernelMT             | Error in message loop: Out of memory
11/23/2013 01:37:07.078 |     0 | ERROR   | KernelMT             | Error in message loop: Out of memory
11/23/2013 01:37:07.094 |     0 | ERROR   | KernelMT             | Error in message loop: Out of memory
11/23/2013 01:37:25.299 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 01:37:30.244 | 16169 | WARNING | TimerID #12, TimerThread #46 | [HomeMatic Socket] = Waiting for response timed out
11/23/2013 01:38:25.318 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 01:39:25.347 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 01:40:25.512 | 16169 | MESSAGE | HomeMatic Socket     | Socket (Data Radio) - Connected
11/23/2013 01:40:25.512 | 16169 | MESSAGE | EventControl         | Reconnecting [HomeMatic Socket] succeeded
11/23/2013 06:00:16.560 |     0 | ERROR   | ScriptEngine         | FunctionName: SetValue, ThreadID: 6784, CrashReport: Out of memory
11/23/2013 06:00:22.457 |     0 | ERROR   | ScriptEngine         | FunctionName: SetValue, ThreadID: 6784, CrashReport: Out of memory
11/23/2013 06:00:32.761 |     0 | WARNING | ReadThread           | Out of memory
11/23/2013 06:00:32.761 | 16169 | MESSAGE | HomeMatic Socket     | Socket (Data Radio) - Disconnected
11/23/2013 06:00:37.410 |     0 | ERROR   | ScriptEngine         | FunctionName: SetValue, ThreadID: 6784, CrashReport: Out of memory
11/23/2013 06:00:37.769 | 16169 | WARNING | TimerID #12, TimerThread #16 | [HomeMatic Socket] = Waiting for response timed out
11/23/2013 06:00:52.327 |     0 | ERROR   | ScriptEngine         | FunctionName: SetValue, ThreadID: 6784, CrashReport: Out of memory
11/23/2013 06:01:07.350 |     0 | ERROR   | ScriptEngine         | FunctionName: SetValue, ThreadID: 6784, CrashReport: Out of memory
11/23/2013 06:01:22.370 |     0 | ERROR   | ScriptEngine         | FunctionName: SetValue, ThreadID: 6784, CrashReport: Out of memory
11/23/2013 06:01:28.049 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:02:28.078 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:03:28.097 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:04:28.122 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:05:28.141 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:06:28.171 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:07:28.220 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:08:07.237 |     0 | ERROR   | ScriptEngine         | FunctionName: SetValue, ThreadID: 1736, CrashReport: Out of memory
11/23/2013 06:08:28.291 | 12742 | WARNING | TimerID #13, TimerThread #49 | [Event Handler] = Out of memory
11/23/2013 06:09:28.320 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:10:28.407 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:11:28.615 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:12:28.776 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command
11/23/2013 06:13:28.973 | 16169 | ERROR   | EventControl         | Reconnecting [HomeMatic Socket] failed = Thread creation error: Not enough storage is available to process this command

Interessanterweise sind die Logs der drei Tage davor fast leer, die haben nur diesen Inhalt:

11/22/2013 00:06:26.361 |     0 | MESSAGE | Kernel               | Log File Rotation after Midnight...
11/22/2013 00:06:26.361 |     0 | MESSAGE | Kernel               | Backuping Settings after Midnight...
11/22/2013 00:06:26.377 |     0 | MESSAGE | Kernel               | Cleaning up Logfile Folder...
11/22/2013 00:06:26.377 |     0 | MESSAGE | Settings             | Backuping Settings after Midnight...
11/22/2013 00:06:26.377 |     0 | MESSAGE | Settings             | Cleaning up Settings Folder...
11/23/2013 00:09:44.756 |     0 | MESSAGE | Kernel               | Log File Rotation after Midnight...

Ich habe seit Monaten nichts am Setup des Systems geaendert, dieses Problem tritt seit #3007 auf. Ich gehe also davon aus, dass das ein Bug ist und bitte IP-Symcon hoeflich um Reaktion.

Danke

Adrian

paresy · 23. November 2013 um 11:27

Kein Platz mehr auf der Festplatte? Mal den RAM beobachtet?

paresy

axbigo · 23. November 2013 um 13:13

Hier nochmal der Auszug aus meinem ersten Post:

Zu dem Zeitpunkt hatte der Zerver etwa 4GB RAM und 22 GB HDD frei, daran kann’s also nicht liegen.

Hier nochmal die Profile dieser Woche fuer CPU, RAM und HDD. Alles mehr als reichlich vorhanden:

paresy · 23. November 2013 um 14:49

Okey. Ich vermute aber, dass der Verbrauch der ips.exe auf > 2,3GB RAM geht. Evtl. kannst du noch schauen, ob z.B. deine access_*.log im logs Ordner zu groß wird.

paresy

axbigo · 23. November 2013 um 17:47

Ich habe gar keine access logs im log ordner.

Den Speicherverbrauch der ips.exe kann ich werde beinflussen noch ermitteln, richtig?

Danke

Adrian

paresy · 24. November 2013 um 09:34

Jupp. Hiermit: http://www.ip-symcon.de/service/dokumentation/modulreferenz/system-informationen/sys-getprocessinfo/

Trotzdem ist die Frage, wer dir Speicher wegfrisst. Manchmal ist es gerne ein Skript, welches z.B. fopen nutzt, aber nicht korrekt mit fclose abschließt.

paresy