[horde] horde3.2-alpha + memcached + session tracking
Majeed
mabuqu at ilstu.edu
Sat Aug 4 01:07:07 UTC 2007
Hey all,
I'm trying to setup horde to use memcached as my session handler. It
seems to work fine (i can log in successfully) if I set
$conf['sessionhandler']['params']['track'] = false;. When memcache
session tracking is set to true, I can't login. I would love to track
those memcache sessions.
Here is some version info.
apache: 2.2.3
PHP Version: 5.2.3
Memcached 1.2.0 (from coolstack
http://cooltools.sunsource.net/coolstack/) built for solaris 10 (sparc)
pear: memcache 2.1.0 stable
horde3.2-alpha
Does anyone know of any compatibility issues with the above versions or
anything I might be doing wrong?
Sorry about the wall of text below. Figured more info is better than less.
Thanks much for any suggestions,
Majeed
Here is a snip from the horde log. The time frame is the second I click
on the login button to when the page is finished loading (back at the
login page since I am not able to login). This is what happens when I
have session tracking enabled.
***********
Aug 03 19:39:16 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:39:16 HORDE [error] [horde] Error retrieving session data (id
= 316cb9c184c0ceec4cb137359b406f7f) [on line 88 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:16 HORDE [debug] [horde] Deleted session data (id =
316cb9c184c0ceec4cb137359b406f7f) [on line 165 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:16 HORDE [debug] [horde] SQL Query by
Auth_sql::_authenticate(): SELECT * FROM horde_users WHERE user_uid = ?
[on line 134 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Auth/sql.php"]
Aug 03 19:39:16 HORDE [debug] [horde] SQL Query by
Prefs_sql::retrieve(): SELECT pref_scope, pref_name, pref_value FROM
horde_prefs WHERE pref_uid = ? AND pref_scope = ?, values: mabuqu, horde
[on line 148 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Prefs/sql.php"]
Aug 03 19:39:16 HORDE [debug] [horde] Hook _prefs_change_hook_last_login
in application horde not called. [on line 1484 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde.php"]
Aug 03 19:39:16 HORDE [notice] [horde] Login success for mabuqu
[138.87.1.97] to Horde [on line 120 of
"/usr/local/webmail/horde-3.2-alpha/horde/login.php"]
Aug 03 19:39:16 HORDE [debug] [horde] SQL Query by Prefs_sql::store():
SELECT 1 FROM horde_prefs WHERE pref_uid = ? AND pref_name = ? AND
pref_scope = ?, values: mabuqu, last_login, horde [on line 210 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Prefs/sql.php"]
Aug 03 19:39:16 HORDE [debug] [horde] SQL Query by Prefs_sql::store():
UPDATE horde_prefs SET pref_value = ? WHERE pref_uid = ? AND pref_name =
? AND pref_scope = ?, values:
a:2:{s:4:"time";i:1186187956;s:4:"host";s:11:"138.87.1.97";}, mabuqu,
last_login, horde [on line 244 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Prefs/sql.php"]
Aug 03 19:39:17 HORDE [debug] [horde] Wrote session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:17 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:39:17 HORDE [debug] [horde] Read session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 93 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:17 HORDE [debug] [horde] Wrote session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:17 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:39:17 HORDE [error] [horde] Error retrieving session data (id
= 1e1b8983b5ee0ef79042ee4b53b42421) [on line 88 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:17 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:39:17 HORDE [error] [horde] Error retrieving session data (id
= 1e1b8983b5ee0ef79042ee4b53b42421) [on line 88 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:17 HORDE [debug] [] Guest user does not have READ
permission for horde [on line 777 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Registry.php"]
Aug 03 19:39:17 HORDE [debug] [] Wrote session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:18 HORDE [debug] [horde] Wrote session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:18 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:39:18 HORDE [error] [horde] Error retrieving session data (id
= 1e1b8983b5ee0ef79042ee4b53b42421) [on line 88 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:18 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:39:18 HORDE [error] [horde] Error retrieving session data (id
= 1e1b8983b5ee0ef79042ee4b53b42421) [on line 88 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:18 HORDE [debug] [horde] Wrote session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:18 HORDE [debug] [horde] Wrote session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:18 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:39:18 HORDE [error] [horde] Error retrieving session data (id
= 1e1b8983b5ee0ef79042ee4b53b42421) [on line 88 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:39:18 HORDE [debug] [horde] Wrote session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Then when I disable memcache session tracking, here is what a successful
login looks like.
***********************
Aug 03 19:43:35 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:43:35 HORDE [error] [horde] Error retrieving session data (id
= 1e1b8983b5ee0ef79042ee4b53b42421) [on line 88 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:35 HORDE [debug] [horde] Deleted session data (id =
1e1b8983b5ee0ef79042ee4b53b42421) [on line 165 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:35 HORDE [debug] [horde] SQL Query by
Auth_sql::_authenticate(): SELECT * FROM horde_users WHERE user_uid = ?
[on line 134 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Auth/sql.php"]
Aug 03 19:43:35 HORDE [debug] [horde] SQL Query by
Prefs_sql::retrieve(): SELECT pref_scope, pref_name, pref_value FROM
horde_prefs WHERE pref_uid = ? AND pref_scope = ?, values: mabuqu, horde
[on line 148 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Prefs/sql.php"]
Aug 03 19:43:35 HORDE [debug] [horde] Hook _prefs_change_hook_last_login
in application horde not called. [on line 1484 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde.php"]
Aug 03 19:43:35 HORDE [notice] [horde] Login success for mabuqu
[138.x.x.x] to Horde [on line 120 of
"/usr/local/webmail/horde-3.2-alpha/horde/login.php"]
Aug 03 19:43:36 HORDE [debug] [horde] SQL Query by Prefs_sql::store():
SELECT 1 FROM horde_prefs WHERE pref_uid = ? AND pref_name = ? AND
pref_scope = ?, values: mabuqu, last_login, horde [on line 210 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Prefs/sql.php"]
Aug 03 19:43:36 HORDE [debug] [horde] SQL Query by Prefs_sql::store():
UPDATE horde_prefs SET pref_value = ? WHERE pref_uid = ? AND pref_name =
? AND pref_scope = ?, values:
a:2:{s:4:"time";i:1186188215;s:4:"host";s:11:"138.x.x.x";}, mabuqu,
last_login, horde [on line 244 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Prefs/sql.php"]
Aug 03 19:43:36 HORDE [debug] [horde] Wrote session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:36 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:43:36 HORDE [debug] [horde] Read session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 93 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:36 HORDE [debug] [horde] Wrote session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:36 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:43:36 HORDE [debug] [horde] Read session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 93 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:36 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:43:37 HORDE [debug] [horde] SQL Query by
Prefs_sql::retrieve(): SELECT pref_scope, pref_name, pref_value FROM
horde_prefs WHERE pref_uid = ? AND pref_scope = ?, values: mabuqu, imp
[on line 148 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Prefs/sql.php"]
Aug 03 19:43:37 HORDE [debug] [horde] Wrote session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:37 HORDE [debug] [horde] Read session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 93 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:37 HORDE [debug] [horde] Connected to the following
memcache servers for memcache SessionHandler:127.0.0.1:12000 [on line
119 of "/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/Memcache.php"]
Aug 03 19:43:37 HORDE [debug] [horde] Wrote session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:37 HORDE [debug] [horde] Read session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 93 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
Aug 03 19:43:37 HORDE [debug] [horde] Wrote session data (id =
919e3bdc60fc1f419adc3d24b459ae4f) [on line 136 of
"/usr/local/webmail/horde-3.2-alpha/horde/lib/Horde/SessionHandler/memcache.php"]
***********************
More information about the horde
mailing list