I have now a test environment for caldav io, based on a Radicale installation. Everything seems fine, a trigger for a switch is properly executed:
2016-08-09 21:16:11.712 [DEBUG] [o.o.i.c.i.job.EventReloaderJob] - loading events for config: test
2016-08-09 21:16:11.849 [DEBUG] [o.o.i.c.i.job.EventReloaderJob] - loading resource: /mit/calendar.ics/aea75ad6-ff4f-4b14-9629-ee77fce0b745.1470769828461.ics
2016-08-09 21:16:12.064 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - begin timer scheduled for event 'aea75ad6-ff4f-4b14-9629-ee77fce0b745.1470769828461(Ausschalten @09.08.2016/21:18-09.08.2016/22:18)' @ Tue Aug 09 21:18:00 CEST 2016
2016-08-09 21:16:12.066 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - end timer scheduled for event 'aea75ad6-ff4f-4b14-9629-ee77fce0b745.1470769828461(Ausschalten @09.08.2016/21:18-09.08.2016/22:18)' @ Tue Aug 09 22:18:00 CEST 2016
2016-08-09 21:16:12.099 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - return event list for CalDavQuery [calendarIds=[test], from=2016-08-09T21:16:12.098+02:00, to=null, sort=null] with 1 entries
2016-08-09 21:18:00.015 [INFO ] [o.caldav.internal.job.EventJob] - event BEGIN for: aea75ad6-ff4f-4b14-9629-ee77fce0b745.1470769828461(Ausschalten @09.08.2016/21:18-09.08.2016/22:18)
2016-08-09 21:18:00.083 [DEBUG] [m.r.internal.engine.RuleEngine] - Executing rule 'mapdbTestRule'
2016-08-09 21:18:00.085 [DEBUG] [.p.m.i.MapDBPersistenceService] - store called for mapdbTest
2016-08-09 21:18:00.093 [INFO ] [org.openhab.model.script.demo ] - mapdbTest is OFF
2016-08-09 21:18:00.096 [DEBUG] [.p.m.i.MapDBPersistenceService] - Stored 'mapdbTest' with state 'OFF' in mapdb database
2016-08-09 21:18:00.098 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - return event list for CalDavQuery [calendarIds=[test], from=2016-08-09T21:18:00.098+02:00, to=null, sort=null] with 1 entries
But in my test i added then another trigger for switching on again and here is the log
2016-08-09 21:26:11.712 [DEBUG] [o.o.i.c.i.job.EventReloaderJob] - loading events for config: test
2016-08-09 21:26:11.841 [DEBUG] [o.o.i.c.i.job.EventReloaderJob] - loading resource: /mit/calendar.ics/08a76005-9c5d-4aaa-a404-124dc949f676.1470770441365.ics
2016-08-09 21:26:11.951 [INFO ] [o.caldav.internal.job.EventJob] - event BEGIN for: 08a76005-9c5d-4aaa-a404-124dc949f676.1470770441365(Wieder an@09.08.2016/21:21-09.08.2016/22:21)
2016-08-09 21:26:11.952 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - begin timer scheduled for event '08a76005-9c5d-4aaa-a404-124dc949f676.1470770441365(Wieder an@09.08.2016/21:21-09.08.2016/22:21)' @ Tue Aug 09 21:21:00 CEST 2016
2016-08-09 21:26:11.954 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - end timer scheduled for event '08a76005-9c5d-4aaa-a404-124dc949f676.1470770441365(Wieder an@09.08.2016/21:21-09.08.2016/22:21)' @ Tue Aug 09 22:21:00 CEST 2016
2016-08-09 21:26:11.957 [DEBUG] [m.r.internal.engine.RuleEngine] - Executing rule 'mapdbTestRule'
2016-08-09 21:26:11.958 [DEBUG] [.p.m.i.MapDBPersistenceService] - store called for mapdbTest
2016-08-09 21:26:11.961 [DEBUG] [.p.m.i.MapDBPersistenceService] - Stored 'mapdbTest' with state 'ON' in mapdb database
2016-08-09 21:26:11.964 [INFO ] [org.openhab.model.script.demo ] - mapdbTest is ON
2016-08-09 21:26:11.966 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - return event list for CalDavQuery [calendarIds=[test], from=2016-08-09T21:26:11.965+02:00, to=null, sort=null] with 2 entries
2016-08-09 21:26:11.982 [DEBUG] [o.o.i.c.i.job.EventReloaderJob] - loading resource: /mit/calendar.ics/aea75ad6-ff4f-4b14-9629-ee77fce0b745.1470769828461.ics
2016-08-09 21:26:12.142 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - event is already in event map and newer -> delete the old one, reschedule timer
2016-08-09 21:26:12.146 [INFO ] [o.caldav.internal.job.EventJob] - event BEGIN for: aea75ad6-ff4f-4b14-9629-ee77fce0b745.1470769828461(Ausschalten @09.08.2016/21:18-09.08.2016/22:18)
2016-08-09 21:26:12.150 [DEBUG] [m.r.internal.engine.RuleEngine] - Executing rule 'mapdbTestRule'
2016-08-09 21:26:12.152 [DEBUG] [.p.m.i.MapDBPersistenceService] - store called for mapdbTest
2016-08-09 21:26:12.155 [DEBUG] [.p.m.i.MapDBPersistenceService] - Stored 'mapdbTest' with state 'OFF' in mapdb database
2016-08-09 21:26:12.156 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - return event list for CalDavQuery [calendarIds=[test], from=2016-08-09T21:26:12.156+02:00, to=null, sort=null] with 2 entries
2016-08-09 21:26:12.158 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - begin timer scheduled for event 'aea75ad6-ff4f-4b14-9629-ee77fce0b745.1470769828461(Ausschalten @09.08.2016/21:18-09.08.2016/22:18)' @ Tue Aug 09 21:18:00 CEST 2016
2016-08-09 21:26:12.158 [INFO ] [org.openhab.model.script.demo ] - mapdbTest is OFF
2016-08-09 21:26:12.161 [DEBUG] [.i.c.internal.CalDavLoaderImpl] - end timer scheduled for event 'aea75ad6-ff4f-4b14-9629-ee77fce0b745.1470769828461(Ausschalten @09.08.2016/21:18-09.08.2016/22:18)' @ Tue Aug 09 22:18:00 CEST 2016
The new trigger is found first and scheduled (even if already past, which is great and appreciated) but then the first trigger is found again and rescheduled, switch is immediately turned off again. This game is replayed every 10 minutes - ON - OFF
Works as designed? Am i doing something wrong? How do i get a trigger that was already executed deleted?
Cheers, Michael