[rt-users] Slow Query when Displaying "Owners" dropdown (Query Builder, Reply, etc.)
mark matyas
mark at library.ucsc.edu
Mon Jan 2 17:02:12 EST 2006
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 at 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.
More information about the rt-users
mailing list