IP Symcon schließt öfters automatisch

Hallo,
seit einigen Tagen schließt sich IP-Symcon von selbst und startet nicht neu. In der Computerverwaltung steht:

Name der fehlerhaften Anwendung: ips.exe
Version: 2.4.0.0

Name des fehlerhaften Moduls: ips.exe
Version: 2.4.0.0

ID des fehlerhaften Prozesses: 0x804

Logfiles. Logfiles. Logfiles. :wink:

paresy

Die Logfile hört genau um die Uhrzeit auf aufzuzeichnen, in der der Fehler auftritt.

Das klingt erstmal logisch :wink:

Was war vorher?.. wäre auch interessant.

Das Problem besteht schon immer, IPS schließt sich von selbst, und der Dienst muss neu gestartet werden. Ich habe auch schon probiert IPS jeden Tag über eine .bat Datei neustarten zu lassen, aber ohne Erfolg.

Du fährst noch auf der 2.4. Wie schaut es mit einem Update auf die aktuelle 2.6 aus?

paresy

Hallo paresy,
das Update auf Version 2.6 funktioniert leider nicht weil manche Scripts nicht unter der neuen Version laufen.

Ich habe aber in einer älteren Logfile folgende Fehlermeldung gefunden:

31.10.2012 07:55:50.968 | 50541 | WARNING | WebServer | Error #7: Access violation at address 00407EAC in module ‚ips.exe‘. Read of address 00000008

Folgendes tritt auch häufiger auf:
29.11.2012 00:44:44.522 | 55918 | ERROR | ExecuteThreadID #4 | [MODBUS] =
Warning: socket_write() [function.socket-write]: unable to write to socket [0]: Ein Socketvorgang konnte nicht ausgeführt werden, da dem System Pufferspeicher fehlte oder eine Warteschlange voll war.
in C:\IP-Symcon\scripts\Phpmodbus\ModbusMasterUdp.php on line 115
readMultipleRegisters: START
Connected
Packet: e9b30000000600033001007d
Send
Wait data …
Wait data …
Wait data …
Wait data …
exception ‚Exception‘ with message ‚Watchdog time expired [ 5 sec]!!! Connection to 192.168.178.103 is not established.‘ in C:\IP-Symcon\scripts\Phpmodbus\ModbusMasterUdp.php:147
Stack trace:
#0 C:\IP-Symcon\scripts\Phpmodbus\ModbusMasterUdp.php(312): ModbusMasterUdp->rec()
#1 C:\IP-Symcon\scripts\55918.ips.php(10): ModbusMasterUdp->readMultipleRegisters(0, 12289, 125)
#2 {main}

Also bei mir steigt IPS in letzter Zeit immer öfter aus. Der Dienst beendet sich und startet dann nicht wieder.
Ich habe versucht das mit IPSWatchdog zu umgehen, allerdings funktionier IPSWatchdog bei mir nicht, da es zwar im Autostart läuft, aber das ja nur ausgeführt wird, wenn ein User am Windows angemeldet ist.
Hier mal meine Logs

08.12.2012 22:58:17.683 | 30811 | MESSAGE | VariableManager      | [Aktoren-Sensoren\Licht\Flur DG\STATE] = True
08.12.2012 22:58:17.686 | 34275 | MESSAGE | VariableManager      | [Aktoren-Sensoren\Licht\Flur DG\WORKING] = True
08.12.2012 22:58:17.729 |     0 | DEBUG   | ExecuteThreadID #8   | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 11279 ms
08.12.2012 22:58:19.513 |     0 | DEBUG   | ExecuteThreadID #8   | Skriptausführung: ips.php ~ Absender: WebInterface
08.12.2012 22:58:24.802 | 19934 | MESSAGE | VariableManager      | [Aktoren-Sensoren\Licht\Bad\Status] = True
08.12.2012 22:58:24.817 | 36000 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Licht\Bad\WORKING] = False
08.12.2012 22:58:24.849 |     0 | DEBUG   | ExecuteThreadID #8   | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 5339 ms
08.12.2012 22:58:26.627 |     0 | DEBUG   | ExecuteThreadID #2   | Skriptausführung: ips.php ~ Absender: WebInterface
08.12.2012 22:58:30.012 | 31855 | DEBUG   | ExecuteThreadID #4   | Skriptausführung: IWDAliveFileSkript.php ~ Absender: Ereignis #21124, Zeit Ereignis
08.12.2012 22:58:30.028 | 31855 | DEBUG   | ExecuteThreadID #4   | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 27 ms
08.12.2012 22:58:46.720 |     0 | DEBUG   | ExecuteThreadID #2   | Ausgeführt, Resultat: 1, Erfolgreich: True, Zeit: 20096 ms
08.12.2012 22:58:47.930 |     0 | DEBUG   | ExecuteThreadID #2   | Skriptausführung: ips.php ~ Absender: WebInterface
08.12.2012 22:58:47.930 |     0 | WARNING | ExecuteThreadID #2   | Fehler beim Ausführen des Skripts (ips.php): Access violation at address 00404CB0 in module 'ips.exe'. Read of address 08468AFC

