[gelöst] iCal - Events aus dem Exchange gehen nicht mehr

[matze-pe]

Hallo,
seit gestern funktioniert die Kalender Abholung nicht mehr im iCal Adpater.
Der iCal Kalender hat sonst die letzten Jahre sehr gut funktioniert.
Ich habe 2-3 Termine gelöscht, die ich die letzten Tage eingetragen habe. Im Outlook und am iPhone werden sie alle korrekt angezeigt.
Die angebene URL lädt auch die .ics Datei herunter und ist mit Inhalt entsprechend gefüllt.
21 Tage im vorraus sollen Termine abgerufen werden, hier sind auch einige Termine im Original Kalender drin.

Im Log vom ioBroker finde ich keinen Fehler:

ical.0	2022-05-12 11:05:06.590	info	Terminated (NO_ERROR): Without reason
ical.0	2022-05-12 11:05:00.921	info	starting. Version 1.12.1 in /opt/iobroker/node_modules/iobroker.ical, node: v16.14.2, js-controller: 4.0.23
ical.0	2022-05-12 11:00:22.550	info	Terminated (NO_ERROR): Without reason
ical.0	2022-05-12 11:00:16.882	info	starting. Version 1.12.1 in /opt/iobroker/node_modules/iobroker.ical, node: v16.14.2, js-controller: 4.0.23
ical.0	2022-05-12 10:30:14.529	info	Terminated (NO_ERROR): Without reason
ical.0	2022-05-12 10:30:08.888	info	starting. Version 1.12.1 in /opt/iobroker/node_modules/iobroker.ical, node: v16.14.2, js-controller: 4.0.23
ical.0	2022-05-12 10:22:49.794	info	Terminated (NO_ERROR): Without reason

Die Ausgabe ist aber leer:

Hat jemand eine Idee?

Gruß
Matthias

[Glasfaser]

@matze-pe sagte in iCal - Events aus dem Exchange werden nicht mehr abgerufen:

im Log vom ioBroker finde ich keinen Fehler:

Stelle bei der Adapterinstanz die Logstufe auf DEBUG ,
was steht dann im Log ... damit kann man mehr mit anfangen .

node: v16.14.2

Dein System auch sauber installiert.

[matze-pe]

ah danke, habe das Logging erweitert:

--> Plugin sentry destroyed?

