Unusual exceptions sometimes occur at startup: uninitialized constant
ActionDispatch::Http::FilterParameters::ParameterFilter
-----------------------------------------------------------------------------------------------------------------------------
Key: JRUBY-6254
URL: https://jira.codehaus.org/browse/JRUBY-6254
Project: JRuby
Issue Type: Bug
Affects Versions: JRuby 1.6.5
Environment: Ubuntu 11.04 64-bit, Rails 3.0.10, tomcat 7.0.23, warbler
1.3.2, running in --1.9 mode.
Reporter: David Wood
Assignee: Thomas E Enebo
In our (threadsafe) rails app, when I warble it, install it in tomcat 7, and
run our automated tests against it, we frequently, but not every time, see an
exception causing a test failure right at the start of the test run:
{code}
org.jruby.exceptions.RaiseException: (NameError) uninitialized constant
ActionDispatch::Http::FilterParameters::ParameterFilter
at org.jruby.RubyModule.const_missing(org/jruby/RubyModule.java:2590)
at
Module.const_missing(<<<OMITTED>>>/WEB-INF/gems/gems/rake-0.9.2.2/lib/rake/ext/module.rb:36)
at org.jruby.RubyMethod.call(org/jruby/RubyMethod.java:133)
at
ActionDispatch::Http::FilterParameters.parameter_filter_for(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:57)
at
ActionDispatch::Http::FilterParameters.parameter_filter(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:49)
at
ActionDispatch::Request.filtered_query_string(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:64)
at org.jruby.RubyString.gsub(org/jruby/RubyString.java:2877)
at
ActionDispatch::Http::FilterParameters.filtered_query_string(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:63)
at
ActionDispatch::Http::FilterParameters.filtered_path(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:43)
at
Rails::Rack::Logger.before_dispatch(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/rack/logger.rb:22)
at
Rails::Rack::Logger.call(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/rack/logger.rb:12)
at
Rack::Runtime.call(<<<OMITTED>>>/WEB-INF/gems/gems/rack-1.2.4/lib/rack/runtime.rb:17)
at
#<Class:0x6830d77d>.call(<<<OMITTED>>>/WEB-INF/gems/gems/activesupport-3.0.10/lib/active_support/cache/strategy/local_cache.rb:90)
at
ActionDispatch::Static.call(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/middleware/static.rb:30)
at
Rails::Application.call(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/application.rb:168)
at
Rack::Handler::Servlet.call(file:<<<OMITTED>>>/WEB-INF/lib/jruby-rack-1.1.1.jar!/rack/handler/servlet.rb:19)
Dec 7, 2011 11:36:21 AM org.apache.catalina.core.ApplicationContext log
SEVERE: Application Error
org.jruby.exceptions.RaiseException: (NameError) uninitialized constant
ActionDispatch::Http::FilterParameters::ParameterFilter
at org.jruby.RubyModule.const_missing(org/jruby/RubyModule.java:2590)
at
Module.const_missing(<<<OMITTED>>>/WEB-INF/gems/gems/rake-0.9.2.2/lib/rake/ext/module.rb:36)
at org.jruby.RubyMethod.call(org/jruby/RubyMethod.java:133)
at
ActionDispatch::Http::FilterParameters.parameter_filter_for(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:57)
at
ActionDispatch::Http::FilterParameters.parameter_filter(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:49)
at
ActionDispatch::Request.filtered_query_string(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:64)
at org.jruby.RubyString.gsub(org/jruby/RubyString.java:2877)
at
ActionDispatch::Http::FilterParameters.filtered_query_string(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:63)
at
ActionDispatch::Http::FilterParameters.filtered_path(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:43)
at
Rails::Rack::Logger.before_dispatch(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/rack/logger.rb:22)
at
Rails::Rack::Logger.call(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/rack/logger.rb:12)
at
Rack::Runtime.call(<<<OMITTED>>>/WEB-INF/gems/gems/rack-1.2.4/lib/rack/runtime.rb:17)
at
#<Class:0x6830d77d>.call(<<<OMITTED>>>/WEB-INF/gems/gems/activesupport-3.0.10/lib/active_support/cache/strategy/local_cache.rb:90)
at
ActionDispatch::Static.call(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/middleware/static.rb:30)
at
Rails::Application.call(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/application.rb:168)
at
Rack::Handler::Servlet.call(file:<<<OMITTED>>>/WEB-INF/lib/jruby-rack-1.1.1.jar!/rack/handler/servlet.rb:19)
Dec 7, 2011 11:36:21 AM org.apache.catalina.core.ApplicationContext log
SEVERE: Application Error
org.jruby.exceptions.RaiseException: (NameError) uninitialized constant
ActionDispatch::Http::FilterParameters::ParameterFilter
at org.jruby.RubyModule.const_missing(org/jruby/RubyModule.java:2590)
at
Module.const_missing(<<<OMITTED>>>/WEB-INF/gems/gems/rake-0.9.2.2/lib/rake/ext/module.rb:36)
at org.jruby.RubyMethod.call(org/jruby/RubyMethod.java:133)
at
ActionDispatch::Http::FilterParameters.parameter_filter_for(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:57)
at
ActionDispatch::Http::FilterParameters.parameter_filter(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:49)
at
ActionDispatch::Request.filtered_query_string(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:64)
at org.jruby.RubyString.gsub(org/jruby/RubyString.java:2877)
at
ActionDispatch::Http::FilterParameters.filtered_query_string(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:63)
at
ActionDispatch::Http::FilterParameters.filtered_path(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:43)
at
Rails::Rack::Logger.before_dispatch(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/rack/logger.rb:22)
at
Rails::Rack::Logger.call(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/rack/logger.rb:12)
at
Rack::Runtime.call(<<<OMITTED>>>/WEB-INF/gems/gems/rack-1.2.4/lib/rack/runtime.rb:17)
at
#<Class:0x6830d77d>.call(<<<OMITTED>>>/WEB-INF/gems/gems/activesupport-3.0.10/lib/active_support/cache/strategy/local_cache.rb:90)
at
ActionDispatch::Static.call(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/middleware/static.rb:30)
at
Rails::Application.call(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/application.rb:168)
at
Rack::Handler::Servlet.call(file:<<<OMITTED>>>/WEB-INF/lib/jruby-rack-1.1.1.jar!/rack/handler/servlet.rb:19)
Dec 7, 2011 11:36:21 AM org.apache.catalina.core.ApplicationContext log
SEVERE: Application Error
org.jruby.exceptions.RaiseException: (NameError) uninitialized constant
ActionDispatch::Http::FilterParameters::ParameterFilter
at org.jruby.RubyModule.const_missing(org/jruby/RubyModule.java:2590)
at
Module.const_missing(<<<OMITTED>>>/WEB-INF/gems/gems/rake-0.9.2.2/lib/rake/ext/module.rb:36)
at org.jruby.RubyMethod.call(org/jruby/RubyMethod.java:133)
at
ActionDispatch::Http::FilterParameters.parameter_filter_for(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:57)
at
ActionDispatch::Http::FilterParameters.parameter_filter(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:49)
at
ActionDispatch::Request.filtered_query_string(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:64)
at org.jruby.RubyString.gsub(org/jruby/RubyString.java:2877)
at
ActionDispatch::Http::FilterParameters.filtered_query_string(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:63)
at
ActionDispatch::Http::FilterParameters.filtered_path(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/http/filter_parameters.rb:43)
at
Rails::Rack::Logger.before_dispatch(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/rack/logger.rb:22)
at
Rails::Rack::Logger.call(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/rack/logger.rb:12)
at
Rack::Runtime.call(<<<OMITTED>>>/WEB-INF/gems/gems/rack-1.2.4/lib/rack/runtime.rb:17)
at
#<Class:0x6830d77d>.call(<<<OMITTED>>>/WEB-INF/gems/gems/activesupport-3.0.10/lib/active_support/cache/strategy/local_cache.rb:90)
at
ActionDispatch::Static.call(<<<OMITTED>>>/WEB-INF/gems/gems/actionpack-3.0.10/lib/action_dispatch/middleware/static.rb:30)
at
Rails::Application.call(<<<OMITTED>>>/WEB-INF/gems/gems/railties-3.0.10/lib/rails/application.rb:168)
at
Rack::Handler::Servlet.call(file:<<<OMITTED>>>/WEB-INF/lib/jruby-rack-1.1.1.jar!/rack/handler/servlet.rb:19)
Dec 7, 2011 11:36:21 AM org.apache.catalina.core.ApplicationContext log
INFO: Completed 500 Internal Server Error in 7ms
{code}
We have now confirmed that this never happens over a number of runs with the
same code in the MRI interpreter v1.9.*, so we believe it is jruby or warbler
related. Because it happens intermittently, and only on the first few requests
if at all, it smells like a threading problem.
--
This message is automatically generated by JIRA.
For more information on JIRA, see: http://www.atlassian.com/software/jira
---------------------------------------------------------------------
To unsubscribe from this list, please visit:
http://xircles.codehaus.org/manage_email
