Slow Query when Displaying "Owners" dropdown (Query Builder, Reply, etc.)

Hello RT Users,

We just upgraded from RT 3.0 to 3.4.4 and everything went fine expect
for one thing:
There is a specific query that takes more than 50 Seconds and is
executed frequently as the results of the Query seems to be the list of
Owners in the Drop down menu for the Query Builder page or When
Selecting Reply, etc. So when a user clicks on the Query Builder it
takes 50 seconds, making it very hard to use sometimes.
The MySql query cache kicks in after that and subsequent clicks to query
builder are faster, but the 50 second time still happens quite often as
the cache gets updated.
We have close to 100,000 tickets and a few thousand users (autocreated,
mainly). If I start from a fresh database I don’t have this problem,
it’s only after I import our current, relatively large DB.

System:
RT 3.4.4 + apache2 + fastcgi + mysql 4.1 + HTML::Mason v1.3101 + DBI
v1.48 + DBIx::SearchBuilder v1.33;

From the MySQL slow query log:

Query_time: 56 Lock_time: 1 Rows_sent: 115 Rows_examined: 208668

use rt3;
SELECT DISTINCT main.* FROM Users main , Principals Principals_1, ACL
ACL_2, Groups Groups_3, CachedGroupMembers CachedGroupMembers_4 WHERE
((ACL_2.RightName = ‘OwnTicket’)) AND ((CachedGroupMembers_4.MemberId =
Principals_1.id)) AND ((Groups_3.id = CachedGroupMembers_4.GroupId)) AND
((Principals_1.Disabled = ‘0’)or(Principals_1.Disabled = ‘0’)) AND
((Principals_1.id != ‘1’)) AND ((main.id = Principals_1.id)) AND ( (
ACL_2.PrincipalId = Groups_3.id AND ACL_2.PrincipalType = 'Group’
AND ( Groups_3.Domain = ‘SystemInternal’ OR
Groups_3.Domain = ‘UserDefined’ OR Groups_3.Domain = ‘ACLEquivalence’))
OR ( ( (Groups_3.Domain = ‘RT::Queue-Role’ ) ) AND
Groups_3.Type = ACL_2.PrincipalType) ) AND (ACL_2.ObjectType =
‘RT::System’ OR (ACL_2.ObjectType = ‘RT::Queue’) ) ORDER BY
main.Name ASC;

That query displays valid users that can own a ticket.

Is there a way to optimize this query? Where is the bottleneck here (Why
so many rows examined)? How can I safely delete Unprivledged users from
the database to clean it up a bit? Would that help?
Or, as a last resort, how would I change every “Owner” drop-down to be a
fill-in text field instead?

I found this old thread
http://lists.bestpractical.com/pipermail/rt-devel/2003-October/004918.html
but it was a while ago and it seems like some internals have changed
since then; also there’s no obviuos solution.

Any help would be greatly appreciated.
Thanks!

Mark Matyas
Computing and Network Services
McHenry Library
University of California, Santa Cruz

Remove OwnTicket Right from Everyone group and only assign it to techs/IT
workers.

Quoting mark matyas mark@library.ucsc.edu:

Remove OwnTicket Right from Everyone group and only assign it to >techs/IT
workers.

That option is not set. The only thing I have set in Everyone under
System groups is ‘Create Ticket’; and under Roles, I have the Requestor
set to ‘Reply to Ticket’ and ‘Modify Ticket’.

-mark

Quoting mark matyas :

Hello RT Users,

We just upgraded from RT 3.0 to 3.4.4 and everything went fine expect
for one thing:
There is a specific query that takes more than 50 Seconds and is
executed frequently as the results of the Query seems to be the list of
Owners in the Drop down menu for the Query Builder page or When
Selecting Reply, etc. So when a user clicks on the Query Builder it
takes 50 seconds, making it very hard to use sometimes.
The MySql query cache kicks in after that and subsequent clicks to query
builder are faster, but the 50 second time still happens quite often as
the cache gets updated.
We have close to 100,000 tickets and a few thousand users (autocreated,
mainly). If I start from a fresh database I don’t have this problem,
it’s only after I import our current, relatively large DB.

