UZSU - Neue Version von Onkelandy

[schuma]

Und ich nehme an von Mitternacht an oder einfach nur bis der Fehler auftritt? Das wäre beim Start von SHNG schon der Fall.

[Onkelandy]

Egal, einfach mal her damit und dann gerne nochmals was zu Mitternacht.

[schuma]

Wenn ich das so in der logging.yaml eintrage, kann ich smarthomeng nicht mehr starten...

Fehlermeldung:

Job for smarthome.service failed because the control process exited with error code.
See "systemctl status smarthome.service" and "journalctl -xe" for details.

[Onkelandy]

Zusätzlich zu den Standardeinträgen. Sonst kennt er wohl tatsächlich den formatter nicht. Und falls es nicht klappt journalctl -xe gibt Hinweise

[schuma]

Jetzt habe ich es hinbekommen....
SHNG konnte mit dem formatter: shng_detail nichts anfangen!

Jetzt läuft es so:

handlers:
  uzsu_file:
    class: logging.handlers.TimedRotatingFileHandler
    formatter: detail
    level: DEBUG
    utc: false
    when: midnight
    backupCount: 7
    filename: ./var/log/uzsu.log
    encoding: utf8
loggers:
    plugins.uzsu:
        handlers: [uzsu_file]
        level: DEBUG

[schuma]

Ich habe da heute noch mehr Fehler im Log...

018-09-29  18:40:06 ERROR    plugins.uzsu.uzsu_EG.Raum7.Rolladen5.pos.schaltuhr uzsu: Error '15:59<sunset-20m<21:59' parsing time: 'Sun' transits below the horizon at 2018/9/22 11:09:35
2018-09-29  18:41:24 ERROR    plugins.uzsu.uzsu_EG.Raum7.Rolladen5.pos.schaltuhr uzsu: Error '15:59<sunset-20m<21:59' parsing time: 'Sun' is still above the horizon at 2018/9/22 23:09:24
2018-09-29  19:21:28 INFO     Scheduler    Adding worker thread. Total: 6
2018-09-29  19:21:28 INFO     Scheduler    Threads: HTTPServer Thread-18: 1, CP Server Thread-14: 1, CP Server Thread-10: 1, CP Server Thread-11: 1, CP Server Thread-23: 1, CP Server Thread-12: 1, Main: 1, CP Server Thread-9: 1, HTTPServer Thread-7: 1, CP Server Thread-8: 1, CP Server Thread-13: 1, CP Server Thread-19: 1, Thread-27: 1, CP Server Thread-16: 1, plugins.uzsu.uzsu_EG.Raum2.Rolladen1.move.schaltuhr: 1, CP Server Thread-15: 1, Scheduler: 1, _TimeoutMonitor: 1, Thread-28: 1, CP Server Thread-22: 1, CP Server Thread-26: 1, idle: 4, CP Server Thread-21: 1, CP Server Thread-25: 1, CP Server Thread-17: 1, MonitoringService_avm_fritzbox_1: 1, CP Server Thread-24: 1, CP Server Thread-20: 1
2018-09-29  19:22:30 INFO     Scheduler    Adding worker thread. Total: 7
2018-09-29  19:22:30 INFO     Scheduler    Threads: Thread-29: 1, HTTPServer Thread-18: 1, CP Server Thread-11: 1, CP Server Thread-23: 1, CP Server Thread-12: 1, Main: 1, CP Server Thread-25: 1, CP Server Thread-14: 1, CP Server Thread-9: 1, CP Server Thread-8: 1, CP Server Thread-13: 1, HTTPServer Thread-7: 1, Scheduler: 1, CP Server Thread-16: 1, Thread-27: 1, CP Server Thread-15: 1, _TimeoutMonitor: 1, CP Server Thread-24: 1, CP Server Thread-22: 1, CP Server Thread-26: 1, idle: 6, CP Server Thread-21: 1, CP Server Thread-10: 1, CP Server Thread-17: 1, MonitoringService_avm_fritzbox_1: 1, CP Server Thread-20: 1, CP Server Thread-19: 1
2018-09-29  19:23:26 ERROR    plugins.uzsu.uzsu_EG.Raum7.Rolladen5.pos.schaltuhr uzsu: Error '07:30<sunrise<09:00' parsing time: 'Sun' transits below the horizon at 2018/9/22 11:09:35
2018-09-29  19:23:31 INFO     Scheduler    Adding worker thread. Total: 8
2018-09-29  19:23:31 INFO     Scheduler    Threads: HTTPServer Thread-18: 1, CP Server Thread-11: 1, CP Server Thread-23: 1, CP Server Thread-12: 1, Main: 1, CP Server Thread-25: 1, CP Server Thread-14: 1, CP Server Thread-9: 1, CP Server Thread-8: 1, CP Server Thread-13: 1, HTTPServer Thread-7: 1, Scheduler: 1, CP Server Thread-16: 1, Thread-27: 1, CP Server Thread-15: 1, Thread-30: 1, idle: 7, CP Server Thread-20: 1, CP Server Thread-22: 1, CP Server Thread-26: 1, _TimeoutMonitor: 1, CP Server Thread-21: 1, CP Server Thread-10: 1, CP Server Thread-17: 1, MonitoringService_avm_fritzbox_1: 1, CP Server Thread-24: 1, CP Server Thread-19: 1
2018-09-29  19:23:49 ERROR    plugins.uzsu.uzsu_EG.Raum7.Rolladen5.pos.schaltuhr uzsu: Error '16:00<sunset+22m<22:00' parsing time: 'Sun' is still above the horizon at 2018/9/22 23:09:24
2018-09-29  19:24:32 INFO     Scheduler    Adding worker thread. Total: 9
2018-09-29  19:24:32 INFO     Scheduler    Threads: HTTPServer Thread-18: 1, CP Server Thread-11: 1, CP Server Thread-23: 1, CP Server Thread-12: 1, Main: 1, CP Server Thread-25: 1, CP Server Thread-14: 1, CP Server Thread-9: 1, CP Server Thread-8: 1, CP Server Thread-13: 1, HTTPServer Thread-7: 1, Scheduler: 1, CP Server Thread-16: 1, Thread-27: 1, CP Server Thread-15: 1, Thread-31: 1, idle: 8, CP Server Thread-24: 1, CP Server Thread-22: 1, CP Server Thread-26: 1, _TimeoutMonitor: 1, CP Server Thread-21: 1, CP Server Thread-10: 1, CP Server Thread-17: 1, MonitoringService_avm_fritzbox_1: 1, CP Server Thread-20: 1, CP Server Thread-19: 1

