See http://ci.opensuse.org/job/obs_master_testsuite_webui/483/changes
Changes:
[Stephan Kulow] [api,webui] fix logging of entries with starting newlines
[Stephan Kulow] [api,webui] update xmlhash dependency
------------------------------------------
[...truncated 17927 lines...]
/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|#19131] Rendered layouts/_watch_and_search.html.erb (0.6ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/layouts/_header.html.erb (1.5ms)
[[32mINFO [0m|#19131] Rendered layouts/_personal_navigation.html.erb (1.4ms)
[[32mINFO [0m|#19131] Rendered layouts/_flash.html.erb (0.1ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|#19131] Completed 400 Bad Request in 391ms (Views: 8.0ms | ActiveRecord: 0.0ms | API: 374.7ms (XML: 0.2ms , View: 2.8ms , Backend: 0.0ms , DB: 7.0ms , HTTP: 289.0ms) | XML: 0.6ms)
[[0;37mDEBUG[0m|#19131] [1m[35m (0.1ms)[0m rollback transaction
[[0;37mDEBUG[0m|#19131] [1m[36m (0.0ms)[0m [1mbegin transaction[0m
[[32mINFO [0m|#19131] Started POST "/user/do_login" for 127.0.0.1 at 2012-10-08 12:26:40 +0200
[[32mINFO [0m|#19131] Processing by UserController#do_login as HTML
[[32mINFO [0m|#19131] Parameters: {"username"=>"tom", "password"=>"[FILTERED]", "return_to_path"=>"/"}
[[0;37mDEBUG[0m|#19131] Setting return_to: "/"
[[0;37mDEBUG[0m|#19131] Authenticating with iChain mode: off
[[32mINFO [0m|#19131] Anonymous request to /
[[0;37mDEBUG[0m|#19131] Doing form authorization to login user tom
[[0;37mDEBUG[0m|#19131] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#19131] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.546821, "db"=>0.990101, "backend"=>0, "xml"=>0, :runtime=>11.857, :all=>52.80605}
[[32mINFO [0m|#19131] Redirected to http://example.org/
[[32mINFO [0m|#19131] Completed 302 Found in 55ms (ActiveRecord: 0.0ms | API: 52.8ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 1.0ms , HTTP: 40.9ms) | XML: 0.5ms)
[[32mINFO [0m|#19131] Started GET "/" for 127.0.0.1 at 2012-10-08 12:26:40 +0200
[[32mINFO [0m|#19131] Processing by MainController#index as HTML
[[0;37mDEBUG[0m|#19131] Setting return_to: "/"
[[0;37mDEBUG[0m|#19131] Authenticating with iChain mode: off
[[32mINFO [0m|#19131] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|#19131] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#19131] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.5553030000000001, "db"=>0.724164, "backend"=>0, "xml"=>0, :runtime=>8.975999999999999, :all=>46.883503}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.563034, "db"=>0.726665, "backend"=>0, "xml"=>0.039641, :runtime=>10.173, :all=>51.192831}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.47664, "db"=>2.2546039999999996, "backend"=>0, "xml"=>0.031172, :runtime=>22.988000000000003, :all=>62.875834000000005}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.495674, "db"=>2.048372, "backend"=>0, "xml"=>0.043205, :runtime=>18.827, :all=>59.438159999999996}
[[32mINFO [0m|#19131] Rendered main/_news.html.erb (0.6ms)
[[32mINFO [0m|#19131] Rendered main/_contact.html.erb (0.1ms)
[[32mINFO [0m|#19131] Rendered main/_latest_updates.erb (55.8ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/main/_countdown.html.erb (0.1ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/main/_sponsors.html.erb (0.0ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/main/_feeds.html.erb (0.0ms)
[[32mINFO [0m|#19131] Rendered layouts/_watch_and_search.html.erb (0.7ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/layouts/_header.html.erb (1.5ms)
[[32mINFO [0m|#19131] Rendered layouts/_personal_navigation.html.erb (0.9ms)
[[32mINFO [0m|#19131] Rendered layouts/_flash.html.erb (0.1ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|#19131] Completed 200 OK in 296ms (Views: 69.5ms | ActiveRecord: 0.0ms | API: 220.4ms (XML: 0.1ms , View: 2.1ms , Backend: 0.0ms , DB: 5.8ms , HTTP: 159.4ms) | XML: 2.3ms)
[[32mINFO [0m|#19131] Started GET "/project/show?project=home%3Aadrian" for 127.0.0.1 at 2012-10-08 12:26:41 +0200
[[32mINFO [0m|#19131] Processing by ProjectController#show as HTML
[[32mINFO [0m|#19131] Parameters: {"project"=>"home:adrian"}
[[0;37mDEBUG[0m|#19131] Setting return_to: "/project/show?project=home%3Aadrian"
[[0;37mDEBUG[0m|#19131] Authenticating with iChain mode: off
[[32mINFO [0m|#19131] Authenticated request to "/project/show?project=home%3Aadrian" from tom
[[0;37mDEBUG[0m|#19131] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#19131] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.47232300000000005, "db"=>0.757694, "backend"=>0, "xml"=>0, :runtime=>8.168999999999999, :all=>11.347149000000002}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.337689, "db"=>0.487082, "backend"=>0, "xml"=>0.035276, :runtime=>6.8919999999999995, :all=>47.973219}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.533568, "db"=>2.6143490000000003, "backend"=>0, "xml"=>0.023833999999999998, :runtime=>23.313, :all=>63.008277}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.480879, "db"=>2.0906029999999998, "backend"=>0, "xml"=>0.047181, :runtime=>16.048, :all=>58.997439}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=home%3Aadrian>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=home%3Aadrian
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.331588, "db"=>0.571129, "backend"=>0, "xml"=>0.034227, :runtime=>7.955, :all=>50.853819}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=target&project=home%3Aadrian>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=target&project=home%3Aadrian
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.375651, "db"=>0.5596300000000001, "backend"=>0, "xml"=>0.03519, :runtime=>6.872999999999999, :all=>47.419326999999996}
[[0;37mDEBUG[0m|#19131] Fetching request list from api
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=home%3Aadrian>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=home%3Aadrian
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.36534300000000003, "db"=>0.403981, "backend"=>0, "xml"=>0.032884, :runtime=>4.875, :all=>43.392843}
[[0;37mDEBUG[0m|#19131] --> direct_http url: #http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27home%3Aadrian%3A%27%29+and+%40kind%3D%27maintenance_incident%27+and+repository%2Freleasetarget%2F%40trigger%3D%27maintenance%27>
[[0;37mDEBUG[0m|#19131] http_do #1: method: GET url: http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27home%...
[[0;37mDEBUG[0m|#19131] RT {"view"=>0.639031, "db"=>1.369211, "backend"=>0, "xml"=>0.06969, :runtime=>13.748, :all=>55.667976}
[[0;37mDEBUG[0m|#19131] [REST] find( Buildresult, [{:project=>"home:adrian", :view=>"status", :code=>["failed", "broken", "unresolvable"]}] )
[[0;37mDEBUG[0m|#19131] http_do #1: method: get url: http://localhost:3203/build/home:adrian/_result?view=status&code=failed&code=broken&code=unresolvable
[[0;37mDEBUG[0m|#19131] RT {"view"=>nil, "db"=>0.576883, "backend"=>0, "xml"=>0, :runtime=>77.174, :all=>118.51977199999999}
[[0;37mDEBUG[0m|#19131] Buildresult.find( {:project=>"home:adrian", :view=>"status", :code=>["failed", "broken", "unresolvable"]} ) did not find anything, return nil
[[31mERROR[0m|#19131] rescue_action: caught NoMethodError: undefined method `elements' for {}:Hash
[[0;37mDEBUG[0m|#19131] ERROR: unknown; undefined method `elements' for {}:Hash
[[0;37mDEBUG[0m|#19131] http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/contr...:281:in `block (2 levels) in show'
/usr/lib64/ruby/gems/1.9.1/gems/xmlhash-1.3.0/lib/xmlhash.rb:24:in `elements'
http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/contr...:280:in `block in show'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/cache.rb:297:in `block in fetch'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/cache.rb:520:in `instrument'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-3.2.8/lib/active_support/cache.rb:296:in `fetch'
http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/contr...:274:in `show'
/usr/lib64/ruby/gems/1.9.1/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:4: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:524:in `_run__21218560515736917__process_action__272469748476272265__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__3338227249702356378__call__2959151665265279285__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.1/lib/rack/mock_session.rb:30:in `request'
/usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.1/lib/rack/test.rb:219:in `process_request'
/usr/lib64/ruby/gems/1.9.1/gems/rack-test-0.6.1/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/func...: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__126053493682792556__setup__2959151665265279285__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|#19131] Rendered layouts/_watch_and_search.html.erb (1.2ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/layouts/_header.html.erb (2.3ms)
[[32mINFO [0m|#19131] Rendered layouts/_personal_navigation.html.erb (1.1ms)
[[32mINFO [0m|#19131] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|#19131] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|#19131] Completed 400 Bad Request in 519ms (Views: 9.8ms | ActiveRecord: 0.0ms | API: 497.2ms (XML: 0.3ms , View: 3.5ms , Backend: 0.0ms , DB: 9.4ms , HTTP: 332.1ms) | XML: 0.9ms)
[[32mINFO [0m|#19131] Started POST "/user/logout" for 127.0.0.1 at 2012-10-08 12:26:41 +0200
[[32mINFO [0m|#19131] Processing by UserController#logout as HTML
[[0;37mDEBUG[0m|#19131] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#19131] Authenticating with iChain mode: off
[[32mINFO [0m|#19131] Authenticated request to "/user/logout" from tom
[[32mINFO [0m|#19131] Logging out: tom
[[32mINFO [0m|#19131] Redirected to http://example.org/
[[32mINFO [0m|#19131] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|#19131] [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