ical.0	2022-05-12 17:25:42.150	info	Terminated (NO_ERROR): Without reason
ical.0	2022-05-12 17:25:42.150	debug	Plugin sentry destroyed
ical.0	2022-05-12 17:25:37.137	debug	displaying dates because of callback
ical.0	2022-05-12 17:25:37.121	debug	File read successfully https://mail.xxxxxx.de/owa/calendar/6a1da596647f4d1f8f2bb3f439beb1af@xxxxxx.de/43890b373e4444909776180ebc4e07fe14106945926254340475/calendar.ics
ical.0	2022-05-12 17:25:37.120	debug	Successfully cached content for calendar "https://mail.xxxxxx.de/owa/calendar/6a1da596647f4d1f8f2bb3f439beb1af@xxxxxx.de/43890b373e4444909776180ebc4e07fe14106945926254340475/calendar.ics" as /opt/iobroker/node_modules/iobroker.ical/6e883e0d337a3c0b329ebf12b3c668eb
ical.0	2022-05-12 17:25:37.028	debug	File read successfully https://mail.xxxxxx.de/owa/calendar/c0e6cc2e31414bdbb97884913f16fcc1@xxxxxx.de/0372ae6441fc4accac5f951210ec990d7499262095505457187/calendar.ics
ical.0	2022-05-12 17:25:37.028	debug	Successfully cached content for calendar "https://mail.xxxxxx.de/owa/calendar/c0e6cc2e31414bdbb97884913f16fcc1@xxxxxx.de/0372ae6441fc4accac5f951210ec990d7499262095505457187/calendar.ics" as /opt/iobroker/node_modules/iobroker.ical/30e97e2c91f3332d81bc5bd1ac7d6d7d
ical.0	2022-05-12 17:25:36.678	debug	reading calendar from URL: https://mail.xxxxx.de/owa/calendar/c0e6cc2e31414bdbb97884913f16fcc1@xxxxx.de/0372ae6441fc4accac5f951210ec990d7499262095505457187/calendar.ics, color: #408080
ical.0	2022-05-12 17:25:36.673	debug	reading calendar from URL: https://mail.xxxxx.de/owa/calendar/6a1da596647f4d1f8f2bb3f439beb1af@xxxxx.de/43890b373e4444909776180ebc4e07fe14106945926254340475/calendar.ics, color: #ffffff
ical.0	2022-05-12 17:25:36.479	info	starting. Version 1.12.1 in /opt/iobroker/node_modules/iobroker.ical, node: v16.14.2, js-controller: 4.0.23
ical.0	2022-05-12 17:25:36.330	debug	Plugin sentry Initialize Plugin (enabled=true)
ical.0	2022-05-12 17:25:36.330	debug	Plugin sentry Initialize Plugin (enabled=true)
ical.0	2022-05-12 17:25:36.227	debug	States connected to redis: 127.0.0.1:9000
ical.0	2022-05-12 17:25:36.201	debug	States create User PubSub Client
ical.0	2022-05-12 17:25:36.200	debug	States create System PubSub Client
ical.0	2022-05-12 17:25:36.185	debug	Redis States: Use Redis connection: 127.0.0.1:9000
ical.0	2022-05-12 17:25:36.165	debug	Objects connected to redis: 127.0.0.1:9001
ical.0	2022-05-12 17:25:36.163	debug	Objects client initialize lua scripts
ical.0	2022-05-12 17:25:36.115	debug	Objects create User PubSub Client
ical.0	2022-05-12 17:25:36.114	debug	Objects create System PubSub Client
ical.0	2022-05-12 17:25:36.114	debug	Objects client ready ... initialize now
ical.0	2022-05-12 17:25:36.088	debug	Redis Objects: Use Redis connection: 127.0.0.1:9001
ical.0	2022-05-12 17:25:01.600	info	Terminated (NO_ERROR): Without reason

[Glasfaser]

@matze-pe

Was mich wundert .. bzw. bei dir fehlt ist :

Das eigentlich unter INFO Log ein Cron angezeigt wird und ein Prozess ( PID ) gestartet ist :

Beispiel:

2022-05-12 17:39:18.909  - info: host.iobrokerv6 instance scheduled system.adapter.ical.0 4 0 * * *
2022-05-12 17:39:18.992  - info: host.iobrokerv6 instance system.adapter.ical.0 started with pid 14617

[matze-pe]

@glasfaser

Im Adapter ist alle 30 Min ausgewählt, der Job läuft auch - sehe ich im Protokoll:

Bzgl PID, sehe gerade ich habe im Protokoll nur den ICAL Adapter gefiltert, anbei restliche Log aus dem Zeitraum:

host.iobroker	2022-05-12 17:49:23.136	info	instance system.adapter.ical.0 started with pid 75852
host.iobroker	2022-05-12 17:49:23.125	info	instance scheduled system.adapter.ical.0 0,30 * * * *
host.iobroker	2022-05-12 17:49:00.338	info	instance system.adapter.ical.0 terminated with code 0 (NO_ERROR)

Ich habe hier mal einen kleinen Auszug aus der heruntergeladenen ICS Datei:

BEGIN:VCALENDAR
METHOD:PUBLISH
PRODID:Microsoft Exchange Server 2010
VERSION:2.0
X-WR-CALNAME:Kalender
BEGIN:VTIMEZONE
TZID:(UTC+01:00) Amsterdam\, Berlin\, Bern\, Rom\, Stockholm\, Wien
BEGIN:STANDARD
DTSTART:16010101T030000
TZOFFSETFROM:+0200
TZOFFSETTO:+0100
RRULE:FREQ=YEARLY;INTERVAL=1;BYDAY=-1SU;BYMONTH=10
END:STANDARD
BEGIN:DAYLIGHT
DTSTART:16010101T020000
TZOFFSETFROM:+0100
TZOFFSETTO:+0200
RRULE:FREQ=YEARLY;INTERVAL=1;BYDAY=-1SU;BYMONTH=3
END:DAYLIGHT
END:VTIMEZONE
BEGIN:VTIMEZONE
TZID:UTC
BEGIN:STANDARD
DTSTART:16010101T000000
TZOFFSETFROM:+0000
TZOFFSETTO:+0000
END:STANDARD
BEGIN:DAYLIGHT
DTSTART:16010101T000000
TZOFFSETFROM:+0000
TZOFFSETTO:+0000
END:DAYLIGHT
END:VTIMEZONE
BEGIN:VEVENT
UID:040000008200E00074C5B7101A82E00800000000DC91CD7F4E65D801000000000000000
 01000000019FADDE61F765044A26CFBAFB5A2E9CF
SUMMARY:Terrassentür einstellen Hage
DTSTART;TZID="(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien":2022
 0531T120000
DTEND;TZID="(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien":202205
 31T130000
CLASS:PUBLIC
PRIORITY:5
DTSTAMP:20220512T151925Z
TRANSP:OPAQUE
STATUS:CONFIRMED
SEQUENCE:0
LOCATION:
X-MICROSOFT-CDO-APPT-SEQUENCE:0
X-MICROSOFT-CDO-BUSYSTATUS:BUSY
X-MICROSOFT-CDO-INTENDEDSTATUS:BUSY
X-MICROSOFT-CDO-ALLDAYEVENT:FALSE
X-MICROSOFT-CDO-IMPORTANCE:1
X-MICROSOFT-CDO-INSTTYPE:0
X-MICROSOFT-DONOTFORWARDMEETING:FALSE
X-MICROSOFT-DISALLOW-COUNTER:FALSE
END:VEVENT
BEGIN:VEVENT
DESCRIPTION:Restmülltonne muss bereitgestellt werden.\n
UID:2d289aecf55e7fc52c1f3feaaa9611af
SUMMARY:Restmülltonne
DTSTART;TZID="(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien":2022
 0601T060000
DTEND;TZID="(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien":202206
 01T060000
CLASS:PUBLIC
PRIORITY:5
DTSTAMP:20220512T151925Z
TRANSP:OPAQUE
STATUS:CONFIRMED
SEQUENCE:0
LOCATION:Peine Ortschaften AIa1
X-MICROSOFT-CDO-APPT-SEQUENCE:0
X-MICROSOFT-CDO-BUSYSTATUS:TENTATIVE
X-MICROSOFT-CDO-INTENDEDSTATUS:BUSY
X-MICROSOFT-CDO-ALLDAYEVENT:FALSE
X-MICROSOFT-CDO-IMPORTANCE:1
X-MICROSOFT-CDO-INSTTYPE:0
X-MICROSOFT-DONOTFORWARDMEETING:FALSE
X-MICROSOFT-DISALLOW-COUNTER:FALSE
END:VEVENT
BEGIN:VEVENT
DESCRIPTION:Biotonne muss bereitgestellt werden.\n
UID:4d53673e99ea2b08018e4fdd56115fc5
SUMMARY:Biotonne
DTSTART;TZID="(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien":2022
 0601T060000
DTEND;TZID="(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien":202206
 01T060000