[Onkelandy]

schuma Das erste Problem sollte behoben sein, bitte nochmals von meinem repo neu ziehen.
Zweiteren Fehler kann ich nur versuchen nachvollziehen, wenn ich das DEBUG log bekomme. Der Fehler sollte nur kommen, wenn der Offset zu groß ist, bei 7:30<sunrise<9:00 ist das ehrlich gesagt ganz komisch und nicht reproduzierbar bei mir.

[schuma]

Heute habe ich das Log für die UZSU mal den ganzen Tag laufen lassen.
Bis um ca. 18:37. Ab da an hat sich irgendetwas totogelaufen und das Logfile wuchs rasant an.

Noch etwas komisches: Der Scheduler für den EG.Raum2.Rolladen wird nicht mehr gesetzt. Obwohl in der Visu alles angezeigt wird wird der Schedulereintrag einfach nicht erstellt. Die Rolladen fahren dementsprechend auch nicht mehr.

[Onkelandy]

Tut mir Leid wegen der Fehler, dachte, das Ding läuft super zuverlässig
Hab nochmals ein Update gepusht. Das Verheddern dürfte auf einem einfachen Namensfehler basieren (UZSU statt UZSU Plugin), hoffe ich.

Warum der Rolladen nicht getriggert wird, ist nicht ganz nachvollziehbar. Hab hier ein Item mit den gleichen Einträgen und da funzt es. Ich fürchte, da musst du nochmals sh 2, 3 Male neu starten und das Log beobachten. Ich habe dort nun eine Zeile eingefügt, falls ein Item nicht aktualisiert wird nach dem Pluginstart. Interessant wäre auch noch, was das webinterface zu dem Item sagt. Danke

[schuma]

Das Plugin habe ich gerade getauscht.
Beim Start wird jetzt auf jeden Fall schon mal der verlorene Rolladen wieder gesetzt (scheduler).
Log läuft dann bis morgen, mal sehen... Wird schon...

Edit an Onkelandy :
Nach dem Neustart war jetzt ein anderes Item nicht geladen. (Setup.Schalter.BAD_Verstaerker.schaltuhr)
Im Webinterface stand dazu: Item aktiv aber keine Einträge.
Hat es aber.... Ich habe die UZSU in der VISU deaktiviert und wieder aktiviert, dann wurde der Scheduler Eintrag auch angelegt. Eintrag im WebIf grün.
Im Log steht: Removed duplicate entries for item Setup.Schalter.BAD_Verstaerker.schaltuhr.

Kann Du dann morgen im Log sehen.

[Onkelandy]

mitternachts wird es nochmals spannend

[schuma]

Hier das Log von gestern und heute:

[schuma]

Onkelandy Jetzt hat sich heute doch noch mal das Log totgelaufen....

Hier das Logfile von heute mit dem "Totlauf". Ich musste es in zwei Teile teilen. Ist sonst zu groß für das Forum:

[schuma]

Ich habe jetzt noch mal ein neues Item mit einer uzsu angelegt.

Beim Klick auf OK in der VISU kommt das hier:

2018-10-01  20:23:15 ERROR    Main         Item AA.Raum0.Licht.Licht_Westseite.schaltuhr: problem running <bound method UZSU.update_item of <plugins.uzsu.UZSU object at 0x65a15dd0>>: 'interpolation'
Traceback (most recent call last):
  File "/usr/local/smarthome/lib/item.py", line 1039, in __update
    method(self, caller, source, dest)
  File "/usr/local/smarthome/plugins/uzsu/__init__.py", line 375, in update_item
    self._schedule(item, caller='update')
  File "/usr/local/smarthome/plugins/uzsu/__init__.py", line 393, in _schedule
    if not self._items[item]['interpolation'].get('itemtype'):
KeyError: 'interpolation'

nach einem erneuten Neustart von SMNG kommt die Meldung nicht mehr im Log.
Sieht so aus, als ob der die Cachedatei falsch angelegt wird.

Dafür kommt dann das hier:

2018-10-01  20:40:06 WARNING  Main         uzsu item 'AA.Raum0.Licht.Licht_Westseite.schaltuhr' is active but has no entries.

[Onkelandy]

Welche shng Version nutzt du denn? Ich kann's mir nur so erklären, dass du evtl. ein altes item.py im lib hast.. das hatte Probleme mit dem Anlegen/Kopieren von Dictionaries... du brauchst die neueste Datei im lib Ordner: https://github.com/smarthomeNG/smart...op/lib/item.py

smartvisu 2.9 hast du eh up to date?

Den Hänger konnte ich nun reproduzieren.. Hab ein Update gepusht. Ich hoffe, dass es nun das Problem endgültig behebt.