[SOLVED] CalDav no Events Found

It looks like I’m really close, I’ve installed CalDAV Personal and CalDAV Command (1.11.0). Running on a Raspberry PI in docker w/ latest raspbian OS.

I can see a pile of ICS files in /opt/openhab/userdata/etc/caldav/google but I am getting the following messages in events.log:

2018-06-05 23:42:54.085 [vent.ItemStateChangedEvent] - OfficeCalName0 changed from NULL to UNDEF
2018-06-05 23:42:54.094 [vent.ItemStateChangedEvent] - OfficeCalTime0 changed from NULL to UNDEF
2018-06-05 23:42:54.122 [vent.ItemStateChangedEvent] - OfficeCalName1 changed from NULL to UNDEF
2018-06-05 23:42:54.145 [vent.ItemStateChangedEvent] - OfficeCalTime1 changed from NULL to UNDEF
2018-06-05 23:42:54.168 [vent.ItemStateChangedEvent] - OfficeCalName2 changed from NULL to UNDEF
2018-06-05 23:42:54.189 [vent.ItemStateChangedEvent] - OfficeCalTime2 changed from NULL to UNDEF
2018-06-05 23:42:54.211 [vent.ItemStateChangedEvent] - OfficeCalName3 changed from NULL to UNDEF
2018-06-05 23:42:54.234 [vent.ItemStateChangedEvent] - OfficeCalTime3 changed from NULL to UNDEF

Here’s the ICS files:

root@raspberrypi:~# cd /opt/openhab/userdata/etc/caldav/google/
root@raspberrypi:/opt/openhab/userdata/etc/caldav/google# ls
040000008200E00074C5B7101A82E0080000000010634E4A2EA6CD010000000000000000100000004EADE5705FE6D743836FD0048E24C0EC.ics  4E444018F1034A2A88061F39BB0C28C40.ics	 DB8396EE591E4F6EBAB7EFA49103F12E0.ics
040000008200E00074C5B7101A82E0080000000090453AD7BB67D001000000000000000010000000B7F3CD1BC2BAD34EA7DBB9B449AD5B34.ics  559081bf-411b-47c4-a512-c1bd6e4eb823.ics	 e44qne27qtbh3ggq5u8enoopgc_google_com.ics
040000008200E00074C5B7101A82E00800000000F076EE2C724CCC0100000000000000001000000006341BADEDB2464DAB111E8726640135.ics  791fnm7q5a9hvbgb7i04ddi8ig_google_com.ics  F71E8134-B68A-4079-B2EA-2F84D08B3B15.ics
07263EC7-D06A-466C-9741-3808FD98F8F5.ics									      8075966727062.ics				 ff395ee7-3218-41b9-ac18-7464afe3dfaf.ics
136f86ai3s9pf6b6l6ivpukflo_google_com.ics									      8079680296470.ics				 h87h235e0rri2qpkf7tc30um08_google_com.ics
17usf0br7bt3gudjh4g8odtbpe_google_com.ics									      86bov9pfkne02hmp26k6v3l7d0_google_com.ics  i8e4gmfs2kt7nj5tfj7sjnj250_google_com.ics
2276d6e3-71ae-4907-9389-6ae406cf5bb5.ics									      991283633.ics				 mkvk3ho2j4k1vp4pa3hhe3m0r8_google_com.ics
257501b8-0b3b-4c8c-8413-12705d738770.ics									      ct1enihigpm8cevjt5155ijb70_google_com.ics  tk6725lctkbkkng3hleam7h4ro_google_com.ics
4182720EB7B548898F99A6F064D27D710.ics									

I thought I enabled TRACE, but I don’t see anything in the logs indicating any verbose troubleshooting information.

openhab> log:list
Logger                                             │ Level
───────────────────────────────────────────────────┼──────
ROOT                                               │ WARN
javax.jmdns                                        │ ERROR
org.apache.karaf.jaas.modules.audit                │ INFO
org.apache.karaf.kar.internal.KarServiceImpl       │ ERROR
org.apache.karaf.shell.support                     │ OFF
org.eclipse.smarthome                              │ INFO
org.jupnp                                          │ ERROR
org.openhab                                        │ INFO
org.openhab.binding.caldav_personal                │ TRACE
org.openhab.caldavPersonal                         │ TRACE
org.openhab.caldavio                               │ TRACE
org.openhab.io.caldav.CalDavLoader                 │ TRACE

