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
The rt-users Archives
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.