System:
RT 3.4.4 + apache2 + fastcgi + mysql 4.1 + HTML::Mason v1.3101 + DBI
v1.48 + DBIx::SearchBuilder v1.33;

From the MySQL slow query log:

Query_time: 56 Lock_time: 1 Rows_sent: 115 Rows_examined: 208668

use rt3;
SELECT DISTINCT main.* FROM Users main , Principals Principals_1, ACL
ACL_2, Groups Groups_3, CachedGroupMembers CachedGroupMembers_4 WHERE
((ACL_2.RightName = ‘OwnTicket’)) AND ((CachedGroupMembers_4.MemberId =
Principals_1.id)) AND ((Groups_3.id = CachedGroupMembers_4.GroupId)) AND
((Principals_1.Disabled = ‘0’)or(Principals_1.Disabled = ‘0’)) AND
((Principals_1.id != ‘1’)) AND ((main.id = Principals_1.id)) AND ( (
ACL_2.PrincipalId = Groups_3.id AND ACL_2.PrincipalType = 'Group’
AND ( Groups_3.Domain = ‘SystemInternal’ OR
Groups_3.Domain = ‘UserDefined’ OR Groups_3.Domain = ‘ACLEquivalence’))
OR ( ( (Groups_3.Domain = ‘RT::Queue-Role’ ) ) AND
Groups_3.Type = ACL_2.PrincipalType) ) AND (ACL_2.ObjectType =
‘RT::System’ OR (ACL_2.ObjectType = ‘RT::Queue’) ) ORDER BY
main.Name ASC;

That query displays valid users that can own a ticket.

Is there a way to optimize this query? Where is the bottleneck here (Why
so many rows examined)? How can I safely delete Unprivledged users from
the database to clean it up a bit? Would that help?
Or, as a last resort, how would I change every “Owner” drop-down to be a
fill-in text field instead?

I found this old thread

http://lists.bestpractical.com/pipermail/rt-devel/2003-October/004918.html

Hello RT Users,

We just upgraded from RT 3.0 to 3.4.4 and everything went fine expect
for one thing:
There is a specific query that takes more than 50 Seconds and is
executed frequently as the results of the Query seems to be the list of
Owners in the Drop down menu for the Query Builder page or When
Selecting Reply, etc. So when a user clicks on the Query Builder it
takes 50 seconds, making it very hard to use sometimes.

Mark,

Can you please test out RT 3.4.5RC2 to see if it solves your performance
problem? We spent about half a man week working on just that for this
release.

Jesse

