See http://ci.opensuse.org/job/obs_master_testsuite_webui/881/
------------------------------------------
[...truncated 651856 lines...]
[[32mINFO [0m|#20919] Rendered layouts/_header.html.erb (1.9ms)
[[32mINFO [0m|#20919] Rendered layouts/_personal_navigation.html.erb (1.0ms)
[[32mINFO [0m|#20919] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|#20919] Completed 200 OK in 261ms (Views: 14.7ms | ActiveRecord: 0.0ms | API: 242.2ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 8.7ms , HTTP: 79.8ms) | XML: 0.6ms)
[[32mINFO [0m|#20919] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-04-15 17:03:56 +0000
[[32mINFO [0m|#20919] Processing by ProjectController#buildresult as */*
[[32mINFO [0m|#20919] Parameters: {"project"=>"BaseDistro", "index"=>""}
[[0;37mDEBUG[0m|#20919] Setting return_to: "/project/buildresult?project=BaseDistro&index="
[[0;37mDEBUG[0m|#20919] Authenticating with iChain mode: off
[[32mINFO [0m|#20919] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom
[[0;37mDEBUG[0m|#20919] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|#20919] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#20919] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|#20919] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/person/tom {"view"=>0.559848, "db"=>1.688345, "backend"=>0, "xml"=>0, :runtime=>13.051, :all=>16.562987}
[[0;37mDEBUG[0m|#20919] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e
[[0;37mDEBUG[0m|#20919] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935
[[0;37mDEBUG[0m|#20919] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] )
[[0;37mDEBUG[0m|#20919] params {:project=>"BaseDistro", :view=>"summary"}
[[0;37mDEBUG[0m|#20919] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild&:arch&:repository
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.686735, "backend"=>0, "xml"=>0, :runtime=>25.068, :all=>66.925019}
[[32mINFO [0m|#20919] Rendered project/_buildstatus.html.erb (0.1ms)
[[32mINFO [0m|#20919] Completed 200 OK in 88ms (Views: 1.1ms | ActiveRecord: 0.0ms | API: 83.5ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 2.4ms , HTTP: 45.4ms) | XML: 0.3ms)
[[32mINFO [0m|#20919] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-15 17:03:56 +0000
[[32mINFO [0m|#20919] Processing by ProjectController#show as HTML
[[32mINFO [0m|#20919] Parameters: {"project"=>"My:Maintenance"}
[[0;37mDEBUG[0m|#20919] Setting return_to: "/project/show?project=My%3AMaintenance"
[[0;37mDEBUG[0m|#20919] Authenticating with iChain mode: off
[[32mINFO [0m|#20919] Authenticated request to "/project/show?project=My%3AMaintenance" from tom
[[0;37mDEBUG[0m|#20919] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|#20919] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#20919] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|#20919] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/person/tom {"view"=>0.5744170000000001, "db"=>2.0262860000000003, "backend"=>0, "xml"=>0, :runtime=>15.375, :all=>54.590697}
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.27863699999999997, "db"=>4.1481010000000005, "backend"=>0, "xml"=>0, :runtime=>29.478, :all=>70.80732}
[[0;37mDEBUG[0m|#20919] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.424071, "db"=>3.7244450000000002, "backend"=>0, "xml"=>0, :runtime=>39.625, :all=>79.53146199999999}
[[0;37mDEBUG[0m|#20919] data {
"name": "My:Maintenance",
"packages": [
],
"xml": "\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n \n <maintenance>\n \n \n \n </maintenance>\n</project>\n",
"incidents": [
],
"maintained_projects": [
"BaseDistro",
"BaseDistro2.0:LinkedUpdateProject",
"BaseDistro3"
],
"linking_projects": [
],
"requests": [
],
"nr_of_problem_packages": 0
}
[[0;37mDEBUG[0m|#20919] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02
[[32mINFO [0m|#20919] Rendered project/_tabs.html.erb (2.2ms)
[[32mINFO [0m|#20919] Rendered shared/_open_requests.html.erb (0.0ms)
[[32mINFO [0m|#20919] Rendered layouts/_watch_and_search.html.erb (1.1ms)
[[32mINFO [0m|#20919] Rendered layouts/_header.html.erb (1.9ms)
[[32mINFO [0m|#20919] Rendered layouts/_personal_navigation.html.erb (1.0ms)
[[32mINFO [0m|#20919] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|#20919] Completed 200 OK in 222ms (Views: 12.1ms | ActiveRecord: 0.0ms | API: 204.9ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 9.9ms , HTTP: 120.5ms) | XML: 0.5ms)
[[32mINFO [0m|#20919] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-15 17:03:56 +0000
[[32mINFO [0m|#20919] Processing by ProjectController#toggle_watch as HTML
[[32mINFO [0m|#20919] Parameters: {"project"=>"My:Maintenance"}
[[0;37mDEBUG[0m|#20919] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance"
[[0;37mDEBUG[0m|#20919] Authenticating with iChain mode: off
[[32mINFO [0m|#20919] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom
[[0;37mDEBUG[0m|#20919] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|#20919] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#20919] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|#20919] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/person/tom {"view"=>0.7351989999999999, "db"=>1.873072, "backend"=>0, "xml"=>0, :runtime=>18.258, :all=>22.028478}
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.295433, "db"=>5.235835000000001, "backend"=>0, "xml"=>0, :runtime=>42.652, :all=>84.4165}
[[0;37mDEBUG[0m|#20919] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|#20919] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb
[[0;37mDEBUG[0m|#20919] Remove My:Maintenance from watchlist for tom
[[0;37mDEBUG[0m|#20919] user 'tom' removes project 'My:Maintenance' from watchlist
[[0;37mDEBUG[0m|#20919] saving object Person ({:is_current=>"true", :login=>"tom"}) to api:
<person>
<login>tom</login>
<email>tschmidt@suse.de</email>
<realname>Thor</realname>
<state>confirmed</state>
<watchlist>
</watchlist>
</person>
[[0;37mDEBUG[0m|#20919] http_do #1: method: put url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/person/tom {"view"=>0.9209240000000001, "db"=>2.03923, "backend"=>0, "xml"=>0, :runtime=>16.146, :all=>20.940378}
[[0;37mDEBUG[0m|#20919] [REST] find( PersonGroup, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#20919] params {:login=>"tom"}
[[0;37mDEBUG[0m|#20919] uri is: http://localhost:3203/person/:login/group
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/person/tom/group
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/person/tom/group {"view"=>0.36048800000000003, "db"=>0.754413, "backend"=>0, "xml"=>0, :runtime=>6.874, :all=>10.834010999999999}
[[0;37mDEBUG[0m|#20919] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08
[[0;37mDEBUG[0m|#20919] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54
[[32mINFO [0m|#20919] Redirected to http://127.0.0.1:32891/project/show?project=My%3AMaintenance
[[32mINFO [0m|#20919] Completed 302 Found in 143ms (ActiveRecord: 0.0ms | API: 138.2ms (XML: 0.0ms , View: 2.3ms , Backend: 0.0ms , DB: 9.9ms , HTTP: 54.3ms) | XML: 0.4ms)
[[32mINFO [0m|#20919] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-15 17:03:56 +0000
[[32mINFO [0m|#20919] Processing by ProjectController#show as HTML
[[32mINFO [0m|#20919] Parameters: {"project"=>"My:Maintenance"}
[[0;37mDEBUG[0m|#20919] Setting return_to: "/project/show?project=My%3AMaintenance"
[[0;37mDEBUG[0m|#20919] Authenticating with iChain mode: off
[[32mINFO [0m|#20919] Authenticated request to "/project/show?project=My%3AMaintenance" from tom
[[0;37mDEBUG[0m|#20919] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|#20919] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#20919] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|#20919] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/person/tom {"view"=>0.504677, "db"=>1.001201, "backend"=>0, "xml"=>0, :runtime=>8.874, :all=>49.378871999999994}
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.24766300000000002, "db"=>3.8476669999999995, "backend"=>0, "xml"=>0, :runtime=>28.413, :all=>66.793288}
[[0;37mDEBUG[0m|#20919] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.41648999999999997, "db"=>3.5480940000000003, "backend"=>0, "xml"=>0, :runtime=>29.367, :all=>67.47896200000001}
[[0;37mDEBUG[0m|#20919] data {
"name": "My:Maintenance",
"packages": [
],
"xml": "\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n \n <maintenance>\n \n \n \n </maintenance>\n</project>\n",
"incidents": [
],
"maintained_projects": [
"BaseDistro",
"BaseDistro2.0:LinkedUpdateProject",
"BaseDistro3"
],
"linking_projects": [
],
"requests": [
],
"nr_of_problem_packages": 0
}
[[0;37mDEBUG[0m|#20919] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02
[[32mINFO [0m|#20919] Rendered project/_tabs.html.erb (2.0ms)
[[32mINFO [0m|#20919] Rendered shared/_open_requests.html.erb (0.0ms)
[[32mINFO [0m|#20919] Rendered layouts/_watch_and_search.html.erb (0.8ms)
[[32mINFO [0m|#20919] Rendered layouts/_header.html.erb (1.5ms)
[[32mINFO [0m|#20919] Rendered layouts/_personal_navigation.html.erb (1.0ms)
[[32mINFO [0m|#20919] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|#20919] Completed 200 OK in 200ms (Views: 11.7ms | ActiveRecord: 0.0ms | API: 183.7ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 8.4ms , HTTP: 117.0ms) | XML: 0.5ms)
[[32mINFO [0m|#20919] Started POST "/user/logout" for 127.0.0.1 at 2013-04-15 17:03:56 +0000
[[32mINFO [0m|#20919] Processing by UserController#logout as HTML
[[0;37mDEBUG[0m|#20919] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#20919] Authenticating with iChain mode: off
[[32mINFO [0m|#20919] Authenticated request to "/user/logout" from tom
[[32mINFO [0m|#20919] Logging out: tom
[[32mINFO [0m|#20919] Redirected to http://127.0.0.1:32891/
[[0;37mDEBUG[0m|#20919] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#20919] Completed 302 Found in 13ms (ActiveRecord: 11.5ms | XML: 0.0ms)
[[32mINFO [0m|#20919] Started GET "/" for 127.0.0.1 at 2013-04-15 17:03:56 +0000
[[32mINFO [0m|#20919] Processing by MainController#index as HTML
[[0;37mDEBUG[0m|#20919] Setting return_to: "/"
[[0;37mDEBUG[0m|#20919] Authenticating with iChain mode: off
[[32mINFO [0m|#20919] Anonymous request to /
[[0;37mDEBUG[0m|#20919] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] Statusmessage_2fe508b303b3ed792c174b7580cb295c
[[0;37mDEBUG[0m|#20919] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] )
[[0;37mDEBUG[0m|#20919] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}
[[0;37mDEBUG[0m|#20919] uri is: http://localhost:3203/status/messages/:id/?:limit
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=4
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/status/messages/?limit=4 {"view"=>0.698264, "db"=>0.505081, "backend"=>0, "xml"=>0, :runtime=>5.771, :all=>8.755054}
[[0;37mDEBUG[0m|#20919] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33
[[0;37mDEBUG[0m|#20919] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] )
[[0;37mDEBUG[0m|#20919] params {:limit=>"6", :shared=>"true"}
[[0;37mDEBUG[0m|#20919] uri is: http://localhost:3203/statistics/latest_updated?:limit
[[0;37mDEBUG[0m|#20919] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.149141, "db"=>2.0067530000000002, "backend"=>0, "xml"=>0, :runtime=>15.825, :all=>57.053787}
[[32mINFO [0m|#20919] Rendered shared/_sign_up.html.erb (1.0ms)
[[32mINFO [0m|#20919] Rendered main/_sponsors.html.erb (0.1ms)
[[32mINFO [0m|#20919] Rendered main/_news.html.erb (0.2ms)
[[32mINFO [0m|#20919] Rendered main/_latest_updates.erb (4.1ms)
[[32mINFO [0m|#20919] Rendered layouts/_watch_and_search.html.erb (0.5ms)
[[32mINFO [0m|#20919] Rendered layouts/_header.html.erb (1.1ms)
[[32mINFO [0m|#20919] Rendered layouts/_personal_navigation.html.erb (1.2ms)
[[32mINFO [0m|#20919] Rendered layouts/_flash.html.erb (0.1ms)
[[32mINFO [0m|#20919] Completed 200 OK in 84ms (Views: 14.2ms | ActiveRecord: 0.0ms | API: 65.8ms (XML: 0.0ms , View: 1.8ms , Backend: 0.0ms , DB: 2.5ms , HTTP: 44.2ms) | XML: 0.9ms)
[[32mINFO [0m|#20919] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-04-15 17:03:57 +0000
[[32mINFO [0m|#20919] Processing by MainController#systemstatus as */*
[[0;37mDEBUG[0m|#20919] Setting return_to: "/main/systemstatus"
[[0;37mDEBUG[0m|#20919] Authenticating with iChain mode: off
[[32mINFO [0m|#20919] Anonymous request to /main/systemstatus
[[0;37mDEBUG[0m|#20919] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a
[[0;37mDEBUG[0m|#20919] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4
[[32mINFO [0m|#20919] Rendered main/_systemstatus.html.erb (1.1ms)
[[32mINFO [0m|#20919] Completed 200 OK in 3ms (Views: 1.6ms | ActiveRecord: 0.0ms | XML: 0.3ms)
[[0;37mDEBUG[0m|#20919] http_do #1: method: post url: http://localhost:3203/test/test_end
[[0;37mDEBUG[0m|#20919] RT http://localhost:3203/test/test_end {"view"=>0.773522, "db"=>31.793815000000002, "backend"=>0, "xml"=>0, :runtime=>36.205, :all=>44.086511}
+ echo
+ cleanup
+ echo 'Killing backend processes'
Killing backend processes
+ egrep 'perl|ruby'
+ fuser -v http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/
+ 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/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