[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #518
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/518/changes> Changes: [adrian] [api] allow project source copies with "withhistory" argument also for non-admins [adrian] [api] basic functionality for creating and modifying groups. We need still explicit calls for adding and remove users to a group for webui, I think. [adrian] [api] document group routes and remove outdated /rpms route from api ------------------------------------------ [...truncated 61925 lines...] [[32mINFO [0m|#32134] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#32134] Rendered layouts/_header.html.erb (1.5ms) [[32mINFO [0m|#32134] Rendered layouts/_personal_navigation.html.erb (1.5ms) [[32mINFO [0m|#32134] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32134] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32134] Completed 200 OK in 122ms (Views: 13.7ms | ActiveRecord: 0.0ms | API: 104.0ms (XML: 0.1ms , View: 1.2ms , Backend: 0.0ms , DB: 2.4ms , HTTP: 85.3ms) | XML: 0.7ms) [[0;37mDEBUG[0m|#32134] [1m[35m (0.1ms)[0m rollback transaction [[0;37mDEBUG[0m|#32134] [1m[36m (0.0ms)[0m [1mbegin transaction[0m [[32mINFO [0m|#32134] Started POST "/user/do_login" for 127.0.0.1 at 2012-10-18 16:19:36 +0200 [[32mINFO [0m|#32134] Processing by UserController#do_login as HTML [[32mINFO [0m|#32134] Parameters: {"username"=>"tom", "password"=>"[FILTERED]", "return_to_path"=>"/"} [[0;37mDEBUG[0m|#32134] Setting return_to: "/" [[0;37mDEBUG[0m|#32134] Authenticating with iChain mode: off [[32mINFO [0m|#32134] Anonymous request to / [[0;37mDEBUG[0m|#32134] Doing form authorization to login user tom [[0;37mDEBUG[0m|#32134] [REST] find( Person, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#32134] params {:login=>"tom"} [[0;37mDEBUG[0m|#32134] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32134] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/person/tom {"view"=>0.631797, "db"=>1.821094, "backend"=>0, "xml"=>0, :runtime=>10.116, :all=>51.535948} [[32mINFO [0m|#32134] Redirected to http://example.org/ [[32mINFO [0m|#32134] Completed 302 Found in 54ms (ActiveRecord: 0.0ms | API: 51.5ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 1.8ms , HTTP: 41.4ms) | XML: 0.4ms) [[32mINFO [0m|#32134] Started GET "/" for 127.0.0.1 at 2012-10-18 16:19:36 +0200 [[32mINFO [0m|#32134] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#32134] Setting return_to: "/" [[0;37mDEBUG[0m|#32134] Authenticating with iChain mode: off [[32mINFO [0m|#32134] Authenticated request to "/" from tom [[0;37mDEBUG[0m|#32134] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#32134] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#32134] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32134] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/person/tom {"view"=>0.34002, "db"=>1.160139, "backend"=>0, "xml"=>0, :runtime=>10.443, :all=>53.416218} [[0;37mDEBUG[0m|#32134] Fetching request list from api [[0;37mDEBUG[0m|#32134] --> direct_http url: #<URI::Generic:0x00000006961058 URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom> [[0;37mDEBUG[0m|#32134] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom {"view"=>0.852526, "db"=>0.809839, "backend"=>0, "xml"=>0.0, :runtime=>10.306, :all=>50.417451} [[0;37mDEBUG[0m|#32134] Fetching request list from api [[0;37mDEBUG[0m|#32134] --> direct_http url: #<URI::Generic:0x000000068fbf00 URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom> [[0;37mDEBUG[0m|#32134] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom {"view"=>0.974659, "db"=>2.79724, "backend"=>0, "xml"=>0.026987, :runtime=>25.395, :all=>67.27389000000001} [[0;37mDEBUG[0m|#32134] Fetching request list from api [[0;37mDEBUG[0m|#32134] --> direct_http url: #<URI::Generic:0x00000007070e70 URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom> [[0;37mDEBUG[0m|#32134] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom {"view"=>0.953055, "db"=>2.156668, "backend"=>0, "xml"=>0.0, :runtime=>22.371, :all=>63.199816000000006} [[32mINFO [0m|#32134] Rendered main/_news.html.erb (0.7ms) [[32mINFO [0m|#32134] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|#32134] Rendered main/_latest_updates.erb (8.3ms) [[32mINFO [0m|#32134] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|#32134] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#32134] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|#32134] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|#32134] Rendered layouts/_header.html.erb (2.0ms) [[32mINFO [0m|#32134] Rendered layouts/_personal_navigation.html.erb (0.9ms) [[32mINFO [0m|#32134] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32134] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32134] Completed 200 OK in 265ms (Views: 23.7ms | ActiveRecord: 0.0ms | API: 234.3ms (XML: 0.0ms , View: 3.1ms , Backend: 0.0ms , DB: 6.9ms , HTTP: 165.8ms) | XML: 1.0ms) [[32mINFO [0m|#32134] Started GET "/groups" for 127.0.0.1 at 2012-10-18 16:19:36 +0200 [[32mINFO [0m|#32134] Processing by GroupController#index as HTML [[0;37mDEBUG[0m|#32134] Setting return_to: "/groups" [[0;37mDEBUG[0m|#32134] Authenticating with iChain mode: off [[32mINFO [0m|#32134] Authenticated request to "/groups" from tom [[0;37mDEBUG[0m|#32134] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#32134] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#32134] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32134] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/person/tom {"view"=>0.7901400000000001, "db"=>2.2554, "backend"=>0, "xml"=>0, :runtime=>11.533, :all=>58.033256} [[0;37mDEBUG[0m|#32134] Fetching request list from api [[0;37mDEBUG[0m|#32134] --> direct_http url: #<URI::Generic:0x0000000724d9f0 URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom> [[0;37mDEBUG[0m|#32134] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom {"view"=>1.099797, "db"=>1.253546, "backend"=>0, "xml"=>0.140145, :runtime=>10.728, :all=>87.84637500000001} [[0;37mDEBUG[0m|#32134] Fetching request list from api [[0;37mDEBUG[0m|#32134] --> direct_http url: #<URI::Generic:0x00000007022b08 URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom> [[0;37mDEBUG[0m|#32134] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom {"view"=>0.9979959999999999, "db"=>4.225064000000001, "backend"=>0, "xml"=>0.026869, :runtime=>27.058, :all=>66.663685} [[0;37mDEBUG[0m|#32134] Fetching request list from api [[0;37mDEBUG[0m|#32134] --> direct_http url: #<URI::Generic:0x00000006a76740 URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom> [[0;37mDEBUG[0m|#32134] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom [[0;37mDEBUG[0m|#32134] RT http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom {"view"=>0.872119, "db"=>1.7941539999999998, "backend"=>0, "xml"=>0.0, :runtime=>21.236, :all=>67.26571200000001} [[31mERROR[0m|#32134] rescue_action: caught ActionView::Template::Error: undefined method `each' for nil:NilClass [[0;37mDEBUG[0m|#32134] ERROR: 400; No message set [[0;37mDEBUG[0m|#32134] <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views/group/index.html.erb>:20:in `block in _app_views_group_index_html_erb__370393051705851095_53602940' <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views/group/index.html.erb>:16:in `each' <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views/group/index.html.erb>:16:in `_app_views_group_index_html_erb__370393051705851095_53602940' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/template.rb:145:in `block in render' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/template.rb:143:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:47:in `block (2 levels) in render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:46:in `block in render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:54:in `render_with_layout' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:45:in `render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:18:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/renderer.rb:36:in `render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/renderer.rb:17:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:110:in `_render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/streaming.rb:225:in `_render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:103:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/renderers.rb:28:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/compatibility.rb:50:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:88:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rendering.rb:16:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:40:in `block (2 levels) in render' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/core_ext/benchmark.rb:5:in `block in ms' /usr/lib64/ruby/1.9.1/benchmark.rb:295:in `realtime' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/core_ext/benchmark.rb:5:in `ms' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:40:in `block in render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:83:in `cleanup_view_runtime' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/railties/controller_runtime.rb:24:in `cleanup_view_runtime' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:39:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:10:in `default_render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:5:in `send_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:167:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rendering.rb:10:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:18:in `block in process_action' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:491:in `_run__2913332305372494292__process_action__2284294325465202751__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:17:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rescue.rb:29:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:30:in `block in process_action' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:29:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/params_wrapper.rb:207:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/railties/controller_runtime.rb:18:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:121:in `process' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:45:in `process' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal.rb:203:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal.rb:246:in `block in action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:36:in `call' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:68:in `block in call' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:56:in `each' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:56:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:600:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/etag.rb:23:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/conditionalget.rb:25:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/head.rb:14:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/params_parser.rb:21:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/flash.rb:242:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:205:in `context' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:200:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/cookies.rb:339:in `call' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/query_cache.rb:64:in `call' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/connection_adapters/abstract/connection_pool.rb:473:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `_run__1053840382014413836__call__3580091282596302828__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_call_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:27:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/remote_ip.rb:31:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/rack/logger.rb:26:in `call_app' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/rack/logger.rb:16:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/request_id.rb:22:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/methodoverride.rb:21:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/runtime.rb:17:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/lock.rb:15:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/static.rb:62:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/engine.rb:479:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/application.rb:223:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/mock_session.rb:30:in `request' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/test.rb:230:in `process_request' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/test.rb:57:in `get' /usr/lib64/ruby/1.9.1/forwardable.rb:201:in `get' <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/test/functional/spider_test.rb>:296:in `test_2respider' /usr/lib64/ruby/1.9.1/minitest/unit.rb:949:in `run' /usr/lib64/ruby/1.9.1/test/unit/testcase.rb:17:in `run' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/testing/setup_and_teardown.rb:36:in `block in run' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:447:in `_run__1633308182574738182__setup__3580091282596302828__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_setup_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/testing/setup_and_teardown.rb:35:in `run' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:175:in `run_test' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:102:in `_run_test' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:93:in `block in _run_suite' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:92:in `each' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:92:in `_run_suite' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `block in _run_suites' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `map' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `_run_suites' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:75:in `_run_anything' /usr/lib64/ruby/1.9.1/minitest/unit.rb:909:in `run_tests' /usr/lib64/ruby/1.9.1/minitest/unit.rb:896:in `block in _run' /usr/lib64/ruby/1.9.1/minitest/unit.rb:895:in `each' /usr/lib64/ruby/1.9.1/minitest/unit.rb:895:in `_run' /usr/lib64/ruby/1.9.1/minitest/unit.rb:884:in `run' /usr/lib64/ruby/1.9.1/test/unit.rb:21:in `run' /usr/lib64/ruby/1.9.1/test/unit.rb:326:in `block (2 levels) in autorun' /usr/lib64/ruby/1.9.1/test/unit.rb:27:in `run_once' /usr/lib64/ruby/1.9.1/test/unit.rb:325:in `block in autorun' [[32mINFO [0m|#32134] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|#32134] Rendered layouts/_header.html.erb (2.2ms) [[32mINFO [0m|#32134] Rendered layouts/_personal_navigation.html.erb (1.5ms) [[32mINFO [0m|#32134] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32134] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32134] Completed 400 Bad Request in 367ms (Views: 9.7ms | ActiveRecord: 0.0ms | API: 279.8ms (XML: 0.2ms , View: 3.8ms , Backend: 0.0ms , DB: 9.5ms , HTTP: 209.3ms) | XML: 2.2ms) [[32mINFO [0m|#32134] Started POST "/user/logout" for 127.0.0.1 at 2012-10-18 16:19:37 +0200 [[32mINFO [0m|#32134] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#32134] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#32134] Authenticating with iChain mode: off [[32mINFO [0m|#32134] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#32134] Logging out: tom [[32mINFO [0m|#32134] Redirected to http://example.org/ [[32mINFO [0m|#32134] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#32134] [1m[35m (0.1ms)[0m rollback transaction + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> Cannot stat file /proc/895/fd/3: No such file or directory + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. sh + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/519/changes> Changes: [adrian] [backend] fix scanning of package sources after project copy ------------------------------------------ [...truncated 61931 lines...] [[32mINFO [0m|#20008] Rendered shared/_download_repository_link.html.erb (0.3ms) [[32mINFO [0m|#20008] Rendered layouts/_watch_and_search.html.erb (0.6ms) [[32mINFO [0m|#20008] Rendered layouts/_header.html.erb (2.2ms) [[32mINFO [0m|#20008] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#20008] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#20008] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#20008] Completed 200 OK in 79ms (Views: 15.3ms | ActiveRecord: 0.0ms | API: 59.2ms (XML: 0.2ms , View: 0.7ms , Backend: 0.0ms , DB: 2.2ms , HTTP: 46.1ms) | XML: 69.8ms) [[0;37mDEBUG[0m|#20008] [1m[35m (0.1ms)[0m rollback transaction [[0;37mDEBUG[0m|#20008] [1m[36m (0.0ms)[0m [1mbegin transaction[0m [[32mINFO [0m|#20008] Started POST "/user/do_login" for 127.0.0.1 at 2012-10-18 17:36:54 +0200 [[32mINFO [0m|#20008] Processing by UserController#do_login as HTML [[32mINFO [0m|#20008] Parameters: {"username"=>"tom", "password"=>"[FILTERED]", "return_to_path"=>"/"} [[0;37mDEBUG[0m|#20008] Setting return_to: "/" [[0;37mDEBUG[0m|#20008] Authenticating with iChain mode: off [[32mINFO [0m|#20008] Anonymous request to / [[0;37mDEBUG[0m|#20008] Doing form authorization to login user tom [[0;37mDEBUG[0m|#20008] [REST] find( Person, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#20008] params {:login=>"tom"} [[0;37mDEBUG[0m|#20008] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#20008] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/person/tom {"view"=>0.5469109999999999, "db"=>1.534934, "backend"=>0, "xml"=>0, :runtime=>11.256, :all=>52.309251} [[32mINFO [0m|#20008] Redirected to http://example.org/ [[32mINFO [0m|#20008] Completed 302 Found in 54ms (ActiveRecord: 0.0ms | API: 52.3ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 1.5ms , HTTP: 41.1ms) | XML: 0.5ms) [[32mINFO [0m|#20008] Started GET "/" for 127.0.0.1 at 2012-10-18 17:36:54 +0200 [[32mINFO [0m|#20008] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#20008] Setting return_to: "/" [[0;37mDEBUG[0m|#20008] Authenticating with iChain mode: off [[32mINFO [0m|#20008] Authenticated request to "/" from tom [[0;37mDEBUG[0m|#20008] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#20008] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#20008] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#20008] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/person/tom {"view"=>0.6763929999999999, "db"=>1.8469109999999997, "backend"=>0, "xml"=>0, :runtime=>11.155, :all=>51.681861000000005} [[0;37mDEBUG[0m|#20008] Fetching request list from api [[0;37mDEBUG[0m|#20008] --> direct_http url: #<URI::Generic:0x0000000616fe30 URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom> [[0;37mDEBUG[0m|#20008] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom {"view"=>0.824099, "db"=>0.234485, "backend"=>0, "xml"=>0.0, :runtime=>10.127, :all=>50.813214} [[0;37mDEBUG[0m|#20008] Fetching request list from api [[0;37mDEBUG[0m|#20008] --> direct_http url: #<URI::Generic:0x0000000641a018 URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom> [[0;37mDEBUG[0m|#20008] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom {"view"=>0.467664, "db"=>1.3453099999999998, "backend"=>0, "xml"=>0.0, :runtime=>23.262999999999998, :all=>64.000475} [[0;37mDEBUG[0m|#20008] Fetching request list from api [[0;37mDEBUG[0m|#20008] --> direct_http url: #<URI::Generic:0x00000006010c60 URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom> [[0;37mDEBUG[0m|#20008] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom {"view"=>0.576009, "db"=>1.6949660000000002, "backend"=>0, "xml"=>0.0, :runtime=>19.313, :all=>60.001293999999994} [[32mINFO [0m|#20008] Rendered main/_news.html.erb (0.5ms) [[32mINFO [0m|#20008] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|#20008] Rendered main/_latest_updates.erb (6.9ms) [[32mINFO [0m|#20008] Rendered main/_countdown.html.erb (0.1ms) [[32mINFO [0m|#20008] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#20008] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|#20008] Rendered layouts/_watch_and_search.html.erb (0.0ms) [[32mINFO [0m|#20008] Rendered layouts/_header.html.erb (1.7ms) [[32mINFO [0m|#20008] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#20008] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#20008] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#20008] Completed 200 OK in 251ms (Views: 20.0ms | ActiveRecord: 0.0ms | API: 226.5ms (XML: 0.0ms , View: 2.5ms , Backend: 0.0ms , DB: 5.1ms , HTTP: 162.6ms) | XML: 0.7ms) [[32mINFO [0m|#20008] Started GET "/groups" for 127.0.0.1 at 2012-10-18 17:36:54 +0200 [[32mINFO [0m|#20008] Processing by GroupController#index as HTML [[0;37mDEBUG[0m|#20008] Setting return_to: "/groups" [[0;37mDEBUG[0m|#20008] Authenticating with iChain mode: off [[32mINFO [0m|#20008] Authenticated request to "/groups" from tom [[0;37mDEBUG[0m|#20008] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#20008] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#20008] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#20008] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/person/tom {"view"=>0.530531, "db"=>0.587364, "backend"=>0, "xml"=>0, :runtime=>9.079, :all=>51.999365999999995} [[0;37mDEBUG[0m|#20008] Fetching request list from api [[0;37mDEBUG[0m|#20008] --> direct_http url: #<URI::Generic:0x0000000670a0c0 URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom> [[0;37mDEBUG[0m|#20008] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom {"view"=>1.285406, "db"=>0.795016, "backend"=>0, "xml"=>0.059594, :runtime=>8.002, :all=>51.429768} [[0;37mDEBUG[0m|#20008] Fetching request list from api [[0;37mDEBUG[0m|#20008] --> direct_http url: #<URI::Generic:0x00000006730d38 URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom> [[0;37mDEBUG[0m|#20008] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom {"view"=>0.528722, "db"=>3.3445180000000003, "backend"=>0, "xml"=>0.030193, :runtime=>24.546, :all=>64.00218000000001} [[0;37mDEBUG[0m|#20008] Fetching request list from api [[0;37mDEBUG[0m|#20008] --> direct_http url: #<URI::Generic:0x00000006760ce0 URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom> [[0;37mDEBUG[0m|#20008] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom [[0;37mDEBUG[0m|#20008] RT http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom {"view"=>0.373841, "db"=>2.5226910000000005, "backend"=>0, "xml"=>0.0, :runtime=>25.258, :all=>67.925556} [[31mERROR[0m|#20008] rescue_action: caught ActionView::Template::Error: undefined method `each' for nil:NilClass [[0;37mDEBUG[0m|#20008] ERROR: 400; No message set [[0;37mDEBUG[0m|#20008] <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views/group/index.html.erb>:20:in `block in _app_views_group_index_html_erb__1694593639790398832_54770480' <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views/group/index.html.erb>:16:in `each' <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views/group/index.html.erb>:16:in `_app_views_group_index_html_erb__1694593639790398832_54770480' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/template.rb:145:in `block in render' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/template.rb:143:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:47:in `block (2 levels) in render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:46:in `block in render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:54:in `render_with_layout' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:45:in `render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:18:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/renderer.rb:36:in `render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/renderer.rb:17:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:110:in `_render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/streaming.rb:225:in `_render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:103:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/renderers.rb:28:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/compatibility.rb:50:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:88:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rendering.rb:16:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:40:in `block (2 levels) in render' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/core_ext/benchmark.rb:5:in `block in ms' /usr/lib64/ruby/1.9.1/benchmark.rb:295:in `realtime' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/core_ext/benchmark.rb:5:in `ms' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:40:in `block in render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:83:in `cleanup_view_runtime' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/railties/controller_runtime.rb:24:in `cleanup_view_runtime' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:39:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:10:in `default_render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:5:in `send_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:167:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rendering.rb:10:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:18:in `block in process_action' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:491:in `_run__4118740787313172230__process_action__89281340957308018__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:17:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rescue.rb:29:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:30:in `block in process_action' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:29:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/params_wrapper.rb:207:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/railties/controller_runtime.rb:18:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:121:in `process' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:45:in `process' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal.rb:203:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal.rb:246:in `block in action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:36:in `call' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:68:in `block in call' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:56:in `each' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:56:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:600:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/etag.rb:23:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/conditionalget.rb:25:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/head.rb:14:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/params_parser.rb:21:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/flash.rb:242:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:205:in `context' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:200:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/cookies.rb:339:in `call' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/query_cache.rb:64:in `call' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/connection_adapters/abstract/connection_pool.rb:473:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `_run__59133889752703519__call__1586741087000381331__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_call_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:27:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/remote_ip.rb:31:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/rack/logger.rb:26:in `call_app' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/rack/logger.rb:16:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/request_id.rb:22:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/methodoverride.rb:21:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/runtime.rb:17:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/lock.rb:15:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/static.rb:62:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/engine.rb:479:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/application.rb:223:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/mock_session.rb:30:in `request' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/test.rb:230:in `process_request' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/test.rb:57:in `get' /usr/lib64/ruby/1.9.1/forwardable.rb:201:in `get' <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/test/functional/spider_test.rb>:296:in `test_2respider' /usr/lib64/ruby/1.9.1/minitest/unit.rb:949:in `run' /usr/lib64/ruby/1.9.1/test/unit/testcase.rb:17:in `run' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/testing/setup_and_teardown.rb:36:in `block in run' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:447:in `_run__4011616688149363852__setup__1586741087000381331__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_setup_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/testing/setup_and_teardown.rb:35:in `run' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:175:in `run_test' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:102:in `_run_test' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:93:in `block in _run_suite' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:92:in `each' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:92:in `_run_suite' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `block in _run_suites' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `map' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `_run_suites' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:75:in `_run_anything' /usr/lib64/ruby/1.9.1/minitest/unit.rb:909:in `run_tests' /usr/lib64/ruby/1.9.1/minitest/unit.rb:896:in `block in _run' /usr/lib64/ruby/1.9.1/minitest/unit.rb:895:in `each' /usr/lib64/ruby/1.9.1/minitest/unit.rb:895:in `_run' /usr/lib64/ruby/1.9.1/minitest/unit.rb:884:in `run' /usr/lib64/ruby/1.9.1/test/unit.rb:21:in `run' /usr/lib64/ruby/1.9.1/test/unit.rb:326:in `block (2 levels) in autorun' /usr/lib64/ruby/1.9.1/test/unit.rb:27:in `run_once' /usr/lib64/ruby/1.9.1/test/unit.rb:325:in `block in autorun' [[32mINFO [0m|#20008] Rendered layouts/_watch_and_search.html.erb (0.7ms) [[32mINFO [0m|#20008] Rendered layouts/_header.html.erb (1.4ms) [[32mINFO [0m|#20008] Rendered layouts/_personal_navigation.html.erb (0.1ms) [[32mINFO [0m|#20008] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#20008] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#20008] Completed 400 Bad Request in 247ms (Views: 6.0ms | ActiveRecord: 0.0ms | API: 235.4ms (XML: 0.1ms , View: 2.7ms , Backend: 0.0ms , DB: 7.2ms , HTTP: 168.5ms) | XML: 0.4ms) [[32mINFO [0m|#20008] Started POST "/user/logout" for 127.0.0.1 at 2012-10-18 17:36:54 +0200 [[32mINFO [0m|#20008] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#20008] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#20008] Authenticating with iChain mode: off [[32mINFO [0m|#20008] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#20008] Logging out: tom [[32mINFO [0m|#20008] Redirected to http://example.org/ [[32mINFO [0m|#20008] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#20008] [1m[35m (0.1ms)[0m rollback transaction + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/520/changes> Changes: [Stephan Kulow] [webui] fix test suite ------------------------------------------ [...truncated 61943 lines...] [[32mINFO [0m|#11144] Rendered package/_tabs.html.erb (2.8ms) [[32mINFO [0m|#11144] Rendered shared/_download_repository_link.html.erb (0.2ms) [[32mINFO [0m|#11144] Rendered layouts/_watch_and_search.html.erb (68.3ms) [[32mINFO [0m|#11144] Rendered layouts/_header.html.erb (69.3ms) [[32mINFO [0m|#11144] Rendered layouts/_personal_navigation.html.erb (1.6ms) [[32mINFO [0m|#11144] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#11144] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#11144] Completed 200 OK in 187ms (Views: 86.8ms | ActiveRecord: 0.0ms | API: 96.0ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 2.4ms , HTTP: 80.0ms) | XML: 0.5ms) [[0;37mDEBUG[0m|#11144] [1m[35m (0.1ms)[0m rollback transaction [[0;37mDEBUG[0m|#11144] [1m[36m (0.0ms)[0m [1mbegin transaction[0m [[32mINFO [0m|#11144] Started POST "/user/do_login" for 127.0.0.1 at 2012-10-19 11:49:31 +0200 [[32mINFO [0m|#11144] Processing by UserController#do_login as HTML [[32mINFO [0m|#11144] Parameters: {"username"=>"tom", "password"=>"[FILTERED]", "return_to_path"=>"/"} [[0;37mDEBUG[0m|#11144] Setting return_to: "/" [[0;37mDEBUG[0m|#11144] Authenticating with iChain mode: off [[32mINFO [0m|#11144] Anonymous request to / [[0;37mDEBUG[0m|#11144] Doing form authorization to login user tom [[0;37mDEBUG[0m|#11144] [REST] find( Person, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#11144] params {:login=>"tom"} [[0;37mDEBUG[0m|#11144] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#11144] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/person/tom {"view"=>0.884734, "db"=>2.663581, "backend"=>0, "xml"=>0, :runtime=>11.006, :all=>14.292429} [[32mINFO [0m|#11144] Redirected to http://example.org/ [[32mINFO [0m|#11144] Completed 302 Found in 17ms (ActiveRecord: 0.0ms | API: 14.3ms (XML: 0.0ms , View: 0.9ms , Backend: 0.0ms , DB: 2.7ms , HTTP: 3.3ms) | XML: 0.4ms) [[32mINFO [0m|#11144] Started GET "/" for 127.0.0.1 at 2012-10-19 11:49:31 +0200 [[32mINFO [0m|#11144] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#11144] Setting return_to: "/" [[0;37mDEBUG[0m|#11144] Authenticating with iChain mode: off [[32mINFO [0m|#11144] Authenticated request to "/" from tom [[0;37mDEBUG[0m|#11144] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#11144] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#11144] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#11144] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/person/tom {"view"=>0.514416, "db"=>0.7532760000000001, "backend"=>0, "xml"=>0, :runtime=>9.828999999999999, :all=>50.308077} [[0;37mDEBUG[0m|#11144] Fetching request list from api [[0;37mDEBUG[0m|#11144] --> direct_http url: #<URI::Generic:0x0000000379a588 URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom> [[0;37mDEBUG[0m|#11144] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom {"view"=>1.063732, "db"=>0.46124699999999996, "backend"=>0, "xml"=>0.050408, :runtime=>8.86, :all=>50.511399} [[0;37mDEBUG[0m|#11144] Fetching request list from api [[0;37mDEBUG[0m|#11144] --> direct_http url: #<URI::Generic:0x0000000490bc18 URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom> [[0;37mDEBUG[0m|#11144] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom {"view"=>1.216456, "db"=>1.82071, "backend"=>0, "xml"=>0.026846000000000002, :runtime=>25.404, :all=>67.211701} [[0;37mDEBUG[0m|#11144] Fetching request list from api [[0;37mDEBUG[0m|#11144] --> direct_http url: #<URI::Generic:0x00000003a09350 URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom> [[0;37mDEBUG[0m|#11144] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom {"view"=>0.8303339999999999, "db"=>2.153317, "backend"=>0, "xml"=>0.0, :runtime=>19.727999999999998, :all=>59.224786} [[32mINFO [0m|#11144] Rendered main/_news.html.erb (0.6ms) [[32mINFO [0m|#11144] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|#11144] Rendered main/_latest_updates.erb (7.9ms) [[32mINFO [0m|#11144] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|#11144] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#11144] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|#11144] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#11144] Rendered layouts/_header.html.erb (2.1ms) [[32mINFO [0m|#11144] Rendered layouts/_personal_navigation.html.erb (0.9ms) [[32mINFO [0m|#11144] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#11144] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#11144] Completed 200 OK in 255ms (Views: 21.3ms | ActiveRecord: 0.0ms | API: 227.3ms (XML: 0.1ms , View: 3.6ms , Backend: 0.0ms , DB: 5.2ms , HTTP: 163.4ms) | XML: 1.2ms) [[32mINFO [0m|#11144] Started GET "/groups/test_group_b" for 127.0.0.1 at 2012-10-19 11:49:31 +0200 [[32mINFO [0m|#11144] Processing by GroupController#show as HTML [[32mINFO [0m|#11144] Parameters: {"id"=>"test_group_b"} [[0;37mDEBUG[0m|#11144] Setting return_to: "/groups/test_group_b" [[0;37mDEBUG[0m|#11144] Authenticating with iChain mode: off [[32mINFO [0m|#11144] Authenticated request to "/groups/test_group_b" from tom [[0;37mDEBUG[0m|#11144] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#11144] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#11144] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#11144] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/person/tom {"view"=>0.721283, "db"=>2.540916, "backend"=>0, "xml"=>0, :runtime=>10.516, :all=>49.81642} [[0;37mDEBUG[0m|#11144] Fetching request list from api [[0;37mDEBUG[0m|#11144] --> direct_http url: #<URI::Generic:0x00000005daf7c8 URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom> [[0;37mDEBUG[0m|#11144] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom {"view"=>0.700406, "db"=>0.720693, "backend"=>0, "xml"=>0.065428, :runtime=>9.658999999999999, :all=>50.341995} [[0;37mDEBUG[0m|#11144] Fetching request list from api [[0;37mDEBUG[0m|#11144] --> direct_http url: #<URI::Generic:0x000000062fd090 URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom> [[0;37mDEBUG[0m|#11144] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom {"view"=>1.134903, "db"=>2.122263, "backend"=>0, "xml"=>0.030801, :runtime=>28.988, :all=>74.706164} [[0;37mDEBUG[0m|#11144] Fetching request list from api [[0;37mDEBUG[0m|#11144] --> direct_http url: #<URI::Generic:0x00000005efcfe0 URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom> [[0;37mDEBUG[0m|#11144] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom [[0;37mDEBUG[0m|#11144] RT http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom {"view"=>0.0, "db"=>1.4945199999999998, "backend"=>0, "xml"=>0.055495, :runtime=>18.588, :all=>59.295967} [[31mERROR[0m|#11144] rescue_action: caught ActionView::Template::Error: undefined method `has_elements?' for nil:NilClass [[0;37mDEBUG[0m|#11144] ERROR: 400; No message set [[0;37mDEBUG[0m|#11144] <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views/group/show.html.erb>:5:in `_app_views_group_show_html_erb__2136613774821567543_58597720' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/template.rb:145:in `block in render' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/template.rb:143:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:47:in `block (2 levels) in render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:46:in `block in render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:54:in `render_with_layout' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:45:in `render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/template_renderer.rb:18:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/renderer.rb:36:in `render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_view/renderer/renderer.rb:17:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:110:in `_render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/streaming.rb:225:in `_render_template' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:103:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/renderers.rb:28:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/compatibility.rb:50:in `render_to_body' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:88:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rendering.rb:16:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:40:in `block (2 levels) in render' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/core_ext/benchmark.rb:5:in `block in ms' /usr/lib64/ruby/1.9.1/benchmark.rb:295:in `realtime' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/core_ext/benchmark.rb:5:in `ms' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:40:in `block in render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:83:in `cleanup_view_runtime' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/railties/controller_runtime.rb:24:in `cleanup_view_runtime' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:39:in `render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:10:in `default_render' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:5:in `send_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:167:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rendering.rb:10:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:18:in `block in process_action' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:491:in `_run__3651058426602480612__process_action__2054349208044860871__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:17:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rescue.rb:29:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:30:in `block in process_action' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:29:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/params_wrapper.rb:207:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/railties/controller_runtime.rb:18:in `process_action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:121:in `process' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:45:in `process' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal.rb:203:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal.rb:246:in `block in action' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `dispatch' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:36:in `call' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:68:in `block in call' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:56:in `each' /usr/lib64/ruby/gems/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:56:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:600:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/etag.rb:23:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/conditionalget.rb:25:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/head.rb:14:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/params_parser.rb:21:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/flash.rb:242:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:205:in `context' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:200:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/cookies.rb:339:in `call' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/query_cache.rb:64:in `call' /usr/lib64/ruby/gems/1.9.1/gems/activerecord-3.2.8/lib/active_record/connection_adapters/abstract/connection_pool.rb:473:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:28:in `block in call' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `_run__472055417408149838__call__4125389588388044668__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_call_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:27:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/remote_ip.rb:31:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/rack/logger.rb:26:in `call_app' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/rack/logger.rb:16:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/request_id.rb:22:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/methodoverride.rb:21:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/runtime.rb:17:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-1.4.1/lib/rack/lock.rb:15:in `call' /usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_dispatch/middleware/static.rb:62:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/engine.rb:479:in `call' /usr/lib64/ruby/gems/1.9.1/gems/railties-3.2.8/lib/rails/application.rb:223:in `call' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/mock_session.rb:30:in `request' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/test.rb:230:in `process_request' /usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.2/lib/rack/test.rb:57:in `get' /usr/lib64/ruby/1.9.1/forwardable.rb:201:in `get' <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/test/functional/spider_test.rb>:296:in `test_2respider' /usr/lib64/ruby/1.9.1/minitest/unit.rb:949:in `run' /usr/lib64/ruby/1.9.1/test/unit/testcase.rb:17:in `run' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/testing/setup_and_teardown.rb:36:in `block in run' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:447:in `_run__3754478360853183442__setup__4125389588388044668__callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_setup_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks' /usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/testing/setup_and_teardown.rb:35:in `run' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:175:in `run_test' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:102:in `_run_test' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:93:in `block in _run_suite' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:92:in `each' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:92:in `_run_suite' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `block in _run_suites' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `map' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:83:in `_run_suites' /usr/lib64/ruby/gems/1.9.1/gems/ci_reporter-1.7.2/lib/ci/reporter/minitest.rb:75:in `_run_anything' /usr/lib64/ruby/1.9.1/minitest/unit.rb:909:in `run_tests' /usr/lib64/ruby/1.9.1/minitest/unit.rb:896:in `block in _run' /usr/lib64/ruby/1.9.1/minitest/unit.rb:895:in `each' /usr/lib64/ruby/1.9.1/minitest/unit.rb:895:in `_run' /usr/lib64/ruby/1.9.1/minitest/unit.rb:884:in `run' /usr/lib64/ruby/1.9.1/test/unit.rb:21:in `run' /usr/lib64/ruby/1.9.1/test/unit.rb:326:in `block (2 levels) in autorun' /usr/lib64/ruby/1.9.1/test/unit.rb:27:in `run_once' /usr/lib64/ruby/1.9.1/test/unit.rb:325:in `block in autorun' [[32mINFO [0m|#11144] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|#11144] Rendered layouts/_header.html.erb (1.7ms) [[32mINFO [0m|#11144] Rendered layouts/_personal_navigation.html.erb (1.8ms) [[32mINFO [0m|#11144] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#11144] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#11144] Completed 400 Bad Request in 251ms (Views: 9.9ms | ActiveRecord: 0.0ms | API: 234.2ms (XML: 0.2ms , View: 2.6ms , Backend: 0.0ms , DB: 6.9ms , HTTP: 166.4ms) | XML: 0.6ms) [[32mINFO [0m|#11144] Started POST "/user/logout" for 127.0.0.1 at 2012-10-19 11:49:31 +0200 [[32mINFO [0m|#11144] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#11144] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#11144] Authenticating with iChain mode: off [[32mINFO [0m|#11144] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#11144] Logging out: tom [[32mINFO [0m|#11144] Redirected to http://example.org/ [[32mINFO [0m|#11144] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#11144] [1m[35m (0.1ms)[0m rollback transaction + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/521/changes> -- To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
participants (1)
-
admin＠opensuse.org