CLASS:PUBLIC
PRIORITY:5
DTSTAMP:20220512T151925Z
TRANSP:OPAQUE
STATUS:CONFIRMED
SEQUENCE:0
LOCATION:Peine Ortschaften AIa1
X-MICROSOFT-CDO-APPT-SEQUENCE:0
X-MICROSOFT-CDO-BUSYSTATUS:TENTATIVE
X-MICROSOFT-CDO-INTENDEDSTATUS:BUSY
X-MICROSOFT-CDO-ALLDAYEVENT:FALSE
X-MICROSOFT-CDO-IMPORTANCE:1
X-MICROSOFT-CDO-INSTTYPE:0
X-MICROSOFT-DONOTFORWARDMEETING:FALSE
X-MICROSOFT-DISALLOW-COUNTER:FALSE
END:VEVENT
BEGIN:VEVENT
DESCRIPTION:Altpapiertonne muss bereitgestellt werden.\n
UID:34595c6f0c822cd755177b3f86041d18
SUMMARY:Altpapiertonne
DTSTART;TZID="(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien":2022
 0609T060000
DTEND;TZID="(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien":202206
 09T060000
CLASS:PUBLIC
PRIORITY:5
DTSTAMP:20220512T151925Z
TRANSP:OPAQUE
STATUS:CONFIRMED
SEQUENCE:0
LOCATION:Peine Ortschaften AIa1
X-MICROSOFT-CDO-APPT-SEQUENCE:0
X-MICROSOFT-CDO-BUSYSTATUS:TENTATIVE
X-MICROSOFT-CDO-INTENDEDSTATUS:BUSY
X-MICROSOFT-CDO-ALLDAYEVENT:FALSE
X-MICROSOFT-CDO-IMPORTANCE:1
X-MICROSOFT-CDO-INSTTYPE:0
X-MICROSOFT-DONOTFORWARDMEETING:FALSE
X-MICROSOFT-DISALLOW-COUNTER:FALSE
END:VEVENT

[Glasfaser]

@matze-pe sagte in iCal - Events aus dem Exchange werden nicht mehr abgerufen:

calendar.ics

Veränderst du die geposteten Inhalte / Antworten , vorhin stand dort im Log iobroker.ics

und
ich meine du hast geschrieben ... ich habe eine andere ics genommen , dort wird alles eingelesen

[matze-pe]

@glasfaser

Ja hatte vorhin das log mit der PID angepasst, ein public Google Kalender ging.

[matze-pe]

Die beiden Cache Dateien werden auch heruntergeladen in der Verzeichnis /opt/iobroker/node_modules/iobroker.ical/

Ich habe die Cache Files mal bei https://icalendar.org/validator.html hochgeladen, da werden mir 230x Errors ausgegeben (alle den gleichen Inhalt, nur andere Zeilen):

Invalid TZID value or missing VTIMEZONE component ("(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien") near line # 79Reference: 3.2.19. Time Zone Identifier
Invalid TZID value or missing VTIMEZONE component ("(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien") near line # 79Reference: 3.2.19. Time Zone Identifier
Invalid TZID value or missing VTIMEZONE component ("(UTC+01:00) Amsterdam, Berlin, Bern, Rom, Stockholm, Wien") near line # 103Reference: 3.2.19. Time Zone Identifier 

Aber das ist ja eine Zeitzone die vom Exchange oder vom Outlook kommmt.
Einen Ausschnitt aus der ICS Datei hatte ich 3 Post darüber mal angehangen. https://forum.iobroker.net/post/801427

Kann damit der ICAL Adapter Probleme haben?

Ich kann meine ICS Datei gerne per PN zur Verfügung stellen.

[matze-pe]

Guten Morgen,

seit einigen Tagen liest er zumindest den Kalender meiner Frau wieder ein, habe mir gerade mal das Debug Log angesehen. Ich bin davon ausgegangen, wenn ich auswähle "21 Tage" die Cal Daten abrufen, dass er auch nur die verarbeitet.
Im Log sind jetzt alle enthalten, meine Kalender Daten werden am anfang auch eingelesen, aber nicht verarbeitet. Mein Kalender ist noch größer, als der von meiner Frau.

Ich habe das Log mal hochgeladen, da es als Text zu Lang war:
log_kalender.txt