openhab.log file

2018-06-05 23:52:44.222 [DEBUG] [ldav_personal.internal.CalDavBinding] - calendar reloaded: google
2018-06-05 23:52:44.223 [DEBUG] [ldav_personal.internal.CalDavBinding] - no event found for OfficeCalName0, setting to UNDEF
2018-06-05 23:52:44.227 [DEBUG] [ldav_personal.internal.CalDavBinding] - no event found for OfficeCalName2, setting to UNDEF
2018-06-05 23:52:44.235 [DEBUG] [ldav_personal.internal.CalDavBinding] - no event found for OfficeCalName1, setting to UNDEF
2018-06-05 23:52:44.240 [DEBUG] [ldav_personal.internal.CalDavBinding] - no event found for OfficeCalName3, setting to UNDEF
2018-06-05 23:52:44.244 [DEBUG] [ldav_personal.internal.CalDavBinding] - no event found for OfficeCalTime0, setting to UNDEF
2018-06-05 23:52:44.248 [DEBUG] [ldav_personal.internal.CalDavBinding] - no event found for OfficeCalTime2, setting to UNDEF
2018-06-05 23:52:44.252 [DEBUG] [ldav_personal.internal.CalDavBinding] - no event found for OfficeCalTime1, setting to UNDEF
2018-06-05 23:52:44.256 [DEBUG] [ldav_personal.internal.CalDavBinding] - no event found for OfficeCalTime3, setting to UNDEF

Here’s my items file:

String 		OfficeCalName0	"[%s]"					{ caldavPersonal="calendar:'google' type:'EVENT' eventNr:'1' value:'NAME'" } //eventNr for concurrent events
DateTime 	OfficeCalTime0	"Starts [%1$tT, %1$td.%1$tm.%1$tY]"	{ caldavPersonal="calendar:'google' type:'EVENT' eventNr:'1' value:'START'" } //eventNr for concurrent events
String 		OfficeCalName1	"Tomorrow [%s]"				{ caldavPersonal="calendar:'google' type:'EVENT' eventNr:'1' value:'NAME'" }
DateTime 	OfficeCalTime1	"Starts [%1$tT, %1$td.%1$tm.%1$tY]"	{ caldavPersonal="calendar:'google' type:'EVENT' eventNr:'1' value:'START'" }
String 		OfficeCalName2	"Day AFter [%s]" 			{ caldavPersonal="calendar:'google' type:'EVENT' eventNr:'2' value:'NAME'" }
DateTime 	OfficeCalTime2	"Starts [%1$tT, %1$td.%1$tm.%1$tY]" 	{ caldavPersonal="calendar:'google' type:'EVENT' eventNr:'2' value:'START'" }
String          OfficeCalName3  "Day AFter [%s]"                        { caldavPersonal="calendar:'google' type:'EVENT' eventNr:'3' value:'NAME'" }
DateTime        OfficeCalTime3  "Starts [%1$tT, %1$td.%1$tm.%1$tY]"     { caldavPersonal="calendar:'google' type:'EVENT' eventNr:'3' value:'START'" }

caldavio.cfg file


caldavio:google:url=https://www.google.com/calendar/dav/xxxx@gmail.com/events
caldavio:google:username=testuser
caldavio:google:password=password
caldavio:google:reloadInterval=2
caldavio:google:preloadTime=2
caldavio:google:disableCertificateVerification=true

caldavPersonal.cfg

caldavPersonal:usedCalendars=google
caldavPersonal:homeIdentifiers=google

caldavCommand.cfg

caldavCommand:readCalendars=google

I’ve deleted all the *.config files in the userdata folder. I’ve also deleted the ICS files and they repopulate on the next job run.

Any idea what I’m missing?

thanks!