ICal-Adapter verschluckt Event?

chris10

Hallo

Habe ICS Abfalltermine (siehe Anhang) bei denen Start- und Endzeit ident sind. Aus irgendwelchen Gründen verschluck der iCal-Adapter diese.

z.B.:

Start 01.03.18 07:00

Ende 01.03.18 07:00

dies Funktioniert:

Start 01.03.18 07:00

Ende 01.03.18 07:01

Irgend jemand eine Idee woran das liegen kann

(ICal-Adapter Version 1.4.0)

LG Chris

apollon77

Stell mal das Logging auf Debug (Instanzen -> Experteneinstellungen -> Spalte Loglevel) und schau was das log sagt bzw poste es /schicke es mir als PN

chris10

wird etwas dauern - bin nicht vor Ort

LG

chris10

Habe 3 Termine angelegt (2Termine werden übernommen - Endzeit +1 und +5)

siehe Termine.PNG

hier das Log-File

! host.Broker 2018-02-01 10:57:39.523 info instance system.adapter.ical.1 terminated with code 0 (OK)
! ical.1 2018-02-01 10:57:33.937 debug todayOnly = false: (Thu Mar 08 2018 07:00:00 GMT+0100 (CET)-Thu Mar 08 2018 07:05:00 GMT+0100 (CET)), alreadyStarted=false
! ical.1 2018-02-01 10:57:33.936 debug todayOnly = false: (Wed Mar 07 2018 07:00:00 GMT+0100 (CET)-Wed Mar 07 2018 07:01:00 GMT+0100 (CET)), alreadyStarted=false
! ical.1 2018-02-01 10:57:33.935 debug displaying dates because of callback
! ical.1 2018-02-01 10:57:33.934 debug Event with time added: " " Bioabfall + 1 Min at 07.03.2018 07:00-07:01
! ical.1 2018-02-01 10:57:33.932 debug todayOnly = false: (Wed Mar 07 2018 07:00:00 GMT+0100 (CET)-Wed Mar 07 2018 07:01:00 GMT+0100 (CET)), alreadyStarted=false
! ical.1 2018-02-01 10:57:33.930 debug Event with time added: " " Bioabfall + 5 Min at 08.03.2018 07:00-07:05
! ical.1 2018-02-01 10:57:33.928 debug todayOnly = false: (Thu Mar 08 2018 07:00:00 GMT+0100 (CET)-Thu Mar 08 2018 07:05:00 GMT+0100 (CET)), alreadyStarted=false
! ical.1 2018-02-01 10:57:33.926 debug {"040000008200E00074C5B7101A82E00800000000F0DCB3BF499BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4":{"type":"VEVENT","params":[],"start":"2018-03-08T06:00:00.000Z","end":"2018-03-08T06
! ical.1 2018-02-01 10:57:33.926 info processing URL: test https://calendar.google.com/calendar/ic … /basic.ics
! ical.1 2018-02-01 10:57:33.548 debug reading calendar from URL: https://calendar.google.com/calendar/ic ... /basic.ics, color: undefined
! ical.1 2018-02-01 10:57:32.763 info starting. Version 1.4.0 in /opt/iobroker/node_modules/iobroker.ical, node: v6.12.3
! host.Broker 2018-02-01 10:57:30.281 info instance system.adapter.ical.1 started with pid 2290
! host.Broker 2018-02-01 10:57:30.253 info instance scheduled system.adapter.ical.1 0,30 * * * *

Danke

LG
5647_termine.png

apollon77

puste mal die Debug Daten direkt aus dem Logfile bitte - wenn du es aus der Log-Ansixcht im Admin kopierst sind Zeilen abgeschnitten.

File sollte unter /opt/iobroker/log/… liegen.

Vor allem interessant istdie Zeile mit

ical.1 2018-02-01 10:57:33.926 debug {"040000008200E00074C5B ....

chris10

Bitteschön

! 2018-02-01 10:57:30.281 - [32minfo[39m: host.Broker instance system.adapter.ical.1 started with pid 2290
! 2018-02-01 10:57:32.611 - [34mdebug[39m: ical.1 objectDB connected
! 2018-02-01 10:57:32.664 - [34mdebug[39m: ical.1 statesDB connected
! 2018-02-01 10:57:32.676 - [32minfo[39m: ical.1 States connected to redis: 127.0.0.1:6379
! 2018-02-01 10:57:32.739 - [32minfo[39m: ical.1 starting. Version 1.4.0 in /opt/iobroker/node_modules/iobroker.ical, node: v6.12.3
! 2018-02-01 10:57:33.151 - [34mdebug[39m: ical.1 reading calendar from URL: https://calendar.google.com/calendar/ic … /basic.ics, color: undefined
! 2018-02-01 10:57:33.890 - [32minfo[39m: ical.1 processing URL: test https://calendar.google.com/calendar/ic ... /basic.ics
! 2018-02-01 10:57:33.891 - [34mdebug[39m: ical.1 {"040000008200E00074C5B7101A82E00800000000F0DCB3BF499BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4":{"type":"VEVENT","params":[],"start":"2018-03-08T06:00:00.000Z","end":"2018-03-08T06:05:00.000Z","dtstamp":"2018-02-01T09:57:33.000Z","uid":"040000008200E00074C5B7101A82E00800000000F0DCB3BF499BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4","class":"PUBLIC","created":"2017-12-20T09:54:36.000Z","description":"","lastmodified":"2018-02-01T09:51:25.000Z","location":"","sequence":"0","status":"CONFIRMED","summary":"Bioabfall + 5 Min","transparency":"OPAQUE","MICROSOFT-CDO-BUSYSTATUS":"BUSY","MICROSOFT-CDO-IMPORTANCE":"1","MS-OLK-AUTOFILLLOCATION":"TRUE"},"040000008200E00074C5B7101A82E00800000000D00C61704A9BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4":{"type":"VEVENT","params":[],"start":"2018-03-07T06:00:00.000Z","end":"2018-03-07T06:01:00.000Z","dtstamp":"2018-02-01T09:57:33.000Z","uid":"040000008200E00074C5B7101A82E00800000000D00C61704A9BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4","class":"PUBLIC","created":"2017-12-20T09:54:36.000Z","description":"","lastmodified":"2018-02-01T09:51:25.000Z","location":"","sequence":"0","status":"CONFIRMED","summary":"Bioabfall + 1 Min","transparency":"OPAQUE","MICROSOFT-CDO-BUSYSTATUS":"BUSY","MICROSOFT-CDO-IMPORTANCE":"1","MS-OLK-AUTOFILLLOCATION":"TRUE"},"040000008200E00074C5B7101A82E00800000000B01A96D0309BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4":{"type":"VEVENT","params":[],"start":"2018-03-06T06:00:00.000Z","dtstamp":"2018-02-01T09:57:33.000Z","uid":"040000008200E00074C5B7101A82E00800000000B01A96D0309BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4","class":"PUBLIC","created":"2017-12-20T09:54:36.000Z","description":"","lastmodified":"2018-02-01T09:51:25.000Z","location":"","sequence":"0","status":"CONFIRMED","summary":"Bioabfall + 0 Min","transparency":"OPAQUE","MICROSOFT-CDO-BUSYSTATUS":"BUSY","MICROSOFT-CDO-IMPORTANCE":"1","MS-OLK-AUTOFILLLOCATION":"TRUE"}}
! 2018-02-01 10:57:33.900 - [34mdebug[39m: ical.1 todayOnly = false: (Thu Mar 08 2018 07:00:00 GMT+0100 (CET)-Thu Mar 08 2018 07:05:00 GMT+0100 (CET)), alreadyStarted=false
! 2018-02-01 10:57:33.902 - [34mdebug[39m: ical.1 Event with time added: " " Bioabfall + 5 Min at 08.03.2018 07:00-07:05
! 2018-02-01 10:57:33.903 - [34mdebug[39m: ical.1 todayOnly = false: (Wed Mar 07 2018 07:00:00 GMT+0100 (CET)-Wed Mar 07 2018 07:01:00 GMT+0100 (CET)), alreadyStarted=false
! 2018-02-01 10:57:33.903 - [34mdebug[39m: ical.1 Event with time added: " " Bioabfall + 1 Min at 07.03.2018 07:00-07:01
! 2018-02-01 10:57:33.904 - [34mdebug[39m: ical.1 displaying dates because of callback
! 2018-02-01 10:57:33.909 - [34mdebug[39m: ical.1 todayOnly = false: (Wed Mar 07 2018 07:00:00 GMT+0100 (CET)-Wed Mar 07 2018 07:01:00 GMT+0100 (CET)), alreadyStarted=false
! 2018-02-01 10:57:33.912 - [34mdebug[39m: ical.1 todayOnly = false: (Thu Mar 08 2018 07:00:00 GMT+0100 (CET)-Thu Mar 08 2018 07:05:00 GMT+0100 (CET)), alreadyStarted=false
! 2018-02-01 10:57:39.518 - [32minfo[39m: host.Broker instance system.adapter.ical.1 terminated with code 0 (OK)[/spoiler]

hier wäre noch das ICS-File

! BEGIN:VCALENDAR
! PRODID:-//Microsoft Corporation//Outlook 15.0 MIMEDIR//EN
! VERSION:2.0
! METHOD:PUBLISH
! X-CALSTART:20180306T060000Z
! X-CALEND:20180308T060500Z
! X-WR-RELCALID:{0000002E-7725-F37B-67E7-BCBFFA453CE0}
! X-WR-CALNAME:test (Nur dieser Computer) (2)
! BEGIN:VTIMEZONE
! TZID:W. Europe Standard Time
! BEGIN:STANDARD
! DTSTART:16011028T030000
! RRULE:FREQ=YEARLY;BYDAY=-1SU;BYMONTH=10
! TZOFFSETFROM:+0200
! TZOFFSETTO:+0100
! END:STANDARD
! BEGIN:DAYLIGHT
! DTSTART:16010325T020000
! RRULE:FREQ=YEARLY;BYDAY=-1SU;BYMONTH=3
! TZOFFSETFROM:+0100
! TZOFFSETTO:+0200
! END:DAYLIGHT
! END:VTIMEZONE
! BEGIN:VEVENT
! CLASS:PUBLIC
! CREATED:20171220T095518Z
! DTEND;TZID="W. Europe Standard Time":20180306T070000
! DTSTAMP:20171220T095436Z
! DTSTART;TZID="W. Europe Standard Time":20180306T070000
! LAST-MODIFIED:20180201T095040Z
! PRIORITY:5
! SEQUENCE:0
! SUMMARY:Bioabfall + 0 Min
! TRANSP:OPAQUE
! UID:040000008200E00074C5B7101A82E00800000000B01A96D0309BD301000000000000000
! 0100000001E1BE2592AC9D140A2090946B44246C4
! X-MICROSOFT-CDO-BUSYSTATUS:BUSY
! X-MICROSOFT-CDO-IMPORTANCE:1
! X-MS-OLK-AUTOFILLLOCATION:TRUE
! END:VEVENT
! BEGIN:VEVENT
! CLASS:PUBLIC
! CREATED:20171220T095518Z
! DTEND;TZID="W. Europe Standard Time":20180308T070500
! DTSTAMP:20171220T095436Z
! DTSTART;TZID="W. Europe Standard Time":20180308T070000
! LAST-MODIFIED:20180201T095008Z
! PRIORITY:5
! SEQUENCE:0
! SUMMARY:Bioabfall + 5 Min
! TRANSP:OPAQUE
! UID:040000008200E00074C5B7101A82E00800000000F0DCB3BF499BD301000000000000000
! 0100000001E1BE2592AC9D140A2090946B44246C4
! X-MICROSOFT-CDO-BUSYSTATUS:BUSY
! X-MICROSOFT-CDO-IMPORTANCE:1
! X-MS-OLK-AUTOFILLLOCATION:TRUE
! END:VEVENT
! BEGIN:VEVENT
! CLASS:PUBLIC
! CREATED:20171220T095518Z
! DTEND;TZID="W. Europe Standard Time":20180307T070100
! DTSTAMP:20171220T095436Z
! DTSTART;TZID="W. Europe Standard Time":20180307T070000
! LAST-MODIFIED:20180201T095031Z
! PRIORITY:5
! SEQUENCE:0
! SUMMARY:Bioabfall + 1 Min
! TRANSP:OPAQUE
! UID:040000008200E00074C5B7101A82E00800000000D00C61704A9BD301000000000000000
! 0100000001E1BE2592AC9D140A2090946B44246C4
! X-MICROSOFT-CDO-BUSYSTATUS:BUSY
! X-MICROSOFT-CDO-IMPORTANCE:1
! X-MS-OLK-AUTOFILLLOCATION:TRUE
! END:VEVENT
! END:VCALENDAR

apollon77

Das 0:00 hat kein "end" …

"040000008200E00074C5B7101A82E00800000000B01A96D0309BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4": {
        "type": "VEVENT",
        "params": [],
        "start": "2018-03-06T06:00:00.000Z",
        "dtstamp": "2018-02-01T09:57:33.000Z",
        "uid": "040000008200E00074C5B7101A82E00800000000B01A96D0309BD3010000000000000000100000001E1BE2592AC9D140A2090946B44246C4",
        "class": "PUBLIC",
        "created": "2017-12-20T09:54:36.000Z",
        "description": "",
        "lastmodified": "2018-02-01T09:51:25.000Z",
        "location": "",
        "sequence": "0",
        "status": "CONFIRMED",
        "summary": "Bioabfall + 0 Min",
        "transparency": "OPAQUE",
        "MICROSOFT-CDO-BUSYSTATUS": "BUSY",
        "MICROSOFT-CDO-IMPORTANCE": "1",
        "MS-OLK-AUTOFILLLOCATION": "TRUE"
    }

Events ohne start oder ohne end werden aktuell ignoriert.

Man könnte jetzt sagen "wenn end fehlt dann end=start …

Wenn man das will bitte auf Github dafür mal ein Issue aufmachen und den Thread referenzieren

chris10

Möchte hier auch keine Diskussion loslösen. Nachdem Google, MS, etc. dies zulassen könnte man annehmen dass dies seine Berechtigung hat.

Werde es dann in einem Issue hinterlegen.

Vielen Dank für die rasche Analyse!

Für mich vorerst - erledigt.

LG

apollon77

Bitte mal Version vom Github versuchen. Die kommt mit fehlenden "end" klar.

dontobi

Ich hänge mich auch Mal hier drunter. Denn mir ist beim ical auch ein Problem aufgefallen.

Ich werte das Event "Nachtschicht" aus. Der passende Termin geht von 22 Uhr bis 6 Uhr morgens am Folgetag. Bei mir ist dann das Event nur von 22 Uhr bis 0 Uhr auf true. Danach auf false.

Bug?

Gesendet von meinem ONEPLUS A5000 mit Tapatalk

apollon77

Gabs die gleiche Frage nicht in einem anderen thread?

Welche Version vom Adapter? Den Bug gab es mit ical <1.4 … nimm die 1.4.

Wenn dort immer noch dann muss man das debuggen.

dontobi

Ich hab das vergangene Woche erst getestet und die 1.4.0 drauf. Wie soll bzw. kann ich das denn debugen? Damit ich dir auch die nötigen Daten schicken kann.

Ich habe dann am Donnerstag eine Nachtschicht und könnte das dann testen.

apollon77

Am besten Adapter mit Debug Log laufen lassen zu einem Zeitpunkt wo das Event true sein sollte es aber nicht ist :-)

Debug -> Instanzen -> Expertenmodus -> Spalte "Loglevel".

Dann das Log schicken, ambesten aus dem Logfile unter /opt/iobroker/log/iobroker.log…

Und das dann am besten als Issue im Github (im notfall hier oder als PN)

dontobi

Okay. Dann richte ich das ein und schicke das im Fehlerfall.

Gesendet von meinem ONEPLUS A5000 mit Tapatalk

Community Forum

NEWS

ICal-Adapter verschluckt Event?

Support us

399

32.8k

82.8k

1.3m