[horde] Testing CALDAV

Klaus Steinberger klaus.steinberger at Physik.Uni-Muenchen.DE
Tue May 14 10:36:46 UTC 2013 

Hi,

I try to test CALDAV on the new Horde Beta, but found some weird things:

1)  Opening the principals for all users needs too long time.

	in horde.log we see a database request for any user in the site, like this:

2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] Hook prefs_init in application
horde called. [pid 23335 on line 1137 of "/usr/share/pear/Horde.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] Load config file (prefs.php;
app: horde) [pid 23335 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] SQL  (0,0014s)
        SELECT pref_name, pref_value FROM horde_prefs WHERE pref_uid =
          'cyrus-admin' AND pref_scope = 'horde' [pid 23335 on line 558 of
"/usr/share/pear/Horde/Db/Adapter/Base.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] Hook prefs_init in application
horde called. [pid 23335 on line 1137 of "/usr/share/pear/Horde.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] Load config file (prefs.php;
app: horde) [pid 23335 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] SQL  (0,0004s)
        SELECT pref_name, pref_value FROM horde_prefs WHERE pref_uid =
          'git-heuss' AND pref_scope = 'horde' [pid 23335 on line 558 of
"/usr/share/pear/Horde/Db/Adapter/Base.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] Hook prefs_init in application
horde called. [pid 23335 on line 1137 of "/usr/share/pear/Horde.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] Load config file (prefs.php;
app: horde) [pid 23335 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] SQL  (0,0023s)
        SELECT pref_name, pref_value FROM horde_prefs WHERE pref_uid =
          'git-thaiss' AND pref_scope = 'horde' [pid 23335 on line 558 of
"/usr/share/pear/Horde/Db/Adapter/Base.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] Hook prefs_init in application
horde called. [pid 23335 on line 1137 of "/usr/share/pear/Horde.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] Load config file (prefs.php;
app: horde) [pid 23335 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:19:53+02:00 DEBUG: HORDE [horde] SQL  (0,0024s)
        SELECT pref_name, pref_value FROM horde_prefs WHERE pref_uid =
          'git-huy' AND pref_scope = 'horde' [pid 23335 on line 558 of
"/usr/share/pear/Horde/Db/Adapter/Base.php"]


This needs nearly endless on a site with 4k Users.

2)
	Opening my own principal returns the following:

2013-05-14T12:30:45+02:00 DEBUG: HORDE Load config file (conf.php; app: horde)
[pid 23201 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Load config file (hooks.php; app:
horde) [pid 23201 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Connected to the following memcache
servers:localhost:11211 [pid 23201 on line 125 of
"/usr/share/pear/Horde/Memcache.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Read session data (id =
e7jmb7ad921gidhfv5dcb669o1) [pid 23201 on line 177 of
"/usr/share/pear/Horde/SessionHandler.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Horde_Registry: retrieved app with
cache ID horde_registry|app|1368000053|652bacee7c6059e8fdae16cea2caad35 [pid
23201 on line 1986 of "/usr/share/pear/Horde/Registry.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [imp] Load config file (nls.php; app:
horde) [pid 23201 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [imp] Load config file (conf.php; app:
imp) [pid 23201 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [horde] Horde_Rpc::__construct complete
[pid 23201 on line 45 of "/usr/share/pear/Horde/Rpc/Webdav.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [horde] Horde_Rpc::authorize() starting
[pid 23201 on line 133 of "/var/www/html/horde/rpc.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [horde] Hook preauthenticate in
application horde called. [pid 23201 on line 1137 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [horde] SQL  (0,0003s)
        DELETE FROM horde_histories WHERE object_uid IN
          ('klaus.steinberger at logins.failed') [pid 23201 on line 558 of
"/usr/share/pear/Horde/Db/Adapter/Base.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [gollem] Load config file (conf.php;
app: gollem) [pid 23201 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [ingo] Load config file (conf.php; app:
ingo) [pid 23201 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [horde] Max memory usage: 19660800
bytes [pid 23201 on line 558 of "/usr/share/pear/Horde/Registry.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [horde] Wrote session data (id =
e7jmb7ad921gidhfv5dcb669o1) [pid 23201 on line 199 of
"/usr/share/pear/Horde/SessionHandler.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Load config file (conf.php; app: horde)
[pid 23205 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Load config file (hooks.php; app:
horde) [pid 23205 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Connected to the following memcache
servers:localhost:11211 [pid 23205 on line 125 of
"/usr/share/pear/Horde/Memcache.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Read session data (id =
e7jmb7ad921gidhfv5dcb669o1) [pid 23205 on line 177 of
"/usr/share/pear/Horde/SessionHandler.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE Horde_Registry: retrieved app with
cache ID horde_registry|app|1368000053|652bacee7c6059e8fdae16cea2caad35 [pid
23205 on line 1986 of "/usr/share/pear/Horde/Registry.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [imp] Load config file (nls.php; app:
horde) [pid 23205 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:45+02:00 DEBUG: HORDE [imp] Load config file (conf.php; app:
imp) [pid 23205 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:46+02:00 DEBUG: HORDE [horde] Horde_Rpc::__construct complete
[pid 23205 on line 45 of "/usr/share/pear/Horde/Rpc/Webdav.php"]
2013-05-14T12:30:46+02:00 DEBUG: HORDE [horde] Horde_Rpc::authorize() starting
[pid 23205 on line 133 of "/var/www/html/horde/rpc.php"]
2013-05-14T12:30:46+02:00 DEBUG: HORDE [horde] Hook preauthenticate in
application horde called. [pid 23205 on line 1137 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:46+02:00 DEBUG: HORDE [horde] SQL  (0,0004s)
        DELETE FROM horde_histories WHERE object_uid IN
          ('klaus.steinberger at logins.failed') [pid 23205 on line 558 of
"/usr/share/pear/Horde/Db/Adapter/Base.php"]
2013-05-14T12:30:46+02:00 DEBUG: HORDE [gollem] Load config file (conf.php;
app: gollem) [pid 23205 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:46+02:00 DEBUG: HORDE [ingo] Load config file (conf.php; app:
ingo) [pid 23205 on line 401 of "/usr/share/pear/Horde.php"]
2013-05-14T12:30:46+02:00 DEBUG: HORDE [horde] Max memory usage: 19660800
bytes [pid 23205 on line 558 of "/usr/share/pear/Horde/Registry.php"]
2013-05-14T12:30:46+02:00 DEBUG: HORDE [horde] Wrote session data (id =
e7jmb7ad921gidhfv5dcb669o1) [pid 23205 on line 199 of "/usr/share/pear/Horde
/SessionHandler.php"]

looks like it has some trouble with the username? No principals are shown in
the principal folder, IOS says it can't check the account, but shows calendar
entries, but new calender entries created are not saved on the horde server.

Sincerly,
Klaus

-- 
Rechnerbetriebsgruppe / IT, Fakultät für Physik
Klaus Steinberger
FAX: +49 89 28914280
Tel: +49 89 28914287

More information about the horde mailing list