Das ganze ist dahingehend unangenehm, da auch die ganze Heizung über IPS gesteuert wir dund ich zum beispiel heute morgen in einem kalten Bad stehen musste, weil IPS gestern am späten abend seinen Dienst einstellte. Im Sommer wär mir das egal.

Ich habe gerade mal wieder einen Totalabsturz.

14.12.2012 04:18:04.106 |     0 | ERROR   | InstanceManager      | Fehler beim Verarbeiten von Nachricht: VM_UPDATE, Instanz 54833, Nachricht: database or disk is full
14.12.2012 04:18:04.121 | 22133 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Heizungspumpe\WORKING] = False
14.12.2012 04:18:30.002 | 31855 | WARNING | ScriptEngine         | Datei für Skript [Skripte\IPSWatchDog\IWDAliveFileSkript] nicht gefunden! ~ Absender: Ereignis #21124, Zeit Ereignis
14.12.2012 04:18:31.936 | 37787 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Thermostate\Thermostat Schlafzimmer\Temperatur] = 20.7
14.12.2012 04:18:31.936 | 31213 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Thermostate\Thermostat Schlafzimmer\Luftfeuchte] = 55
14.12.2012 04:18:31.952 |     0 | ERROR   | InstanceManager      | Fehler beim Verarbeiten von Nachricht: VM_UPDATE, Instanz 54833, Nachricht: unable to open database file
14.12.2012 04:18:31.952 |     0 | ERROR   | InstanceManager      | Fehler beim Verarbeiten von Nachricht: VM_UPDATE, Instanz 54833, Nachricht: unable to open database file
14.12.2012 04:18:40.033 | 11061 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Thermostate\Außensensor\Temperatur] = -0.1
14.12.2012 04:18:40.033 | 48386 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Thermostate\Außensensor\Luftfeuchte] = 89
14.12.2012 04:18:40.048 |     0 | ERROR   | InstanceManager      | Fehler beim Verarbeiten von Nachricht: VM_UPDATE, Instanz 54833, Nachricht: database or disk is full
14.12.2012 04:18:40.064 |     0 | ERROR   | InstanceManager      | Fehler beim Verarbeiten von Nachricht: VM_UPDATE, Instanz 54833, Nachricht: database or disk is full
14.12.2012 04:18:46.101 | 50185 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Thermostate\Thermostat Bad\Temperatur] = 21
14.12.2012 04:18:46.101 |     0 | ERROR   | InstanceManager      | Fehler beim Verarbeiten von Nachricht: VM_UPDATE, Instanz 54833, Nachricht: unable to open database file
14.12.2012 04:18:46.101 | 14932 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Thermostate\Thermostat Bad\Luftfeuchte] = 56
14.12.2012 04:18:46.179 |     0 | ERROR   | InstanceManager      | Fehler beim Verarbeiten von Nachricht: VM_UPDATE, Instanz 54833, Nachricht: database or disk is full
14.12.2012 04:18:48.644 | 15258 | WARNING | Serial Port          | I/O error 32

Irgendwann geht dann gar nichts mehr. Das komplette System lag lahm.