Hi Jesse,
Thanks for responding. Before I got your email I decided to go ahead and
try 3.5.6 for the heck of it, and it seems to have fixed the problem. I
really like 3.5.6 actually especially the WebUI and Simple Search. I
have another problem now though.
Myspecs: RT 3.5.6 + apache 2 + fastcgi + + mysql 4.1 + HTML::Mason
v1.3101 + DBI v1.48 + DBIx::SearchBuilder v1.36;
The only problem now though is that I get alot of the following errors
in my apache log:
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Fri Dec 30 07:12:13
2005] [err]: Couldn’t load from the users database.
(/opt/rt3/lib/RT/CurrentUser.pm:146)
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: Use of uninitialized
value in concatenation (.) or string at
/opt/rt3/lib/RT/Principal_Overlay.pm line 425.
[Thu Dec 29 23:12:13 2005] [error] [client 64.233.172.40] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Fri Dec 30 07:12:13
2005] [err]: Couldn’t load from the users database.
(/opt/rt3/lib/RT/CurrentUser.pm:146)
[Thu Dec 29 23:12:13 2005] [error] [client 64.233.172.40] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: Use of uninitialized
value in concatenation (.) or string at
/opt/rt3/lib/RT/Principal_Overlay.pm line 425.
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: DBD::mysql::st execute
failed: You have an error in your SQL syntax; check the manual that
corresponds to your MySQL server version for the right syntax to use
near 'AND ((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR
(ACL.ObjectType = ‘’ at line 1 at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 493.
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
RT::Handle=HASH(0xaabfb6c) couldn’t execute the query ‘SELECT ACL.id
from ACL, Groups, Principals, CachedGroupMembers WHERE (ACL.RightName =
‘SuperUser’ OR ACL.RightName = ‘ModifySelf’) AND Principals.Disabled =
0 AND CachedGroupMembers.Disabled = 0 AND Principals.id = Groups.id AND
Principals.PrincipalType = ‘Group’ AND Principals.id =
CachedGroupMembers.GroupId AND CachedGroupMembers.MemberId = AND
((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR (ACL.ObjectType
= ‘RT::System’)) AND ACL.PrincipalId = Principals.id AND
ACL.PrincipalType = ‘Group’ LIMIT 1’ at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 506

what could this be? should I downgrade or upgrade a certain perl module?
I would really like to keep using 3.5.6 if possible. should i downgrade RT?
Thanks for your help,
mark matyas

Jesse Vincent wrote:

Hi Jesse,
Thanks for responding. Before I got your email I decided to go ahead and
try 3.5.6 for the heck of it, and it seems to have fixed the problem. I
really like 3.5.6 actually especially the WebUI and Simple Search. I
have another problem now though.
Myspecs: RT 3.5.6 + apache 2 + fastcgi + + mysql 4.1 + HTML::Mason
v1.3101 + DBI v1.48 + DBIx::SearchBuilder v1.36;
The only problem now though is that I get alot of the following errors
in my apache log:
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Fri Dec 30 07:12:13
2005] [err]: Couldn’t load from the users database.
I saw this sveral times too. I find it harmless, but anyway it should
be debugged.

(/opt/rt3/lib/RT/CurrentUser.pm:146)
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: Use of uninitialized
value in concatenation (.) or string at
/opt/rt3/lib/RT/Principal_Overlay.pm line 425.
[Thu Dec 29 23:12:13 2005] [error] [client 64.233.172.40] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Fri Dec 30 07:12:13
2005] [err]: Couldn’t load from the users database.
(/opt/rt3/lib/RT/CurrentUser.pm:146)
[Thu Dec 29 23:12:13 2005] [error] [client 64.233.172.40] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: Use of uninitialized
value in concatenation (.) or string at
/opt/rt3/lib/RT/Principal_Overlay.pm line 425.
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: DBD::mysql::st execute
failed: You have an error in your SQL syntax; check the manual that
corresponds to your MySQL server version for the right syntax to use
near 'AND ((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR
(ACL.ObjectType = ‘’ at line 1 at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 493.
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
RT::Handle=HASH(0xaabfb6c) couldn’t execute the query ‘SELECT ACL.id
from ACL, Groups, Principals, CachedGroupMembers WHERE (ACL.RightName =
‘SuperUser’ OR ACL.RightName = ‘ModifySelf’) AND Principals.Disabled =
0 AND CachedGroupMembers.Disabled = 0 AND Principals.id = Groups.id AND
Principals.PrincipalType = ‘Group’ AND Principals.id =
CachedGroupMembers.GroupId AND CachedGroupMembers.MemberId = AND
((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR (ACL.ObjectType
= ‘RT::System’)) AND ACL.PrincipalId = Principals.id AND
ACL.PrincipalType = ‘Group’ LIMIT 1’ at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 506
This is bad.
“AND CachedGroupMembers.MemberId = AND”
^^^^^ here
Could turn on stack traces logging in RT config:
Set($LogToFile, ‘error’);
Set($LogStackTraces, 1);
Then reproduce this query error and send us stack trace from log file,
note that stacktraces are not logged via syslog.

what could this be? should I downgrade or upgrade a certain perl module?
I would really like to keep using 3.5.6 if possible. should i downgrade RT?
Thanks for your help,
mark matyas

Jesse Vincent wrote:

Hello RT Users,

We just upgraded from RT 3.0 to 3.4.4 and everything went fine expect
for one thing:
There is a specific query that takes more than 50 Seconds and is
executed frequently as the results of the Query seems to be the list of
Owners in the Drop down menu for the Query Builder page or When
Selecting Reply, etc. So when a user clicks on the Query Builder it
takes 50 seconds, making it very hard to use sometimes.

Mark,

Can you please test out RT 3.4.5RC2 to see if it solves your performance
problem? We spent about half a man week working on just that for this
release.

Jesse


http://lists.bestpractical.com/cgi-bin/mailman/listinfo/rt-users

Be sure to check out the RT Wiki at http://wiki.bestpractical.com

Download a free sample chapter of RT Essentials from O’Reilly Media at http://rtbook.bestpractical.com

WE’RE COMING TO YOUR TOWN SOON - RT Training in Amsterdam, Boston and
San Francisco - Find out more at http://bestpractical.com/services/training.html

Best regards, Ruslan.

Hello RT Users, Ruslan, Jesse,
Sorry for taking a few days to reply (went on vacation). I’m sending you
the requested stack traces from the error logs regarding my problem. To
recap this was my issue: I was using 3.4.4 and had peformance issues
with the Query Builder page (we have a large database). So I upgraded to
3.5.6 which fixed the problem (I really like 3.5.6 btw). Although there
are no visible errors while using RT, I notice some errors in the apache
and rt logs. It only seems to happen when a user logs out of RT,
otherwise 3.5.6 is working out well.
My specs again:
RT 3.5.6 + apache2 + fastcgi + mysql 4.1 + HTML::Mason v1.3101 + DBI
v1.48 + DBIx::SearchBuilder v1.36;

Log files are appended at the end of this email and attached.
thanks!
Mark Matyas
UCSC University Library

The following happens when I’m already logged in to RT (doesn’t

happen when logging in).
####I restarted apache right before I did this. I get this in apache
error_log immediately after I LOGOUT:

[Mon Jan 02 13:42:06 2006] [warn] FastCGI: server
"/opt/rt3/bin/mason_handler.fcgi" started (pid 13365)
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Mon Jan 2 21:42:50
2006] [err]: Couldn’t load from the users database.
(/opt/rt3/lib/RT/CurrentUser.pm:146)
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: Stack trace:
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::CurrentUser::UserObj() called at /opt/rt3/lib/RT/CurrentUser.pm:340
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::CurrentUser::HasRight() called at
/opt/rt3/local/html/Elements/Header:88
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1255
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \t(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp() called at
/opt/rt3/share/html/Elements/Login:68
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1255
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \t(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp() called at /opt/rt3/share/html/autohandler:253
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1250
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \t(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:461
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \t(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:461
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \t(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:413
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:192
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \t(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:192
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::CGI::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Interp.pm:323
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Interp::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:123
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \t(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:123
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::CGIHandler::_handler() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:73
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::CGIHandler::handle_cgi_object() called at
/opt/rt3/bin/mason_handler.fcgi:76
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \t(eval)() called at
/opt/rt3/bin/mason_handler.fcgi:76
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: Use of uninitialized
value in concatenation (.) or string at
/opt/rt3/lib/RT/Principal_Overlay.pm line 425.
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: DBD::mysql::st execute
failed: You have an error in your SQL syntax; check the manual that
corresponds to your MySQL server version for the right syntax to use
near 'AND ((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR
(ACL.ObjectType = ‘’ at line 1 at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 493.
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
RT::Handle=HASH(0x9f687f4) couldn’t execute the query ‘SELECT ACL.id
from ACL, Groups, Principals, CachedGroupMembers WHERE (ACL.RightName =
‘SuperUser’ OR ACL.RightName = ‘ModifySelf’) AND Principals.Disabled =
0 AND CachedGroupMembers.Disabled = 0 AND Principals.id = Groups.id AND
Principals.PrincipalType = ‘Group’ AND Principals.id =
CachedGroupMembers.GroupId AND CachedGroupMembers.MemberId = AND
((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR (ACL.ObjectType
= ‘RT::System’)) AND ACL.PrincipalId = Principals.id AND
ACL.PrincipalType = ‘Group’ LIMIT 1’ at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 506
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tDBIx::SearchBuilder::Handle::SimpleQuery(‘RT::Handle=HASH(0x9f687f4)’,
‘SELECT ACL.id from ACL, Groups, Principals, CachedGroupMember…’)
called at /usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm
line 538
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tDBIx::SearchBuilder::Handle::FetchResult(‘RT::Handle=HASH(0x9f687f4)’,
‘SELECT ACL.id from ACL, Groups, Principals, CachedGroupMember…’)
called at /opt/rt3/lib/RT/Principal_Overlay.pm line 458
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::Principal::_HasRight(‘RT::Principal=HASH(0xa331620)’, ‘Right’,
‘ModifySelf’, ‘EquivObjects’, ‘ARRAY(0xa331494)’, ‘Object’,
‘RT::System=HASH(0x9fc38dc)’) called at
/opt/rt3/lib/RT/Principal_Overlay.pm line 369
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::Principal::HasRight(‘RT::Principal=HASH(0xa331620)’, ‘Right’,
‘ModifySelf’, ‘Object’, ‘RT::System=HASH(0x9fc38dc)’) called at
/opt/rt3/lib/RT/User_Overlay.pm line 1570
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::User::HasRight(‘RT::User=HASH(0xa33be2c)’, ‘Right’, ‘ModifySelf’,
‘Object’, ‘RT::System=HASH(0x9fc38dc)’) called at
/opt/rt3/lib/RT/CurrentUser.pm line 340
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::CurrentUser::HasRight(‘RT::CurrentUser=HASH(0xa328e80)’, ‘Right’,
‘ModifySelf’, ‘Object’, ‘RT::System=HASH(0x9fc38dc)’) called at
/opt/rt3/local/html/Elements/Header line 88
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON(‘Title’, ‘Login’, ‘Focus’, ‘user’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm line 135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run(‘HTML::Mason::Component::FileBased=HASH(0xa31d600)’,
‘Title’, ‘Login’, ‘Focus’, ‘user’) called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1255
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp(‘undef’, ‘undef’, ‘Title’, ‘Login’,
‘Focus’, ‘user’) called at /opt/rt3/share/html/Elements/Login line 68
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm line 135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run(‘HTML::Mason::Component::FileBased=HASH(0xa2fa57c)’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1255
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp(‘undef’, ‘undef’) called at
/opt/rt3/share/html/autohandler line 253
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm line 135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run(‘HTML::Mason::Component::FileBased=HASH(0xa24ebec)’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1250
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp(‘undef’, ‘undef’, ‘undef’) called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 461
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 461
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 413
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::exec(‘HTML::Mason::Request::CGI=HASH(0xa25e1a8)’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 192
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 192
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::CGI::exec(‘HTML::Mason::Request::CGI=HASH(0xa25e1a8)’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Interp.pm line 323
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Interp::exec(‘undef’, ‘undef’) called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 123
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 123
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::CGIHandler::_handler(‘HTML::Mason::CGIHandler=HASH(0x9f4c60c)’,
‘HASH(0xa2d0b6c)’) called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 73
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::CGIHandler::handle_cgi_object(‘HTML::Mason::CGIHandler=HASH(0x9f4c60c)’,
‘CGI::Fast=HASH(0xa2314b8)’) called at /opt/rt3/bin/mason_handler.fcgi
line 76
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/opt/rt3/bin/mason_handler.fcgi line 76
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: DBD::mysql::st execute
failed: You have an error in your SQL syntax; check the manual that
corresponds to your MySQL server version for the right syntax to use
near 'AND ((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR
(ACL.ObjectType = ‘’ at line 1 at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 493.
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
RT::Handle=HASH(0x9f687f4) couldn’t execute the query ‘SELECT ACL.id
from ACL, Groups, Principals, CachedGroupMembers WHERE (ACL.RightName =
‘SuperUser’ OR ACL.RightName = ‘ModifySelf’) AND Principals.Disabled =
0 AND CachedGroupMembers.Disabled = 0 AND Principals.id = Groups.id AND
Principals.PrincipalType = ‘Group’ AND Principals.id =
CachedGroupMembers.GroupId AND CachedGroupMembers.MemberId = AND
((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR (ACL.ObjectType
= ‘RT::System’)) AND ACL.PrincipalType = Groups.Type AND ((Groups.Domain
= ‘RT::System-Role’ AND Groups.Instance = ‘1’) OR (Groups.Domain =
‘RT::System-Role’)) LIMIT 1’ at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 506
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tDBIx::SearchBuilder::Handle::SimpleQuery(‘RT::Handle=HASH(0x9f687f4)’,
‘SELECT ACL.id from ACL, Groups, Principals, CachedGroupMember…’)
called at /usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm
line 538
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tDBIx::SearchBuilder::Handle::FetchResult(‘RT::Handle=HASH(0x9f687f4)’,
‘SELECT ACL.id from ACL, Groups, Principals, CachedGroupMember…’)
called at /opt/rt3/lib/RT/Principal_Overlay.pm line 467
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::Principal::_HasRight(‘RT::Principal=HASH(0xa331620)’, ‘Right’,
‘ModifySelf’, ‘EquivObjects’, ‘ARRAY(0xa331494)’, ‘Object’,
‘RT::System=HASH(0x9fc38dc)’) called at
/opt/rt3/lib/RT/Principal_Overlay.pm line 369
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::Principal::HasRight(‘RT::Principal=HASH(0xa331620)’, ‘Right’,
‘ModifySelf’, ‘Object’, ‘RT::System=HASH(0x9fc38dc)’) called at
/opt/rt3/lib/RT/User_Overlay.pm line 1570
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::User::HasRight(‘RT::User=HASH(0xa33be2c)’, ‘Right’, ‘ModifySelf’,
‘Object’, ‘RT::System=HASH(0x9fc38dc)’) called at
/opt/rt3/lib/RT/CurrentUser.pm line 340
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tRT::CurrentUser::HasRight(‘RT::CurrentUser=HASH(0xa328e80)’, ‘Right’,
‘ModifySelf’, ‘Object’, ‘RT::System=HASH(0x9fc38dc)’) called at
/opt/rt3/local/html/Elements/Header line 88
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON(‘Title’, ‘Login’, ‘Focus’, ‘user’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm line 135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run(‘HTML::Mason::Component::FileBased=HASH(0xa31d600)’,
‘Title’, ‘Login’, ‘Focus’, ‘user’) called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1255
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp(‘undef’, ‘undef’, ‘Title’, ‘Login’,
‘Focus’, ‘user’) called at /opt/rt3/share/html/Elements/Login line 68
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm line 135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run(‘HTML::Mason::Component::FileBased=HASH(0xa2fa57c)’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1255
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp(‘undef’, ‘undef’) called at
/opt/rt3/share/html/autohandler line 253
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm line 135
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Component::run(‘HTML::Mason::Component::FileBased=HASH(0xa24ebec)’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1250
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 1249
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::comp(‘undef’, ‘undef’, ‘undef’) called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 461
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 461
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm line 413
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::exec(‘HTML::Mason::Request::CGI=HASH(0xa25e1a8)’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 192
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 192
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Request::CGI::exec(‘HTML::Mason::Request::CGI=HASH(0xa25e1a8)’)
called at /usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Interp.pm line 323
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::Interp::exec(‘undef’, ‘undef’) called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 123
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 123
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::CGIHandler::_handler(‘HTML::Mason::CGIHandler=HASH(0x9f4c60c)’,
‘HASH(0xa2d0b6c)’) called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm line 73
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
\tHTML::Mason::CGIHandler::handle_cgi_object(‘HTML::Mason::CGIHandler=HASH(0x9f4c60c)’,
‘CGI::Fast=HASH(0xa2314b8)’) called at /opt/rt3/bin/mason_handler.fcgi
line 76
[Mon Jan 02 13:42:50 2006] [error] [client 128.114.238.30] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: \teval {…} called at
/opt/rt3/bin/mason_handler.fcgi line 76

#####I get this in rt.log (with stack trace):

FYI: the time in RT log is messed up and doesn’t sync with apache

error log

Stack trace:
RT::CurrentUser::UserObj() called at
/opt/rt3/lib/RT/CurrentUser.pm:340
RT::CurrentUser::HasRight() called at
/opt/rt3/local/html/Elements/Header:88
HTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
HTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1255
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
HTML::Mason::Request::comp() called at
/opt/rt3/share/html/Elements/Login:68
HTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
HTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1255
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
HTML::Mason::Request::comp() called at
/opt/rt3/share/html/autohandler:253
HTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
HTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1250
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
HTML::Mason::Request::comp() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:461
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:461
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:413
HTML::Mason::Request::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:192
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:192
HTML::Mason::Request::CGI::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Interp.pm:323
HTML::Mason::Interp::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:123
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:123
HTML::Mason::CGIHandler::_handler() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:73
HTML::Mason::CGIHandler::handle_cgi_object() called at
/opt/rt3/bin/mason_handler.fcgi:76
(eval)() called at /opt/rt3/bin/mason_handler.fcgi:76
[Mon Jan 2 21:42:50 2006] [err]: Couldn’t load from the users
database. (/opt/rt3/lib/RT/CurrentUser.pm:146)

Stack trace:
RT::CurrentUser::UserObj() called at
/opt/rt3/lib/RT/CurrentUser.pm:340
RT::CurrentUser::HasRight() called at
/opt/rt3/local/html/Elements/Header:88
HTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
HTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1255
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
HTML::Mason::Request::comp() called at
/opt/rt3/share/html/Elements/Login:68
HTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
HTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1255
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
HTML::Mason::Request::comp() called at
/opt/rt3/share/html/autohandler:253
HTML::Mason::Commands::ANON() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Component.pm:135
HTML::Mason::Component::run() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1250
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:1249
HTML::Mason::Request::comp() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:461
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:461
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Request.pm:413
HTML::Mason::Request::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:192
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:192
HTML::Mason::Request::CGI::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/Interp.pm:323
HTML::Mason::Interp::exec() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:123
(eval)() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:123
HTML::Mason::CGIHandler::_handler() called at
/usr/lib/perl5/site_perl/5.8.5/HTML/Mason/CGIHandler.pm:73
HTML::Mason::CGIHandler::handle_cgi_object() called at
/opt/rt3/bin/mason_handler.fcgi:76
(eval)() called at /opt/rt3/bin/mason_handler.fcgi:76

Ruslan Zakirov wrote:> On 12/30/05, mark matyas mark@library.ucsc.edu wrote:

Hi Jesse,
Thanks for responding. Before I got your email I decided to go ahead and
try 3.5.6 for the heck of it, and it seems to have fixed the problem. I
really like 3.5.6 actually especially the WebUI and Simple Search. I
have another problem now though.
Myspecs: RT 3.5.6 + apache 2 + fastcgi + + mysql 4.1 + HTML::Mason
v1.3101 + DBI v1.48 + DBIx::SearchBuilder v1.36;
The only problem now though is that I get alot of the following errors
in my apache log:
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Fri Dec 30 07:12:13
2005] [err]: Couldn’t load from the users database.

I saw this sveral times too. I find it harmless, but anyway it should
be debugged.

(/opt/rt3/lib/RT/CurrentUser.pm:146)
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: Use of uninitialized
value in concatenation (.) or string at
/opt/rt3/lib/RT/Principal_Overlay.pm line 425.
[Thu Dec 29 23:12:13 2005] [error] [client 64.233.172.40] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Fri Dec 30 07:12:13
2005] [err]: Couldn’t load from the users database.
(/opt/rt3/lib/RT/CurrentUser.pm:146)
[Thu Dec 29 23:12:13 2005] [error] [client 64.233.172.40] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: Use of uninitialized
value in concatenation (.) or string at
/opt/rt3/lib/RT/Principal_Overlay.pm line 425.
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: DBD::mysql::st execute
failed: You have an error in your SQL syntax; check the manual that
corresponds to your MySQL server version for the right syntax to use
near 'AND ((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR
(ACL.ObjectType = ‘’ at line 1 at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 493.
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr:
RT::Handle=HASH(0xaabfb6c) couldn’t execute the query ‘SELECT ACL.id
from ACL, Groups, Principals, CachedGroupMembers WHERE (ACL.RightName =
‘SuperUser’ OR ACL.RightName = ‘ModifySelf’) AND Principals.Disabled =
0 AND CachedGroupMembers.Disabled = 0 AND Principals.id = Groups.id AND
Principals.PrincipalType = ‘Group’ AND Principals.id =
CachedGroupMembers.GroupId AND CachedGroupMembers.MemberId = AND
((ACL.ObjectType = ‘RT::System’ AND ACL.ObjectId = 1) OR (ACL.ObjectType
= ‘RT::System’)) AND ACL.PrincipalId = Principals.id AND
ACL.PrincipalType = ‘Group’ LIMIT 1’ at
/usr/lib/perl5/site_perl/5.8.5/DBIx/SearchBuilder/Handle.pm line 506

This is bad.
“AND CachedGroupMembers.MemberId = AND”
^^^^^ here
Could turn on stack traces logging in RT config:
Set($LogToFile, ‘error’);
Set($LogStackTraces, 1);
Then reproduce this query error and send us stack trace from log file,
note that stacktraces are not logged via syslog.

what could this be? should I downgrade or upgrade a certain perl module?
I would really like to keep using 3.5.6 if possible. should i downgrade RT?
Thanks for your help,
mark matyas

Jesse Vincent wrote:

On Wed, Dec 28, 2005 at 03:16:09PM -0800, mark matyas wrote:

Hello RT Users,

We just upgraded from RT 3.0 to 3.4.4 and everything went fine expect
for one thing:
There is a specific query that takes more than 50 Seconds and is
executed frequently as the results of the Query seems to be the list of
Owners in the Drop down menu for the Query Builder page or When
Selecting Reply, etc. So when a user clicks on the Query Builder it
takes 50 seconds, making it very hard to use sometimes.

Mark,

Can you please test out RT 3.4.5RC2 to see if it solves your performance
problem? We spent about half a man week working on just that for this
release.

Jesse


http://lists.bestpractical.com/cgi-bin/mailman/listinfo/rt-users

Be sure to check out the RT Wiki at http://wiki.bestpractical.com

Download a free sample chapter of RT Essentials from O’Reilly Media at http://rtbook.bestpractical.com

WE’RE COMING TO YOUR TOWN SOON - RT Training in Amsterdam, Boston and
San Francisco - Find out more at http://bestpractical.com/services/training.html


Best regards, Ruslan.

Hello!On Fri, 2005-12-30 at 02:26, Ruslan Zakirov wrote:

On 12/30/05, mark matyas mark@library.ucsc.edu wrote:

The only problem now though is that I get alot of the following errors
in my apache log:
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Fri Dec 30 07:12:13
2005] [err]: Couldn’t load from the users database.
I saw this sveral times too. I find it harmless, but anyway it should
be debugged.

I’ve noticed it, too. Seems to happen only when displaying the login
page. I was guessing it has to do with loading CurrentUser when there’s
no user, but I hadn’t dug deeper.

Cheers!

–j
Jim Meyer, Geek at Large purp@acm.org

here is patch.On 1/5/06, Jim Meyer purp@acm.org wrote:

Hello!

On Fri, 2005-12-30 at 02:26, Ruslan Zakirov wrote:

On 12/30/05, mark matyas mark@library.ucsc.edu wrote:

The only problem now though is that I get alot of the following errors
in my apache log:
[Thu Dec 29 23:12:13 2005] [error] [client 67.180.231.50] FastCGI:
server “/opt/rt3/bin/mason_handler.fcgi” stderr: [Fri Dec 30 07:12:13
2005] [err]: Couldn’t load from the users database.
I saw this sveral times too. I find it harmless, but anyway it should
be debugged.

I’ve noticed it, too. Seems to happen only when displaying the login
page. I was guessing it has to do with loading CurrentUser when there’s
no user, but I hadn’t dug deeper.

Cheers!

–j

Jim Meyer, Geek at Large purp@acm.org

Best regards, Ruslan.

cu_login_page.patch (925 Bytes)