See http://ci.opensuse.org/job/obs_master_testsuite_webui/669/changes
Changes:
[Stephan Kulow] [ci] downgrade to firefox 11 on travis
------------------------------------------
[...truncated 21562 lines...]
<person>
<login>tom</login>
<email>tschmidt@suse.de</email>
<realname>Tom Thunder</realname>
<watchlist/>
</person>
[[32mINFO [0m|# 2741] Completed 500 Internal Server Error in 108ms
[[0;37mDEBUG[0m|# 2741] --> direct_http url: #http://localhost:3203/test/test_start>
[[0;37mDEBUG[0m|# 2741] http_do #1: method: GET url: http://localhost:3203/test/test_start
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/test/test_start {"view"=>0.887003, "db"=>0.090375, "backend"=>0, "xml"=>0, :runtime=>4.053, :all=>23.334196000000002}
[[32mINFO [0m|# 2741] Started GET "/" for 127.0.0.1 at 2012-11-23 18:13:52 +0100
[[32mINFO [0m|# 2741] Processing by MainController#index as HTML
[[0;37mDEBUG[0m|# 2741] Setting return_to: "/"
[[0;37mDEBUG[0m|# 2741] Authenticating with iChain mode: off
[[32mINFO [0m|# 2741] Anonymous request to /
[[0;37mDEBUG[0m|# 2741] returning [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] from rails cache Statusmessage_753097322d9cc873836d791589547e90
[[0;37mDEBUG[0m|# 2741] returning [{:limit=>"6", :shared=>"true"}] from rails cache LatestUpdated_ee34770dc62e51dca62baed2d5258b33
[[32mINFO [0m|# 2741] Rendered main/_news.html.erb (0.6ms)
[[32mINFO [0m|# 2741] Rendered main/_contact.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered main/_latest_updates.erb (5.5ms)
[[32mINFO [0m|# 2741] Rendered main/_countdown.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered main/_sponsors.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered main/_feeds.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered layouts/_watch_and_search.html.erb (0.7ms)
[[32mINFO [0m|# 2741] Rendered layouts/_header.html.erb (1.4ms)
[[32mINFO [0m|# 2741] Rendered layouts/_personal_navigation.html.erb (1.4ms)
[[32mINFO [0m|# 2741] Rendered layouts/_flash.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered layouts/_sponsor.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Completed 200 OK in 44ms (Views: 41.0ms | ActiveRecord: 0.0ms | API: 126.5ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 18.7ms , HTTP: 44.4ms) | XML: 1.3ms)
[[32mINFO [0m|# 2741] Started GET "/main/systemstatus" for 127.0.0.1 at 2012-11-23 18:13:52 +0100
[[32mINFO [0m|# 2741] Processing by MainController#systemstatus as */*
[[0;37mDEBUG[0m|# 2741] Setting return_to: "/main/systemstatus"
[[0;37mDEBUG[0m|# 2741] Authenticating with iChain mode: off
[[32mINFO [0m|# 2741] Anonymous request to /main/systemstatus
[[0;37mDEBUG[0m|# 2741] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a
[[0;37mDEBUG[0m|# 2741] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4
[[32mINFO [0m|# 2741] Rendered main/_systemstatus.html.erb (1.5ms)
[[32mINFO [0m|# 2741] Completed 200 OK in 3ms (Views: 2.2ms | ActiveRecord: 0.0ms | XML: 0.6ms)
[[32mINFO [0m|# 2741] Started POST "/user/do_login" for 127.0.0.1 at 2012-11-23 18:13:52 +0100
[[32mINFO [0m|# 2741] Processing by UserController#do_login as HTML
[[32mINFO [0m|# 2741] Parameters: {"utf8"=>"���", "return_to_path"=>"/", "username"=>"tom", "password"=>"[FILTERED]", "commit"=>"Login"}
[[0;37mDEBUG[0m|# 2741] Setting return_to: "/"
[[0;37mDEBUG[0m|# 2741] Authenticating with iChain mode: off
[[32mINFO [0m|# 2741] Anonymous request to /
[[0;37mDEBUG[0m|# 2741] Doing form authorization to login user tom
[[0;37mDEBUG[0m|# 2741] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|# 2741] params {:login=>"tom"}
[[0;37mDEBUG[0m|# 2741] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|# 2741] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/person/tom {"view"=>0.60014, "db"=>0.847128, "backend"=>0, "xml"=>0, :runtime=>10.354000000000001, :all=>30.23144}
[[32mINFO [0m|# 2741] Redirected to http://127.0.0.1:57073/
[[32mINFO [0m|# 2741] Completed 302 Found in 33ms (ActiveRecord: 0.0ms | API: 30.2ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 0.8ms , HTTP: 19.9ms) | XML: 0.1ms)
[[32mINFO [0m|# 2741] Started GET "/" for 127.0.0.1 at 2012-11-23 18:13:53 +0100
[[32mINFO [0m|# 2741] Processing by MainController#index as HTML
[[0;37mDEBUG[0m|# 2741] Setting return_to: "/"
[[0;37mDEBUG[0m|# 2741] Authenticating with iChain mode: off
[[32mINFO [0m|# 2741] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|# 2741] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|# 2741] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|# 2741] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|# 2741] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|# 2741] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/person/tom {"view"=>0.5829989999999999, "db"=>1.363978, "backend"=>0, "xml"=>0, :runtime=>10.815999999999999, :all=>23.719884}
[[0;37mDEBUG[0m|# 2741] --> direct_http url: #http://localhost:3203/webui/person_requests_that_need_work?login=tom>
[[0;37mDEBUG[0m|# 2741] http_do #1: method: GET url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>9.578321, "db"=>25.631963000000002, "backend"=>0, "xml"=>0, :runtime=>75.644, :all=>88.107255}
[[0;37mDEBUG[0m|# 2741] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|# 2741] returning [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] from rails cache Statusmessage_753097322d9cc873836d791589547e90
[[0;37mDEBUG[0m|# 2741] returning [{:limit=>"6", :shared=>"true"}] from rails cache LatestUpdated_ee34770dc62e51dca62baed2d5258b33
[[0;37mDEBUG[0m|# 2741] returning [{:name=>"home:tom"}] from rails cache Project_aadf1ec049c50614647e4261c26bfa68
[[32mINFO [0m|# 2741] Rendered main/_news.html.erb (0.8ms)
[[32mINFO [0m|# 2741] Rendered main/_contact.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered main/_latest_updates.erb (14.0ms)
[[32mINFO [0m|# 2741] Rendered main/_countdown.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered main/_sponsors.html.erb (0.0ms)
[[32mINFO [0m|# 2741] Rendered main/_feeds.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered layouts/_watch_and_search.html.erb (0.8ms)
[[32mINFO [0m|# 2741] Rendered layouts/_header.html.erb (1.6ms)
[[32mINFO [0m|# 2741] Rendered layouts/_personal_navigation.html.erb (1.1ms)
[[32mINFO [0m|# 2741] Rendered layouts/_flash.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered layouts/_sponsor.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Completed 200 OK in 144ms (Views: 28.1ms | ActiveRecord: 0.0ms | API: 111.8ms (XML: 0.0ms , View: 10.2ms , Backend: 0.0ms , DB: 27.0ms , HTTP: 25.4ms) | XML: 0.8ms)
[[32mINFO [0m|# 2741] Started GET "/main/systemstatus" for 127.0.0.1 at 2012-11-23 18:13:53 +0100
[[32mINFO [0m|# 2741] Processing by MainController#systemstatus as */*
[[0;37mDEBUG[0m|# 2741] Setting return_to: "/main/systemstatus"
[[0;37mDEBUG[0m|# 2741] Authenticating with iChain mode: off
[[32mINFO [0m|# 2741] Authenticated request to "/main/systemstatus" from tom
[[0;37mDEBUG[0m|# 2741] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|# 2741] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|# 2741] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|# 2741] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|# 2741] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/person/tom {"view"=>11.846051999999998, "db"=>0.502892, "backend"=>0, "xml"=>0, :runtime=>23.566, :all=>39.306571}
[[0;37mDEBUG[0m|# 2741] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a
[[0;37mDEBUG[0m|# 2741] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4
[[32mINFO [0m|# 2741] Rendered main/_systemstatus.html.erb (1.2ms)
[[32mINFO [0m|# 2741] Completed 200 OK in 43ms (Views: 1.7ms | ActiveRecord: 0.0ms | API: 39.3ms (XML: 0.0ms , View: 11.8ms , Backend: 0.0ms , DB: 0.5ms , HTTP: 15.7ms) | XML: 0.4ms)
[[32mINFO [0m|# 2741] Started GET "/project/show?project=BaseDistro" for 127.0.0.1 at 2012-11-23 18:13:53 +0100
[[32mINFO [0m|# 2741] Processing by ProjectController#show as HTML
[[32mINFO [0m|# 2741] Parameters: {"project"=>"BaseDistro"}
[[0;37mDEBUG[0m|# 2741] Setting return_to: "/project/show?project=BaseDistro"
[[0;37mDEBUG[0m|# 2741] Authenticating with iChain mode: off
[[32mINFO [0m|# 2741] Authenticated request to "/project/show?project=BaseDistro" from tom
[[0;37mDEBUG[0m|# 2741] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|# 2741] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|# 2741] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|# 2741] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|# 2741] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/person/tom {"view"=>0.443841, "db"=>6.821813, "backend"=>0, "xml"=>0, :runtime=>20.445, :all=>33.841446}
[[0;37mDEBUG[0m|# 2741] --> direct_http url: #http://localhost:3203/webui/person_requests_that_need_work?login=tom>
[[0;37mDEBUG[0m|# 2741] http_do #1: method: GET url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.204862, "db"=>3.2491390000000004, "backend"=>0, "xml"=>0, :runtime=>42.261, :all=>61.363304}
[[0;37mDEBUG[0m|# 2741] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|# 2741] --> direct_http url: #http://localhost:3203/webui/project_infos?project=BaseDistro>
[[0;37mDEBUG[0m|# 2741] http_do #1: method: GET url: http://localhost:3203/webui/project_infos?project=BaseDistro
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/webui/project_infos?project=BaseDistro {"view"=>0.434459, "db"=>16.562952000000003, "backend"=>0, "xml"=>0, :runtime=>99.619, :all=>120.39480900000001}
[[0;37mDEBUG[0m|# 2741] data {
"name": "BaseDistro",
"packages": [
[
"pack1",
null
],
[
"pack2",
null
],
[
"pack3",
null
]
],
"xml": "\n <title>This is a base distro</title>\n <description>This could be openSUSE:11.2 project for example</description>\n \n \n <arch>i586</arch>\n </repository>\n</project>\n",
"maintenance_project": "My:Maintenance",
"linking_projects": [
"BaseDistro:Update"
],
"requests": [
],
"nr_of_problem_packages": 0
}
[[32mINFO [0m|# 2741] Rendered project/_tabs.html.erb (19.1ms)
[[32mINFO [0m|# 2741] Rendered shared/_open_requests.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered shared/_buildresult_box.html.erb (0.7ms)
[[32mINFO [0m|# 2741] Rendered layouts/_watch_and_search.html.erb (1.1ms)
[[32mINFO [0m|# 2741] Rendered layouts/_header.html.erb (2.1ms)
[[32mINFO [0m|# 2741] Rendered layouts/_personal_navigation.html.erb (1.0ms)
[[32mINFO [0m|# 2741] Rendered layouts/_flash.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Rendered layouts/_sponsor.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Completed 200 OK in 288ms (Views: 55.2ms | ActiveRecord: 0.0ms | API: 215.6ms (XML: 0.0ms , View: 1.1ms , Backend: 0.0ms , DB: 26.6ms , HTTP: 53.3ms) | XML: 0.5ms)
[[32mINFO [0m|# 2741] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2012-11-23 18:13:54 +0100
[[32mINFO [0m|# 2741] Processing by ProjectController#buildresult as */*
[[32mINFO [0m|# 2741] Parameters: {"project"=>"BaseDistro", "index"=>""}
[[0;37mDEBUG[0m|# 2741] Setting return_to: "/project/buildresult?project=BaseDistro&index="
[[0;37mDEBUG[0m|# 2741] Authenticating with iChain mode: off
[[32mINFO [0m|# 2741] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom
[[0;37mDEBUG[0m|# 2741] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|# 2741] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|# 2741] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|# 2741] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|# 2741] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/person/tom {"view"=>0.868243, "db"=>0.0, "backend"=>0, "xml"=>0, :runtime=>12.14, :all=>29.569070999999997}
[[0;37mDEBUG[0m|# 2741] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e
[[0;37mDEBUG[0m|# 2741] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935
[[0;37mDEBUG[0m|# 2741] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] )
[[0;37mDEBUG[0m|# 2741] params {:project=>"BaseDistro", :view=>"summary"}
[[0;37mDEBUG[0m|# 2741] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild&:arch&:repository
[[0;37mDEBUG[0m|# 2741] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.0, "backend"=>0, "xml"=>0, :runtime=>202.09, :all=>226.232226}
[[32mINFO [0m|# 2741] Rendered project/_buildstatus.html.erb (0.1ms)
[[32mINFO [0m|# 2741] Completed 200 OK in 259ms (Views: 0.7ms | ActiveRecord: 0.0ms | API: 255.8ms (XML: 0.0ms , View: 0.9ms , Backend: 0.0ms , DB: 0.0ms , HTTP: 41.6ms) | XML: 0.2ms)
[[32mINFO [0m|# 2741] Started GET "/project/toggle_watch?project=BaseDistro" for 127.0.0.1 at 2012-11-23 18:13:54 +0100
[[32mINFO [0m|# 2741] Processing by ProjectController#toggle_watch as HTML
[[32mINFO [0m|# 2741] Parameters: {"project"=>"BaseDistro"}
[[0;37mDEBUG[0m|# 2741] Setting return_to: "/project/toggle_watch?project=BaseDistro"
[[0;37mDEBUG[0m|# 2741] Authenticating with iChain mode: off
[[32mINFO [0m|# 2741] Authenticated request to "/project/toggle_watch?project=BaseDistro" from tom
[[0;37mDEBUG[0m|# 2741] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|# 2741] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|# 2741] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|# 2741] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|# 2741] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/person/tom {"view"=>0.453021, "db"=>1.0885269999999998, "backend"=>0, "xml"=>0, :runtime=>9.34, :all=>27.940469}
[[0;37mDEBUG[0m|# 2741] --> direct_http url: #http://localhost:3203/webui/person_requests_that_need_work?login=tom>
[[0;37mDEBUG[0m|# 2741] http_do #1: method: GET url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|# 2741] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>10.034393000000001, "db"=>9.051498000000002, "backend"=>0, "xml"=>0, :runtime=>54.997, :all=>68.222509}
[[0;37mDEBUG[0m|# 2741] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|# 2741] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e
[[0;37mDEBUG[0m|# 2741] Add BaseDistro to watchlist for tom
[[0;37mDEBUG[0m|# 2741] user 'tom' is now watching project 'BaseDistro'
[[0;37mDEBUG[0m|# 2741] saving object Person ({:is_current=>"true", :login=>"tom"}) to api:
<person>
<login>tom</login>
<email>tschmidt@suse.de</email>
<realname>Thor</realname>
<watchlist><project name="BaseDistro"/></watchlist>
</person>
[[32mINFO [0m|# 2741] Completed 500 Internal Server Error in 250ms
+ echo
+ cleanup
+ echo 'Killing backend processes'
Killing backend processes
+ egrep 'perl|ruby'
+ fuser -v http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/
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/scheduler.done src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/capybara 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