14.12.2012 04:20:02.869 | 35681 | ERROR   | ExecuteThreadID #3   | [Skripte\HighCharts\HighChartsConfigAußenKlima] = 
Fatal error:  Out of memory (allocated 524288) (tried to allocate 12969 bytes) in [Program\IPSLibrary\app\core\IPSLogger\IPSLogger_Output] on line 207

14.12.2012 04:20:02.869 | 35681 | DEBUG   | ExecuteThreadID #3   | Ausgeführt, Resultat: 0, Erfolgreich: False, Zeit: 291 ms
14.12.2012 04:20:03.633 |     0 | ERROR   | Settings             | Error updating on message EM_UPDATE for Sender 35739. Error: Out of memory
14.12.2012 04:20:17.595 |     0 | WARNING | TimerThread #5       | Out of memory
14.12.2012 04:20:42.025 |     0 | WARNING | TimerThread #4       | Out of memory
14.12.2012 04:20:49.450 | 54833 | WARNING | TimerID #9, TimerThread #10 | [Archive Handler] = SQL logic error or missing database
14.12.2012 04:26:34.071 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 04:36:34.079 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 04:46:34.087 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 04:56:34.095 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 05:06:34.104 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 05:16:34.112 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 05:26:34.120 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 05:36:34.128 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 05:46:34.137 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 05:56:34.145 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 06:06:34.153 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 06:16:34.161 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 06:26:34.170 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 06:36:34.178 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 06:46:48.757 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 06:56:48.765 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 07:06:48.773 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 07:16:48.781 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 07:26:48.790 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 07:36:48.798 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 07:46:56.762 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 07:56:56.770 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 08:06:56.779 |     0 | DEBUG   | Settings             | Error writing Settings...
14.12.2012 08:11:48.764 | 13785 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Thermostate\Thermostat Max\Temperatur] = 20.4
14.12.2012 08:11:48.780 | 11480 | DEBUG   | VariableManager      | [Aktoren-Sensoren\Thermostate\Thermostat Max\Luftfeuchte] = 56

Anhand der Fehler habe ich erst mal die Platte gecheckt (SSD) die arbeite einwandfrei und hat keine Schreib-Lese-Fehler. Rechner neu gestartet und die Settings angeschaut. Diese waren leer. Nach Rückspielen der Backup Settings läuft jetzt alles wieder .
Momentan läuft mein System keine 4 Tage durch. Das ist mehr als unbefriedigend!

Logge dir mal deinen RAM mit. Out of Memory klingt wie ein Speicherleck, dass du dir irgendwo gebaut hast.

Alternativ der I/O Error von Serial Port könnte auf veraltete USB -> Seriell Treiber deuten?

paresy

Der I/O Error kommt von vom meiner FHZ1300. Da war das USB Kabek raus gerutscht. Das sollte aber abgesehen von der Fehlermeldung keinen einfluss haben. Da hängt nur eine Außenlampe dran.

Ram mitloggen? in IPSymcon oder meinst Du mit dem Taskmanager?

Also den Speicher habe ich mal mit dem Windows Ressourcenmonitor angeschaut.
Bei der IPS. Exe scheint nichts außergewöhnliches zu pasieren.
Alleridngs komme wird es immer bunter was das System mit mir treibt. Jetzt ist der Wurm im Webfront drin. Ich rufe es mit Chrome auf. NAchdem der Bildschirm aufgebaut hat steht untern „warte auf 192.168.178.35“. Der Mauszeiger geht in " Wait" und es passier tnix mehr. Ich kann keinen Reiter anklicken noch sonst irgendwas machen. Der Speicher den Chrome verbraucht steigt sekündlich um etwa 1MByte an!!!. eine analoges Verhalten zeigt Firefox. In den ogfiles finde ich keine Anhaltspunkte, dass da etwas schief laufen sollte.
Die Android App ist momentan die einzige Möglichkeit mein System zu bedienen.

PS: Ich habe keinerlei Änderungen an der Konfiguration vorgenommen!! Es lief halt mal und irgendwie steigen die Fehler in letzter Zeit exponentiell an. :frowning:

In einem anderen Thread im Forum steht beschrieben, dass der aktuelle Chrome Speicher frisst. Musst mal danach suchen oder zeitweise auf Firefox ausweichen.

paresy