[horde] CalDAV Mac OS large number of sessions

[Mark Holmes]

I'm using Mac OS Lion 10.8.4 and have configured Horde 5.1.1 with Caldav support.

When using IOS I see one session in the Horde list of current sessions and this remains at 1 for each calendar refresh.

When using the Desktop calendar on the Mac It uses 12 sessions per refresh of the calendar. So the total session count
increases by 12 for each refresh, on and on until there are thousands and thousands of sessions. I could certainly see this
being problematic with many users refreshing their calendars automatically every minute. :-)

Now this may very well be an Apple problem but I'd like to know if anyone else sees this same behavior.

I'm posting the log entries for an IOS calendar refresh and Mac desktop calendar refresh below

os refresh 1 opens 1 session in horde session list

xx.x.xxx.xxx - - [24/Jun/2013:16:05:05 -0400] "PROPFIND /rpc.php/calendars/testuser/ HTTP/1.1" 401 213
xx.x.xxx.xxx - testuser [24/Jun/2013:16:05:06 -0400] "PROPFIND /rpc.php/calendars/testuser/ HTTP/1.1" 207 757
xx.x.xxx.xxx - testuser [24/Jun/2013:16:05:07 -0400] "PROPPATCH /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 305
xx.x.xxx.xxx - - [24/Jun/2013:16:05:08 -0400] "PROPPATCH /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 401 213
xx.x.xxx.xxx - testuser [24/Jun/2013:16:05:09 -0400] "PROPPATCH /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 310
xx.x.xxx.xxx - testuser [24/Jun/2013:16:05:10 -0400] "PROPFIND /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 241
xx.x.xxx.xxx - testuser [24/Jun/2013:16:05:11 -0400] "PROPFIND /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 241
xx.x.xxx.xxx - - [24/Jun/2013:16:05:12 -0400] "PROPFIND /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 401 213
xx.x.xxx.xxx - testuser [24/Jun/2013:16:05:12 -0400] "PROPFIND /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 237
xx.x.xxx.xxx - testuser [24/Jun/2013:16:05:13 -0400] "REPORT /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 437

2nd session uses same session as first

xx.x.xxx.xxx - - [24/Jun/2013:16:06:47 -0400] "PROPFIND /rpc.php/calendars/testuser/ HTTP/1.1" 401 213
xx.x.xxx.xxx - testuser [24/Jun/2013:16:06:47 -0400] "PROPFIND /rpc.php/calendars/testuser/ HTTP/1.1" 207 757
xx.x.xxx.xxx - - [24/Jun/2013:16:06:48 -0400] "PROPPATCH /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 401 213
xx.x.xxx.xxx - testuser [24/Jun/2013:16:06:49 -0400] "PROPPATCH /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 310
xx.x.xxx.xxx - - [24/Jun/2013:16:06:50 -0400] "PROPPATCH /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 401 213
xx.x.xxx.xxx - testuser [24/Jun/2013:16:06:51 -0400] "PROPPATCH /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 305
xx.x.xxx.xxx - testuser [24/Jun/2013:16:06:51 -0400] "PROPFIND /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 237
xx.x.xxx.xxx - testuser [24/Jun/2013:16:06:52 -0400] "REPORT /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 436
xx.x.xxx.xxx - testuser [24/Jun/2013:16:06:53 -0400] "PROPFIND /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 241
xx.x.xxx.xxx - testuser [24/Jun/2013:16:06:54 -0400] "PROPFIND /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 241

Mac calendar desktop uses 12 sessions to horde

yy.yy.yy.yyy - - [24/Jun/2013:16:09:38 -0400] "PROPFIND /rpc.php/calendars/testuser/ HTTP/1.1" 401 213
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:39 -0400] "PROPFIND /rpc.php/calendars/testuser/ HTTP/1.1" 207 757
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:40 -0400] "PROPPATCH /rpc.php/calendars/testuser/ HTTP/1.1" 207 269
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:42 -0400] "PROPPATCH /rpc.php/calendars/testuser/ HTTP/1.1" 207 271
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:43 -0400] "PROPPATCH /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 310
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:44 -0400] "PROPPATCH /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 295
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:45 -0400] "PROPPATCH /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 305
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:46 -0400] "PROPPATCH /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 291
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:47 -0400] "PROPFIND /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 241
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:49 -0400] "PROPFIND /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 241
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:50 -0400] "PROPFIND /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 237
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:51 -0400] "PROPFIND /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 441
yy.yy.yy.yyy - - [24/Jun/2013:16:09:52 -0400] "REPORT /rpc.php/principals/testuser/ HTTP/1.1" 401 213
yy.yy.yy.yyy - testuser [24/Jun/2013:16:09:53 -0400] "REPORT /rpc.php/principals/testuser/ HTTP/1.1" 207 284

Next mac desktop calendar refresh uses an additional 12 sessions so 24 sessions total for the mac desktop calendar

yy.yy.yy.yyy - - [24/Jun/2013:16:11:46 -0400] "PROPFIND /rpc.php/calendars/testuser/ HTTP/1.1" 401 213
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:47 -0400] "PROPFIND /rpc.php/calendars/testuser/ HTTP/1.1" 207 757
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:48 -0400] "PROPPATCH /rpc.php/calendars/testuser/ HTTP/1.1" 207 269
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:49 -0400] "PROPPATCH /rpc.php/calendars/testuser/ HTTP/1.1" 207 271
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:50 -0400] "PROPPATCH /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 310
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:51 -0400] "PROPPATCH /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 295
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:53 -0400] "PROPPATCH /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 305
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:54 -0400] "PROPPATCH /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 291
yy.yy.yy.yyy - - [24/Jun/2013:16:11:54 -0400] "POST /services/ajax.php/horde/topbarUpdate HTTP/1.1" 200 216
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:55 -0400] "PROPFIND /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 241
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:57 -0400] "PROPFIND /rpc.php/calendars/testuser/tasks%3aNM_fJkfwrKaZFHEbQrHwiA1/ HTTP/1.1" 207 241
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:58 -0400] "PROPFIND /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 237
yy.yy.yy.yyy - testuser [24/Jun/2013:16:11:59 -0400] "PROPFIND /rpc.php/calendars/testuser/calendar%3aRC4DknCsRJR7hkh4ETP-2g1/ HTTP/1.1" 207 441
yy.yy.yy.yyy - - [24/Jun/2013:16:12:01 -0400] "REPORT /rpc.php/principals/testuser/ HTTP/1.1" 401 213
yy.yy.yy.yyy - testuser [24/Jun/2013:16:12:02 -0400] "REPORT /rpc.php/principals/testuser/ HTTP/1.1" 207 284