edit: Unter Log "Info" steht, es wird nur der Kalender meiner Frau verarbeitet:
Wenn ich die URL aus meinem Kalender nehme, wird sie heruntergeladen (87KB)

ical.0	2022-05-23 06:47:59.220	info	Terminated (NO_ERROR): Without reason
ical.0	2022-05-23 06:47:54.074	info	processing URL: Caro https://mail........../calendar.ics
ical.0	2022-05-23 06:47:53.599	info	starting. Version 1.12.1 in /opt/iobroker/node_modules/iobroker.ical, node: v16.14.2, js-controller: 4.0.23

MOD-EDIT: private Daten entfernt

[Glasfaser]

@matze-pe

Bitte deine Kalender URL unkenntlich machen !

EDIT:

und dein log_kalender.txt enthält Private Daten !

[Glasfaser]

@matze-pe sagte in iCal - Events aus dem Exchange werden nicht mehr abgerufen:

node: v16.14.2

Mit deinem Ical per Exchange kann ich dir leider nicht mehr helfen ,
aber ist dein System sauber installiert , Empfohlen ist Node 14 / NPM 6

[matze-pe]

@glasfaser said in iCal - Events aus dem Exchange werden nicht mehr abgerufen:

Empfohlen ist Node 14 / NPM 6

Danke für den Tipp. Ich habe nodejs deinstalliert und mit Version 14.19. neu installiert, NPM ist 6.14.17.
Wird nur ein Kalender abgerufen.

Wenn jemand Interesse an meiner ICS Datei vom Exchange 2019 hat, kann er sich gerne bei mir melden dann stelle ich sie per PN bereit.

ical.0	2022-05-23 10:17:57.324	info	Terminated (NO_ERROR): Without reason
ical.0	2022-05-23 10:17:52.081	info	processing URL: Caro https://mail.xxxxxx.de/owa/calendar/c0e6cc2e31414bdbb97884913f16fcc1@xxxxxx.de/0372ae6441fc4accac5f951210ec990d7499262095505457187/calendar.ics
ical.0	2022-05-23 10:17:51.524	info	starting. Version 1.12.1 in /opt/iobroker/node_modules/iobroker.ical, node: v14.19.3, js-controller: 4.0.23

[Glasfaser]

@matze-pe sagte in iCal - Events aus dem Exchange werden nicht mehr abgerufen:

Wird nur ein Kalender abgerufen.

freut mich das es wieder funktioniert.

Bitte noch das log_kalender.txt löschen

Dann kannst du ja den Thread auf [gelöst] setzen !?

[Homoran]

@glasfaser sagte in iCal - Events aus dem Exchange werden nicht mehr abgerufen:

Bitte noch das log_kalender.txt löschen

DONE!

[matze-pe]

@homoran

Es ist leider nicht gelöst, ich habe zwei Exchange Kalender. Den von meiner Frau und meinen.
Es wird nur einer abgerufen (der von meiner Frau), in dem großen Debug Log finde ich keinen Fehler.

Wenn jemand interesse an meiner ICS Datei hat (die nicht verarbeitet wird), dann kann ich die gerne per PN zur Verfügung stellen.

[matze-pe]

gelöst, es gab vor einigen Monaten mal Probleme mit der Zeitzone.
Da habe ich unseren beiden Kalender auf UTC-0 gestellt, dann waren Anfang des Jahres die Einträge in der richtigen Zeit drin.
Habe sie jetzt wieder auf "Berlin" gesetzt und neugestartet und zack waren beiden Kalender wieder da.

Jetzt kann geschlossen werden, danke an alle

[Glasfaser]

@matze-pe sagte in iCal - Events aus dem Exchange werden nicht mehr abgerufen:

und zack waren beiden Kalender wieder da.

Schön das du den Fehler gefunden hast ...

Jetzt kann geschlossen werden, danke an alle

Den Titel ändern mit [gelöst]
Im Startbeitrag gehen und bei den 3 Punkten kannst du es ändern
.