[gelöst] ical - seit Samstag keine Aktualisierung mehr

[hobbycamper]

Hallo,

den ical -Adapter (1.5.2) habe ich vor ca. 8 Wochen installiert, lief bis Samstag tadellos! (Admin 2.0.9) Am Sonntag ist mir aufgefallen, dass der Samstag-Termin immer noch in roter Schrift vorhanden war. Letzte Aktualisierung des Datenpunkts war am Samstag. Gestern auch noch keine Änderung. In meiner Unwissenheit habe ich dann den Adapter gelöscht, neu installiert und erst mal einen Kalender eingestellt (habe zwei google und zwei lokale Kalender). Die Datenpunkte wurden zwar angelegt, aber nicht befüllt ( halben Tag gewartet). Aktualisierung steht auf jede halbe Stunde, sollte aber auch nach Neustart des Adapters aktualisieren (?).

Dann habe ich noch ein Update des Systems gemacht (nun Admin 3.3.6) und den Adapter habe ich noch auf 1.5.3 erhöht. Keine Besserung….

Gibt es einen Punkt wo ich ansetzen kann?

Grüße

Thomas
5576_log.jpg
5576_objekte.jpg

[arteck]

solch Probleme kenn ich.. bei mir wars andersrum.. ich habe keine Events im meinem Kalender gehabt und der Adapter meinete DOCH..

hast mal den iobroker neu gestartet .. ansonsten ja der Adapter sollte bei Adapterneustart die Daten ziehen..

[hobbycamper]

klar, iobroker neu gestartet, raspi neu gestartet…...

[wendy2702]

Mal ein Refresh des Objekt Tabs versucht?

Browser Cache gelöscht und Forced Reload (CTRL-F5) ?

Ical Instanz mal im Debug laufen lassen?

Was meinst du mit "Aktualisierung steht auf jede halbe Stunde"? –> ical instanz wird ausgeführt ??

[hobbycamper]

Refresh gemacht,Cache geleert (Das Widget der Visu zeigt ja auch nichts mehr an). Debug habe ich ja schon gepostet, siehe Bild. Aktualisierung meine ich die Zeitplanung unter Instanzen. Ich habe nur die standardmäßige 0 und 30 in 02 und 32 geändert

[wendy2702]

Kannst du die Instanz mal stoppen, die ical Objekte löschen, dann Instanz wieder starten und davon das log (Bitte als Text in Code-Tags) posten und schauen ob die Objekte danach befüllt werden?

Zusätzlich wäre ein Screenshot der Adapter Einstellung hilfreich.

[hobbycamper]

Alles schon gemacht, aber hier nochmal:

host.ioBroker-Pi	2018-04-10 11:38:00.033	warn	instance system.adapter.ical.0 already running with pid 12962
ical.0				2018-04-10 11:37:26.711	debug	Event " " Exxx at Tue Nov 21 2017 16:30:00 GMT+0100 (CET) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.710	debug	Event " " Exxx at Thu Nov 23 2017 14:20:00 GMT+0100 (CET) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.709	debug	Event (full day) " " Txxxb at Mon Apr 30 2018 00:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.709	debug	Event (full day) " " Txxxb at Fri May 11 2018 00:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.708	debug	Event (full day) " " Txxxb at Tue May 22 2018 00:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.708	debug	Event (full day) " " Txxxb at Mon Aug 06 2018 00:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.708	debug	Event (full day) " " Txxxb at Fri Nov 02 2018 00:00:00 GMT+0100 (CET) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.707	debug	Event " " Exxxng at Thu Dec 07 2017 17:00:00 GMT+0100 (CET) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.707	debug	Event (full day) " " Exxxub at Wed Dec 27 2017 00:00:00 GMT+0100 (CET) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.706	debug	Event " " Haxxxc at Thu Jan 11 2018 09:35:00 GMT+0100 (CET) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.706	debug	Event with time added: " " Arxxxxn at In 5 Tagen 12:00-13:00
ical.0				2018-04-10 11:37:26.703	debug	todayOnly = false: (Sun Apr 15 2018 12:00:00 GMT+0200 (CEST)-Sun Apr 15 2018 13:00:00 GMT+0200 (CEST)), alreadyStarted=false
ical.0				2018-04-10 11:37:26.696	debug	Event " " Taxxxat Thu Apr 26 2018 10:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.696	debug	Event " " Taxxxo at Thu May 24 2018 10:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.696	debug	Event " " Txxxx at Thu Jun 14 2018 10:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.695	debug	Event " " ExxxxxNO at Wed Mar 07 2018 10:10:00 GMT+0100 (CET) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.695	debug	Event " " Exxxxt at Mon May 14 2018 14:15:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.694	debug	Event " " Erxxxxxox at Fri Mar 30 2018 18:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.694	debug	Event (full day) " " Txxxb at Mon Mar 26 2018 00:00:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.693	debug	Event " " xxxxxzt at Tue Apr 10 2018 09:45:00 GMT+0200 (CEST) filtered out, because does not belongs to specified time interval
ical.0				2018-04-10 11:37:26.686	debug	{"6op3xxxxxxxxxx64@google.com":{"type":"VEVENT","params":[],"start":"2018-04-10T07:45:00.000Z","end":"2018-04-10T08:45:00.000Z","dtstamp":"2018-04-10T09:37:2
ical.0				2018-04-10 11:37:26.684	info	processing URL: Familie https://calendar.google.com/calendar/ical/a7ki2q8bxxxxxxxxxxxgroup.calendar.google.com/private-2f3xxxxxxxxxxxxx98e/basic.ics
ical.0				2018-04-10 11:37:26.472	info	Event "ical.0.events.Vacation" created
ical.0				2018-04-10 11:37:26.074	debug	reading calendar from URL: https://calendar.google.com/calendar/ical/a7ki2q8bsbxxxxxxxxxx0group.calendar.google.com/private-2fxxxxxxxxe598e/basic.ics, color: undefined
ical.0				2018-04-10 11:37:26.073	debug	reading calendar from URL: /media/usb0/addressbook#contacts@group.v.calendar.google.com.ics, color: undefined
ical.0				2018-04-10 11:37:26.068	debug	reading calendar from URL: /media/usb/allestrassxxxxxch.ics, color: undefined
ical.0				2018-04-10 11:37:25.944	info	starting. Version 1.5.3 in /opt/iobroker/node_modules/iobroker.ical, node: v6.14.1
ical.0				2018-04-10 11:37:25.882	info	States connected to redis: 127.0.0.1:6379
ical.0				2018-04-10 11:37:25.871	debug	statesDB connected
ical.0				2018-04-10 11:37:25.818	debug	objectDB connected
host.ioBroker-Pi	2018-04-10 11:37:23.538	info	instance system.adapter.ical.0 started with pid 12962
host.ioBroker-Pi	2018-04-10 11:37:23.504	info	instance scheduled system.adapter.ical.0 8,38 * * * *
host.ioBroker-Pi	2018-04-10 11:37:20.917	warn	stopInstance system.adapter.ical.0 not scheduled
host.ioBroker-Pi	2018-04-10 11:37:20.916	info	stopInstance system.adapter.ical.0
host.ioBroker-Pi	2018-04-10 11:37:20.915	info	object change system.adapter.ical.0
host.ioBroker-Pi	2018-04-10 11:37:18.117	warn	stopInstance system.adapter.ical.0 not scheduled
host.ioBroker-Pi	2018-04-10 11:37:18.117	info	stopInstance system.adapter.ical.0

Das Objekt ical.0 wird gleich angelegt, der Unterpunkt events/vacation wird nach ca. 5-10 Minuten angelegt, ical.0/data wurde bis jetzt (ca 30 Minuten später) noch nicht angelegt. Weiß nicht wie lange es gestern gedauert hat, wurde dann aber irgendwann angelegt, die Datenpunkte darunter (siehe Bild erster Post) blieben aber leer

[wendy2702]

Laut logfile sehe ich aktuell nur einen Termin der ausgelesen wurde, in der Zukunft liegt und sichtbar sein sollte.

2018-04-10 11:37:26.706	debug	Event with time added: " " Arxxxxn at In 5 Tagen 12:00-13:00
ical.0				2018-04-10 11:37:26.703	debug	todayOnly = false: (Sun Apr 15 2018 12:00:00 GMT+0200 (CEST)-Sun Apr 15 2018 13:00:00 GMT+0200 (CEST)), alreadyStarted=false

Kannst du nur zum Testen mal die Kalender aus der Konfig löschen in denen dieser Eintrag nicht vorkommt?

Bist du sicher das du den Haken bei "Ignoriere SSL Fehler" nicht benötigst um die HTTPS Kalender auszulesen?

Ich nutze noch eine Version 1.5.0 mit Admin 3.3.5 und JS-Controller 1.3.0 laufen, da funktioniert das füllen der Objekte noch.

[hobbycamper]

Bin gerade nicht zu Hause.

Teste später wieder….

[eric2905]

Was ich gemerkt habe …

Wenn man einen einzelnen Termin aus einer Serie ändert (zeitlich anders legt), dann klemmt das ab und an.

Ich lösche mittlerweile diesen einen Eintrag der Serie und machen dann einen einzelnen Eintrag.

Meine beiden Google-Kalender mit insgesamt 7 Events rennen seitdem ohne jegliche Klemmer, usw.

Gruß,

Eric

[apollon77]

Bitte sicherstellen das auch wirklich alle Pfade und URLs erreichbar sind und das File jeweilige File liefern. Es sieht mir irgendwie aus als ob er die eine URL verarbeiten kann, aber dann den Pfad nicht kriegt und es dann irgendwie timeouts gibt, weil nach 4 Minuten wird er gekillt.

[hobbycamper]

Seltsam,

nachdem nicht mal der Datenpunkt ical.0/Data angelegt wurde, habe ich soeben nochmal alles gelöscht, dann wie empfohlen, nur den einen Kalender samt "ignoriere SSL Fehler" angelegt, und siehe da, dieser eine Event ist nun eingetragen :?:

Ich werde jetzt mal nach und nach die anderen Kalender hinzufügen und beobachten.

Bericht folgt…..

[hobbycamper]

Danke an Allen für die Hinweise!

Der Fehler ist gefunden. Und zwar war ein lokaler Kalender, der auf dem gesteckten USB-Stick war, warum auch immer, nicht mehr vorhanden. Ich habe ihn erneut rüberkopiert, eingerichtet und nun läuft es.

Nochmals DANKE!

[apollon77]

Naja, Du hast durchaus einen Bug gefunden … Der Adapter sollte auch bei "File not found" weiterarbeiten und die anderen Kalender abarbeiten. Ich Fixe das mal

[hobbycamper]

Freut mich :lol: