[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #868
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/868/changes> Changes: [Stephan Kulow] [webui] fix the spider test - so it actually finds problems [ro] [backend] use nosource to limit amount of download for aggregated packages [ro] [backend] pass on nosource option in getbinarylist also in bs_srcserver [mls] [backend] stage metacache changes in metacache.merge [mls] [backend] fix error in addrev_meta_multiple use [mls] [backend] fix typo in nosource commit ------------------------------------------ [...truncated 571322 lines...] [[32mINFO [0m|# 7282] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 7282] Completed 200 OK in 257ms (Views: 90.1ms | ActiveRecord: 0.0ms | API: 161.2ms (XML: 0.0ms , View: 1.7ms , Backend: 0.0ms , DB: 8.1ms , HTTP: 84.9ms) | XML: 0.7ms) [[32mINFO [0m|# 7282] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-03-21 14:53:41 +0000 [[32mINFO [0m|# 7282] Processing by ProjectController#buildresult as */* [[32mINFO [0m|# 7282] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|# 7282] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|# 7282] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 7282] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>0.526182, "db"=>1.8090789999999999, "backend"=>0, "xml"=>0, :runtime=>13.499, :all=>17.014729} [[0;37mDEBUG[0m|# 7282] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|# 7282] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|# 7282] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|# 7282] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.7893340000000001, "backend"=>0, "xml"=>0, :runtime=>19.373, :all=>59.264576} [[32mINFO [0m|# 7282] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|# 7282] Completed 200 OK in 80ms (Views: 0.9ms | ActiveRecord: 0.0ms | API: 76.3ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.6ms , HTTP: 43.4ms) | XML: 0.3ms) [[32mINFO [0m|# 7282] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 14:53:41 +0000 [[32mINFO [0m|# 7282] Processing by ProjectController#show as HTML [[32mINFO [0m|# 7282] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 7282] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 7282] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 7282] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>0.509317, "db"=>1.558147, "backend"=>0, "xml"=>0, :runtime=>14.506, :all=>54.640774} [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.24296199999999998, "db"=>3.9446710000000005, "backend"=>0, "xml"=>0, :runtime=>29.45, :all=>70.911661} [[0;37mDEBUG[0m|# 7282] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.466058, "db"=>3.6690599999999995, "backend"=>0, "xml"=>0, :runtime=>36.507, :all=>75.457097} [[0;37mDEBUG[0m|# 7282] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|# 7282] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 7282] Rendered project/_tabs.html.erb (3.1ms) [[32mINFO [0m|# 7282] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|# 7282] Rendered layouts/_watch_and_search.html.erb (1.6ms) [[32mINFO [0m|# 7282] Rendered layouts/_header.html.erb (2.7ms) [[32mINFO [0m|# 7282] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|# 7282] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 7282] Completed 200 OK in 223ms (Views: 15.9ms | ActiveRecord: 0.0ms | API: 201.0ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 9.2ms , HTTP: 120.5ms) | XML: 0.7ms) [[32mINFO [0m|# 7282] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 14:53:41 +0000 [[32mINFO [0m|# 7282] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|# 7282] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 7282] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 7282] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 7282] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>0.602097, "db"=>1.821777, "backend"=>0, "xml"=>0, :runtime=>14.199, :all=>17.660036} [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.32462, "db"=>4.5410889999999995, "backend"=>0, "xml"=>0, :runtime=>142.705, :all=>183.159501} [[0;37mDEBUG[0m|# 7282] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 7282] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|# 7282] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|# 7282] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|# 7282] 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|# 7282] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>1.103113, "db"=>2.131732, "backend"=>0, "xml"=>0, :runtime=>17.848, :all=>23.226153999999998} [[0;37mDEBUG[0m|# 7282] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom/group {"view"=>0.36086, "db"=>0.647575, "backend"=>0, "xml"=>0, :runtime=>6.675000000000001, :all=>9.944028000000001} [[0;37mDEBUG[0m|# 7282] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|# 7282] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|# 7282] Redirected to http://127.0.0.1:44015/project/show?project=My%3AMaintenance [[32mINFO [0m|# 7282] Completed 302 Found in 239ms (ActiveRecord: 0.0ms | API: 234.0ms (XML: 0.0ms , View: 2.4ms , Backend: 0.0ms , DB: 9.1ms , HTTP: 52.6ms) | XML: 0.4ms) [[32mINFO [0m|# 7282] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 14:53:41 +0000 [[32mINFO [0m|# 7282] Processing by ProjectController#show as HTML [[32mINFO [0m|# 7282] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 7282] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 7282] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 7282] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>0.46093399999999995, "db"=>0.883327, "backend"=>0, "xml"=>0, :runtime=>8.106, :all=>47.822797} [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.270922, "db"=>3.962192, "backend"=>0, "xml"=>0, :runtime=>30.964, :all=>74.47841299999999} [[0;37mDEBUG[0m|# 7282] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.5360739999999999, "db"=>3.510239, "backend"=>0, "xml"=>0, :runtime=>41.09, :all=>83.278065} [[0;37mDEBUG[0m|# 7282] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|# 7282] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 7282] Rendered project/_tabs.html.erb (2.2ms) [[32mINFO [0m|# 7282] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|# 7282] Rendered layouts/_watch_and_search.html.erb (1.0ms) [[32mINFO [0m|# 7282] Rendered layouts/_header.html.erb (2.1ms) [[32mINFO [0m|# 7282] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|# 7282] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|# 7282] Completed 200 OK in 225ms (Views: 14.0ms | ActiveRecord: 0.0ms | API: 205.6ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 8.4ms , HTTP: 125.4ms) | XML: 0.7ms) [[32mINFO [0m|# 7282] Started POST "/user/logout" for 127.0.0.1 at 2013-03-21 14:53:42 +0000 [[32mINFO [0m|# 7282] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|# 7282] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/user/logout" from tom [[32mINFO [0m|# 7282] Logging out: tom [[32mINFO [0m|# 7282] Redirected to http://127.0.0.1:44015/ [[0;37mDEBUG[0m|# 7282] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|# 7282] Completed 302 Found in 11ms (ActiveRecord: 9.0ms | XML: 0.0ms) [[32mINFO [0m|# 7282] Started GET "/" for 127.0.0.1 at 2013-03-21 14:53:42 +0000 [[32mINFO [0m|# 7282] Processing by MainController#index as HTML [[0;37mDEBUG[0m|# 7282] Setting return_to: "/" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Anonymous request to / [[0;37mDEBUG[0m|# 7282] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|# 7282] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] ) [[0;37mDEBUG[0m|# 7282] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=5 [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/status/messages/?limit=5 {"view"=>0.812403, "db"=>0.591463, "backend"=>0, "xml"=>0, :runtime=>6.44, :all=>9.687883} [[0;37mDEBUG[0m|# 7282] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|# 7282] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|# 7282] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.17608, "db"=>2.078695, "backend"=>0, "xml"=>0, :runtime=>17.068, :all=>59.391612} [[32mINFO [0m|# 7282] Rendered shared/_sign_up.html.erb (1.3ms) [[32mINFO [0m|# 7282] Rendered main/_news.html.erb (0.7ms) [[32mINFO [0m|# 7282] Rendered main/_latest_updates.erb (4.8ms) [[32mINFO [0m|# 7282] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|# 7282] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|# 7282] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|# 7282] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|# 7282] Rendered layouts/_header.html.erb (1.1ms) [[32mINFO [0m|# 7282] Rendered layouts/_personal_navigation.html.erb (1.3ms) [[32mINFO [0m|# 7282] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 7282] Completed 200 OK in 91ms (Views: 17.4ms | ActiveRecord: 0.0ms | API: 69.1ms (XML: 0.0ms , View: 2.0ms , Backend: 0.0ms , DB: 2.7ms , HTTP: 45.6ms) | XML: 1.1ms) [[32mINFO [0m|# 7282] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-03-21 14:53:42 +0000 [[32mINFO [0m|# 7282] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|# 7282] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|# 7282] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|# 7282] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|# 7282] Rendered main/_systemstatus.html.erb (1.2ms) [[32mINFO [0m|# 7282] Completed 200 OK in 3ms (Views: 1.8ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|# 7282] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/test/test_end {"view"=>1.046054, "db"=>24.348969000000004, "backend"=>0, "xml"=>0, :runtime=>29.276, :all=>35.565289} + 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/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/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
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/869/changes> Changes: [mls] [backend] do not look at jobs already in progress, add support for $BSConfig::signer_maxchild_flavor ------------------------------------------ [...truncated 571388 lines...] [[32mINFO [0m|#23878] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#23878] Completed 200 OK in 206ms (Views: 15.4ms | ActiveRecord: 0.0ms | API: 184.6ms (XML: 0.0ms , View: 1.9ms , Backend: 0.0ms , DB: 10.7ms , HTTP: 84.7ms) | XML: 0.7ms) [[32mINFO [0m|#23878] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-03-21 16:20:19 +0000 [[32mINFO [0m|#23878] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#23878] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#23878] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#23878] Authenticating with iChain mode: off [[32mINFO [0m|#23878] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#23878] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#23878] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#23878] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#23878] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/person/tom {"view"=>0.487458, "db"=>1.627763, "backend"=>0, "xml"=>0, :runtime=>12.853, :all=>16.65597} [[0;37mDEBUG[0m|#23878] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#23878] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#23878] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#23878] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#23878] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.5935590000000001, "backend"=>0, "xml"=>0, :runtime=>24.595, :all=>63.607776} [[32mINFO [0m|#23878] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#23878] Completed 200 OK in 84ms (Views: 0.8ms | ActiveRecord: 0.0ms | API: 80.3ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.2ms , HTTP: 42.8ms) | XML: 0.2ms) [[32mINFO [0m|#23878] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 16:20:19 +0000 [[32mINFO [0m|#23878] Processing by ProjectController#show as HTML [[32mINFO [0m|#23878] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#23878] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#23878] Authenticating with iChain mode: off [[32mINFO [0m|#23878] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#23878] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#23878] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#23878] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#23878] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/person/tom {"view"=>0.437301, "db"=>1.2925570000000002, "backend"=>0, "xml"=>0, :runtime=>11.793, :all=>53.273854} [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.239321, "db"=>3.5360990000000005, "backend"=>0, "xml"=>0, :runtime=>26.693, :all=>67.265332} [[0;37mDEBUG[0m|#23878] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.45186899999999997, "db"=>3.5222720000000005, "backend"=>0, "xml"=>0, :runtime=>36.613, :all=>79.468615} [[0;37mDEBUG[0m|#23878] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#23878] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#23878] Rendered project/_tabs.html.erb (2.9ms) [[32mINFO [0m|#23878] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|#23878] Rendered layouts/_watch_and_search.html.erb (1.7ms) [[32mINFO [0m|#23878] Rendered layouts/_header.html.erb (2.8ms) [[32mINFO [0m|#23878] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#23878] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#23878] Completed 200 OK in 220ms (Views: 15.6ms | ActiveRecord: 0.0ms | API: 200.0ms (XML: 0.0ms , View: 1.1ms , Backend: 0.0ms , DB: 8.4ms , HTTP: 124.9ms) | XML: 0.6ms) [[32mINFO [0m|#23878] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 16:20:20 +0000 [[32mINFO [0m|#23878] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#23878] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#23878] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#23878] Authenticating with iChain mode: off [[32mINFO [0m|#23878] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#23878] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#23878] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#23878] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#23878] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/person/tom {"view"=>0.657556, "db"=>1.403236, "backend"=>0, "xml"=>0, :runtime=>13.056, :all=>16.42176} [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.271752, "db"=>4.551113, "backend"=>0, "xml"=>0, :runtime=>36.161, :all=>75.61182199999999} [[0;37mDEBUG[0m|#23878] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#23878] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#23878] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#23878] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#23878] 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|#23878] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/person/tom {"view"=>0.981099, "db"=>2.148857, "backend"=>0, "xml"=>0, :runtime=>17.182, :all=>106.075722} [[0;37mDEBUG[0m|#23878] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#23878] params {:login=>"tom"} [[0;37mDEBUG[0m|#23878] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/person/tom/group {"view"=>0.429692, "db"=>0.767435, "backend"=>0, "xml"=>0, :runtime=>7.749, :all=>16.304223} [[0;37mDEBUG[0m|#23878] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#23878] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#23878] Redirected to http://127.0.0.1:60782/project/show?project=My%3AMaintenance [[32mINFO [0m|#23878] Completed 302 Found in 219ms (ActiveRecord: 0.0ms | API: 214.4ms (XML: 0.0ms , View: 2.3ms , Backend: 0.0ms , DB: 8.9ms , HTTP: 140.3ms) | XML: 0.3ms) [[32mINFO [0m|#23878] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 16:20:20 +0000 [[32mINFO [0m|#23878] Processing by ProjectController#show as HTML [[32mINFO [0m|#23878] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#23878] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#23878] Authenticating with iChain mode: off [[32mINFO [0m|#23878] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#23878] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#23878] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#23878] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#23878] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/person/tom {"view"=>0.508947, "db"=>1.021976, "backend"=>0, "xml"=>0, :runtime=>8.782, :all=>50.603131000000005} [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.288428, "db"=>4.386502, "backend"=>0, "xml"=>0, :runtime=>31.995, :all=>71.080591} [[0;37mDEBUG[0m|#23878] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.435045, "db"=>3.8064199999999997, "backend"=>0, "xml"=>0, :runtime=>39.561, :all=>79.32193} [[0;37mDEBUG[0m|#23878] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#23878] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#23878] Rendered project/_tabs.html.erb (2.2ms) [[32mINFO [0m|#23878] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#23878] Rendered layouts/_watch_and_search.html.erb (0.9ms) [[32mINFO [0m|#23878] Rendered layouts/_header.html.erb (1.7ms) [[32mINFO [0m|#23878] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#23878] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#23878] Completed 200 OK in 271ms (Views: 11.9ms | ActiveRecord: 0.0ms | API: 201.0ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 9.2ms , HTTP: 120.7ms) | XML: 0.5ms) [[32mINFO [0m|#23878] Started POST "/user/logout" for 127.0.0.1 at 2013-03-21 16:20:20 +0000 [[32mINFO [0m|#23878] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#23878] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#23878] Authenticating with iChain mode: off [[32mINFO [0m|#23878] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#23878] Logging out: tom [[32mINFO [0m|#23878] Redirected to http://127.0.0.1:60782/ [[0;37mDEBUG[0m|#23878] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#23878] Completed 302 Found in 10ms (ActiveRecord: 8.3ms | XML: 0.0ms) [[32mINFO [0m|#23878] Started GET "/" for 127.0.0.1 at 2013-03-21 16:20:20 +0000 [[32mINFO [0m|#23878] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#23878] Setting return_to: "/" [[0;37mDEBUG[0m|#23878] Authenticating with iChain mode: off [[32mINFO [0m|#23878] Anonymous request to / [[0;37mDEBUG[0m|#23878] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#23878] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] ) [[0;37mDEBUG[0m|#23878] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"} [[0;37mDEBUG[0m|#23878] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=5 [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/status/messages/?limit=5 {"view"=>0.792212, "db"=>0.546617, "backend"=>0, "xml"=>0, :runtime=>6.207, :all=>9.978299} [[0;37mDEBUG[0m|#23878] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#23878] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#23878] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#23878] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#23878] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.216925, "db"=>2.006536, "backend"=>0, "xml"=>0, :runtime=>16.66, :all=>57.767906} [[32mINFO [0m|#23878] Rendered shared/_sign_up.html.erb (1.2ms) [[32mINFO [0m|#23878] Rendered main/_news.html.erb (0.5ms) [[32mINFO [0m|#23878] Rendered main/_latest_updates.erb (4.1ms) [[32mINFO [0m|#23878] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|#23878] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#23878] Rendered main/_feeds.html.erb (0.1ms) [[32mINFO [0m|#23878] Rendered layouts/_watch_and_search.html.erb (0.6ms) [[32mINFO [0m|#23878] Rendered layouts/_header.html.erb (1.1ms) [[32mINFO [0m|#23878] Rendered layouts/_personal_navigation.html.erb (1.3ms) [[32mINFO [0m|#23878] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#23878] Completed 200 OK in 88ms (Views: 16.3ms | ActiveRecord: 0.0ms | API: 67.7ms (XML: 0.0ms , View: 2.0ms , Backend: 0.0ms , DB: 2.6ms , HTTP: 44.9ms) | XML: 1.0ms) [[32mINFO [0m|#23878] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-03-21 16:20:21 +0000 [[32mINFO [0m|#23878] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#23878] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#23878] Authenticating with iChain mode: off [[32mINFO [0m|#23878] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#23878] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#23878] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#23878] Rendered main/_systemstatus.html.erb (1.2ms) [[32mINFO [0m|#23878] Completed 200 OK in 3ms (Views: 1.7ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|#23878] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#23878] RT http://localhost:3203/test/test_end {"view"=>1.02176, "db"=>23.410975, "backend"=>0, "xml"=>0, :runtime=>28.951999999999998, :all=>32.559174000000006} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' + 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
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/870/changes> Changes: [Stephan Kulow] [api] fix review accept that aren't found (gives 500 now) ------------------------------------------ [...truncated 571281 lines...] [[32mINFO [0m|#11264] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#11264] Completed 200 OK in 263ms (Views: 22.1ms | ActiveRecord: 0.0ms | API: 161.1ms (XML: 0.0ms , View: 1.4ms , Backend: 0.0ms , DB: 8.5ms , HTTP: 81.5ms) | XML: 0.8ms) [[32mINFO [0m|#11264] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-03-25 13:20:03 +0000 [[32mINFO [0m|#11264] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#11264] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#11264] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#11264] Authenticating with iChain mode: off [[32mINFO [0m|#11264] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#11264] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#11264] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#11264] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#11264] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/person/tom {"view"=>0.632362, "db"=>7.395833999999999, "backend"=>0, "xml"=>0, :runtime=>107.922, :all=>111.494469} [[0;37mDEBUG[0m|#11264] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#11264] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#11264] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#11264] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#11264] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.8788200000000002, "backend"=>0, "xml"=>0, :runtime=>25.997, :all=>64.585977} [[32mINFO [0m|#11264] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#11264] Completed 200 OK in 180ms (Views: 1.0ms | ActiveRecord: 0.0ms | API: 176.1ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 8.3ms , HTTP: 42.2ms) | XML: 0.3ms) [[32mINFO [0m|#11264] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 13:20:03 +0000 [[32mINFO [0m|#11264] Processing by ProjectController#show as HTML [[32mINFO [0m|#11264] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#11264] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#11264] Authenticating with iChain mode: off [[32mINFO [0m|#11264] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#11264] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#11264] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#11264] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#11264] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/person/tom {"view"=>0.593522, "db"=>1.506721, "backend"=>0, "xml"=>0, :runtime=>13.574, :all=>53.26161} [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.291831, "db"=>3.9165660000000004, "backend"=>0, "xml"=>0, :runtime=>31.089, :all=>71.010479} [[0;37mDEBUG[0m|#11264] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.402804, "db"=>3.5981080000000003, "backend"=>0, "xml"=>0, :runtime=>39.908, :all=>79.260673} [[0;37mDEBUG[0m|#11264] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#11264] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#11264] Rendered project/_tabs.html.erb (2.3ms) [[32mINFO [0m|#11264] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|#11264] Rendered layouts/_watch_and_search.html.erb (1.2ms) [[32mINFO [0m|#11264] Rendered layouts/_header.html.erb (2.0ms) [[32mINFO [0m|#11264] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#11264] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#11264] Completed 200 OK in 221ms (Views: 12.6ms | ActiveRecord: 0.0ms | API: 203.5ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 9.0ms , HTTP: 119.0ms) | XML: 0.5ms) [[32mINFO [0m|#11264] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 13:20:04 +0000 [[32mINFO [0m|#11264] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#11264] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#11264] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#11264] Authenticating with iChain mode: off [[32mINFO [0m|#11264] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#11264] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#11264] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#11264] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#11264] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/person/tom {"view"=>0.497935, "db"=>1.459166, "backend"=>0, "xml"=>0, :runtime=>13.520000000000001, :all=>16.688177} [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.279021, "db"=>3.6014529999999993, "backend"=>0, "xml"=>0, :runtime=>28.535, :all=>66.614487} [[0;37mDEBUG[0m|#11264] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#11264] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#11264] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#11264] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#11264] 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|#11264] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/person/tom {"view"=>1.2737390000000002, "db"=>2.170092, "backend"=>0, "xml"=>0, :runtime=>17.356, :all=>21.985054} [[0;37mDEBUG[0m|#11264] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#11264] params {:login=>"tom"} [[0;37mDEBUG[0m|#11264] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/person/tom/group {"view"=>0.40820500000000004, "db"=>0.7626269999999999, "backend"=>0, "xml"=>0, :runtime=>7.255, :all=>10.358676} [[0;37mDEBUG[0m|#11264] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#11264] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#11264] Redirected to http://127.0.0.1:36254/project/show?project=My%3AMaintenance [[32mINFO [0m|#11264] Completed 302 Found in 120ms (ActiveRecord: 0.0ms | API: 115.6ms (XML: 0.0ms , View: 2.5ms , Backend: 0.0ms , DB: 8.0ms , HTTP: 49.0ms) | XML: 0.4ms) [[32mINFO [0m|#11264] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 13:20:04 +0000 [[32mINFO [0m|#11264] Processing by ProjectController#show as HTML [[32mINFO [0m|#11264] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#11264] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#11264] Authenticating with iChain mode: off [[32mINFO [0m|#11264] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#11264] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#11264] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#11264] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#11264] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/person/tom {"view"=>0.5360739999999999, "db"=>0.901345, "backend"=>0, "xml"=>0, :runtime=>8.485, :all=>51.675903000000005} [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.26195199999999996, "db"=>4.257357000000001, "backend"=>0, "xml"=>0, :runtime=>32.965, :all=>74.62506400000001} [[0;37mDEBUG[0m|#11264] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.469748, "db"=>3.4657880000000003, "backend"=>0, "xml"=>0, :runtime=>36.336, :all=>79.397006} [[0;37mDEBUG[0m|#11264] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#11264] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#11264] Rendered project/_tabs.html.erb (2.5ms) [[32mINFO [0m|#11264] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#11264] Rendered layouts/_watch_and_search.html.erb (1.0ms) [[32mINFO [0m|#11264] Rendered layouts/_header.html.erb (1.9ms) [[32mINFO [0m|#11264] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#11264] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#11264] Completed 200 OK in 225ms (Views: 13.4ms | ActiveRecord: 0.0ms | API: 205.7ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 8.6ms , HTTP: 127.9ms) | XML: 0.6ms) [[32mINFO [0m|#11264] Started POST "/user/logout" for 127.0.0.1 at 2013-03-25 13:20:04 +0000 [[32mINFO [0m|#11264] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#11264] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#11264] Authenticating with iChain mode: off [[32mINFO [0m|#11264] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#11264] Logging out: tom [[32mINFO [0m|#11264] Redirected to http://127.0.0.1:36254/ [[0;37mDEBUG[0m|#11264] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#11264] Completed 302 Found in 977ms (ActiveRecord: 974.7ms | XML: 0.0ms) [[32mINFO [0m|#11264] Started GET "/" for 127.0.0.1 at 2013-03-25 13:20:05 +0000 [[32mINFO [0m|#11264] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#11264] Setting return_to: "/" [[0;37mDEBUG[0m|#11264] Authenticating with iChain mode: off [[32mINFO [0m|#11264] Anonymous request to / [[0;37mDEBUG[0m|#11264] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#11264] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] ) [[0;37mDEBUG[0m|#11264] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"} [[0;37mDEBUG[0m|#11264] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=5 [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/status/messages/?limit=5 {"view"=>0.6872999999999999, "db"=>0.5089359999999999, "backend"=>0, "xml"=>0, :runtime=>5.441, :all=>8.385846} [[0;37mDEBUG[0m|#11264] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#11264] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#11264] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#11264] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#11264] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.184118, "db"=>2.091729, "backend"=>0, "xml"=>0, :runtime=>16.422, :all=>57.134694} [[32mINFO [0m|#11264] Rendered shared/_sign_up.html.erb (1.0ms) [[32mINFO [0m|#11264] Rendered main/_news.html.erb (0.5ms) [[32mINFO [0m|#11264] Rendered main/_latest_updates.erb (4.3ms) [[32mINFO [0m|#11264] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|#11264] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#11264] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|#11264] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#11264] Rendered layouts/_header.html.erb (1.1ms) [[32mINFO [0m|#11264] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#11264] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#11264] Completed 200 OK in 84ms (Views: 14.6ms | ActiveRecord: 0.0ms | API: 65.5ms (XML: 0.0ms , View: 1.9ms , Backend: 0.0ms , DB: 2.6ms , HTTP: 43.7ms) | XML: 0.9ms) [[32mINFO [0m|#11264] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-03-25 13:20:05 +0000 [[32mINFO [0m|#11264] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#11264] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#11264] Authenticating with iChain mode: off [[32mINFO [0m|#11264] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#11264] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#11264] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#11264] Rendered main/_systemstatus.html.erb (1.3ms) [[32mINFO [0m|#11264] Completed 200 OK in 3ms (Views: 1.8ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|#11264] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#11264] RT http://localhost:3203/test/test_end {"view"=>1.062775, "db"=>42.266652, "backend"=>0, "xml"=>0, :runtime=>47.461999999999996, :all=>51.862449} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' + 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/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/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
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/871/changes> Changes: [Stephan Kulow] [api] remove tons of code from the status/bsrequest route [ro] [backend] support for dumpstate and dropbadhosts in bs_dispatch [ro] [backend] allow to disable syncing of kiwi trees in BSConfig [mls] [backend] only calculate worker/buildcode state every 20 seconds [Stephan Kulow] [api] remove unused variable to please code quality check ------------------------------------------ [...truncated 571226 lines...] [[32mINFO [0m|#28190] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#28190] Completed 200 OK in 188ms (Views: 15.1ms | ActiveRecord: 0.0ms | API: 168.8ms (XML: 0.0ms , View: 1.5ms , Backend: 0.0ms , DB: 8.3ms , HTTP: 88.0ms) | XML: 0.6ms) [[32mINFO [0m|#28190] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-03-25 16:38:15 +0000 [[32mINFO [0m|#28190] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#28190] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#28190] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#28190] Authenticating with iChain mode: off [[32mINFO [0m|#28190] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#28190] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#28190] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#28190] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#28190] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/person/tom {"view"=>0.512971, "db"=>1.521093, "backend"=>0, "xml"=>0, :runtime=>12.095, :all=>15.069464} [[0;37mDEBUG[0m|#28190] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#28190] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#28190] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#28190] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#28190] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.601768, "backend"=>0, "xml"=>0, :runtime=>25.647, :all=>65.30151400000001} [[32mINFO [0m|#28190] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#28190] Completed 200 OK in 83ms (Views: 0.6ms | ActiveRecord: 0.0ms | API: 80.4ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.1ms , HTTP: 42.6ms) | XML: 0.2ms) [[32mINFO [0m|#28190] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 16:38:15 +0000 [[32mINFO [0m|#28190] Processing by ProjectController#show as HTML [[32mINFO [0m|#28190] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#28190] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#28190] Authenticating with iChain mode: off [[32mINFO [0m|#28190] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#28190] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#28190] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#28190] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#28190] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/person/tom {"view"=>0.608332, "db"=>1.830565, "backend"=>0, "xml"=>0, :runtime=>17.444000000000003, :all=>60.292975} [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.41571, "db"=>4.749920999999999, "backend"=>0, "xml"=>0, :runtime=>38.321, :all=>82.532305} [[0;37mDEBUG[0m|#28190] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.828056, "db"=>3.691752, "backend"=>0, "xml"=>0, :runtime=>41.293000000000006, :all=>83.274238} [[0;37mDEBUG[0m|#28190] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#28190] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#28190] Rendered project/_tabs.html.erb (3.9ms) [[32mINFO [0m|#28190] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|#28190] Rendered layouts/_watch_and_search.html.erb (2.2ms) [[32mINFO [0m|#28190] Rendered layouts/_header.html.erb (3.6ms) [[32mINFO [0m|#28190] Rendered layouts/_personal_navigation.html.erb (1.8ms) [[32mINFO [0m|#28190] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#28190] Completed 200 OK in 254ms (Views: 21.3ms | ActiveRecord: 0.0ms | API: 226.1ms (XML: 0.0ms , View: 1.9ms , Backend: 0.0ms , DB: 10.3ms , HTTP: 129.0ms) | XML: 0.8ms) [[32mINFO [0m|#28190] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 16:38:15 +0000 [[32mINFO [0m|#28190] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#28190] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#28190] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#28190] Authenticating with iChain mode: off [[32mINFO [0m|#28190] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#28190] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#28190] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#28190] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#28190] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/person/tom {"view"=>0.683153, "db"=>1.640786, "backend"=>0, "xml"=>0, :runtime=>82.856, :all=>86.416889} [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.33326500000000003, "db"=>4.503735, "backend"=>0, "xml"=>0, :runtime=>32.557, :all=>73.42968900000001} [[0;37mDEBUG[0m|#28190] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#28190] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#28190] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#28190] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#28190] 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|#28190] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/person/tom {"view"=>0.956643, "db"=>2.3766920000000002, "backend"=>0, "xml"=>0, :runtime=>18.255, :all=>22.510198} [[0;37mDEBUG[0m|#28190] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#28190] params {:login=>"tom"} [[0;37mDEBUG[0m|#28190] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/person/tom/group {"view"=>0.45562199999999997, "db"=>0.9505319999999999, "backend"=>0, "xml"=>0, :runtime=>7.917999999999999, :all=>12.296403} [[0;37mDEBUG[0m|#28190] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#28190] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#28190] Redirected to http://127.0.0.1:51505/project/show?project=My%3AMaintenance [[32mINFO [0m|#28190] Completed 302 Found in 199ms (ActiveRecord: 0.0ms | API: 194.7ms (XML: 0.0ms , View: 2.4ms , Backend: 0.0ms , DB: 9.5ms , HTTP: 53.1ms) | XML: 0.4ms) [[32mINFO [0m|#28190] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 16:38:15 +0000 [[32mINFO [0m|#28190] Processing by ProjectController#show as HTML [[32mINFO [0m|#28190] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#28190] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#28190] Authenticating with iChain mode: off [[32mINFO [0m|#28190] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#28190] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#28190] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#28190] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#28190] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/person/tom {"view"=>0.5997170000000001, "db"=>1.115947, "backend"=>0, "xml"=>0, :runtime=>11.069, :all=>50.086432} [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.436773, "db"=>11.409035, "backend"=>0, "xml"=>0, :runtime=>145.651, :all=>186.99822999999998} [[0;37mDEBUG[0m|#28190] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.442288, "db"=>6.491776, "backend"=>0, "xml"=>0, :runtime=>51.748000000000005, :all=>91.170752} [[0;37mDEBUG[0m|#28190] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#28190] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#28190] Rendered project/_tabs.html.erb (2.1ms) [[32mINFO [0m|#28190] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#28190] Rendered layouts/_watch_and_search.html.erb (1.3ms) [[32mINFO [0m|#28190] Rendered layouts/_header.html.erb (2.3ms) [[32mINFO [0m|#28190] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#28190] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#28190] Completed 200 OK in 345ms (Views: 12.2ms | ActiveRecord: 0.0ms | API: 328.3ms (XML: 0.0ms , View: 1.5ms , Backend: 0.0ms , DB: 19.0ms , HTTP: 119.8ms) | XML: 0.5ms) [[32mINFO [0m|#28190] Started POST "/user/logout" for 127.0.0.1 at 2013-03-25 16:38:16 +0000 [[32mINFO [0m|#28190] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#28190] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#28190] Authenticating with iChain mode: off [[32mINFO [0m|#28190] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#28190] Logging out: tom [[32mINFO [0m|#28190] Redirected to http://127.0.0.1:51505/ [[0;37mDEBUG[0m|#28190] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#28190] Completed 302 Found in 9ms (ActiveRecord: 7.0ms | XML: 0.0ms) [[32mINFO [0m|#28190] Started GET "/" for 127.0.0.1 at 2013-03-25 16:38:16 +0000 [[32mINFO [0m|#28190] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#28190] Setting return_to: "/" [[0;37mDEBUG[0m|#28190] Authenticating with iChain mode: off [[32mINFO [0m|#28190] Anonymous request to / [[0;37mDEBUG[0m|#28190] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#28190] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] ) [[0;37mDEBUG[0m|#28190] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"} [[0;37mDEBUG[0m|#28190] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=5 [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/status/messages/?limit=5 {"view"=>0.822916, "db"=>0.6341749999999999, "backend"=>0, "xml"=>0, :runtime=>6.838, :all=>10.267918} [[0;37mDEBUG[0m|#28190] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#28190] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#28190] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#28190] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#28190] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.919772, "db"=>2.3075300000000003, "backend"=>0, "xml"=>0, :runtime=>19.618, :all=>59.907938} [[32mINFO [0m|#28190] Rendered shared/_sign_up.html.erb (1.4ms) [[32mINFO [0m|#28190] Rendered main/_news.html.erb (0.9ms) [[32mINFO [0m|#28190] Rendered main/_latest_updates.erb (6.4ms) [[32mINFO [0m|#28190] Rendered main/_countdown.html.erb (0.1ms) [[32mINFO [0m|#28190] Rendered main/_sponsors.html.erb (0.1ms) [[32mINFO [0m|#28190] Rendered main/_feeds.html.erb (0.1ms) [[32mINFO [0m|#28190] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|#28190] Rendered layouts/_header.html.erb (1.7ms) [[32mINFO [0m|#28190] Rendered layouts/_personal_navigation.html.erb (1.8ms) [[32mINFO [0m|#28190] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#28190] Completed 200 OK in 98ms (Views: 22.6ms | ActiveRecord: 0.0ms | API: 70.2ms (XML: 0.0ms , View: 2.7ms , Backend: 0.0ms , DB: 2.9ms , HTTP: 43.7ms) | XML: 1.4ms) [[32mINFO [0m|#28190] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-03-25 16:38:16 +0000 [[32mINFO [0m|#28190] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#28190] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#28190] Authenticating with iChain mode: off [[32mINFO [0m|#28190] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#28190] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#28190] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#28190] Rendered main/_systemstatus.html.erb (76.9ms) [[32mINFO [0m|#28190] Completed 200 OK in 79ms (Views: 77.7ms | ActiveRecord: 0.0ms | XML: 3.7ms) [[0;37mDEBUG[0m|#28190] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#28190] RT http://localhost:3203/test/test_end {"view"=>1.016457, "db"=>13.406400999999999, "backend"=>0, "xml"=>0, :runtime=>19.820999999999998, :all=>25.145088} + 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/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/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
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/872/changes> Changes: [mls] [backend] tweak metacache merging a bit ------------------------------------------ [...truncated 571229 lines...] [[32mINFO [0m|#12434] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#12434] Completed 200 OK in 181ms (Views: 16.4ms | ActiveRecord: 0.0ms | API: 160.2ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 7.6ms , HTTP: 85.4ms) | XML: 0.6ms) [[32mINFO [0m|#12434] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-03-25 17:16:18 +0000 [[32mINFO [0m|#12434] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#12434] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#12434] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#12434] Authenticating with iChain mode: off [[32mINFO [0m|#12434] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#12434] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#12434] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#12434] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#12434] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/person/tom {"view"=>0.464947, "db"=>1.8205149999999999, "backend"=>0, "xml"=>0, :runtime=>12.616999999999999, :all=>15.840736000000001} [[0;37mDEBUG[0m|#12434] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#12434] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#12434] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#12434] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#12434] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.7186450000000001, "backend"=>0, "xml"=>0, :runtime=>22.221, :all=>64.38240300000001} [[32mINFO [0m|#12434] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#12434] Completed 200 OK in 83ms (Views: 0.6ms | ActiveRecord: 0.0ms | API: 80.2ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.5ms , HTTP: 45.4ms) | XML: 0.2ms) [[32mINFO [0m|#12434] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 17:16:18 +0000 [[32mINFO [0m|#12434] Processing by ProjectController#show as HTML [[32mINFO [0m|#12434] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#12434] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#12434] Authenticating with iChain mode: off [[32mINFO [0m|#12434] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#12434] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#12434] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#12434] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#12434] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/person/tom {"view"=>0.525118, "db"=>1.6442890000000001, "backend"=>0, "xml"=>0, :runtime=>63.957, :all=>103.37375999999999} [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.26844999999999997, "db"=>4.259618, "backend"=>0, "xml"=>0, :runtime=>36.888, :all=>75.149785} [[0;37mDEBUG[0m|#12434] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.440004, "db"=>3.499005, "backend"=>0, "xml"=>0, :runtime=>34.675, :all=>75.41072799999999} [[0;37mDEBUG[0m|#12434] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#12434] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#12434] Rendered project/_tabs.html.erb (3.1ms) [[32mINFO [0m|#12434] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#12434] Rendered layouts/_watch_and_search.html.erb (1.3ms) [[32mINFO [0m|#12434] Rendered layouts/_header.html.erb (2.0ms) [[32mINFO [0m|#12434] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#12434] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#12434] Completed 200 OK in 272ms (Views: 13.3ms | ActiveRecord: 0.0ms | API: 253.9ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 9.4ms , HTTP: 118.4ms) | XML: 0.6ms) [[32mINFO [0m|#12434] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 17:16:18 +0000 [[32mINFO [0m|#12434] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#12434] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#12434] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#12434] Authenticating with iChain mode: off [[32mINFO [0m|#12434] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#12434] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#12434] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#12434] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#12434] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/person/tom {"view"=>0.543498, "db"=>1.356373, "backend"=>0, "xml"=>0, :runtime=>12.888, :all=>16.196628} [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.291386, "db"=>7.735046, "backend"=>0, "xml"=>0, :runtime=>103.80799999999999, :all=>143.415886} [[0;37mDEBUG[0m|#12434] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#12434] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#12434] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#12434] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#12434] 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|#12434] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/person/tom {"view"=>1.3715789999999999, "db"=>2.7650999999999994, "backend"=>0, "xml"=>0, :runtime=>24.556, :all=>30.360088} [[0;37mDEBUG[0m|#12434] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#12434] params {:login=>"tom"} [[0;37mDEBUG[0m|#12434] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/person/tom/group {"view"=>0.352743, "db"=>0.722151, "backend"=>0, "xml"=>0, :runtime=>6.394, :all=>10.675548} [[0;37mDEBUG[0m|#12434] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#12434] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#12434] Redirected to http://127.0.0.1:52683/project/show?project=My%3AMaintenance [[32mINFO [0m|#12434] Completed 302 Found in 205ms (ActiveRecord: 0.0ms | API: 200.6ms (XML: 0.0ms , View: 2.6ms , Backend: 0.0ms , DB: 12.6ms , HTTP: 53.0ms) | XML: 0.3ms) [[32mINFO [0m|#12434] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-25 17:16:19 +0000 [[32mINFO [0m|#12434] Processing by ProjectController#show as HTML [[32mINFO [0m|#12434] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#12434] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#12434] Authenticating with iChain mode: off [[32mINFO [0m|#12434] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#12434] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#12434] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#12434] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#12434] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/person/tom {"view"=>0.471787, "db"=>0.8232140000000001, "backend"=>0, "xml"=>0, :runtime=>8.071, :all=>49.58098} [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.25766199999999995, "db"=>4.707140999999999, "backend"=>0, "xml"=>0, :runtime=>32.663, :all=>71.082737} [[0;37mDEBUG[0m|#12434] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.430932, "db"=>3.5102290000000007, "backend"=>0, "xml"=>0, :runtime=>36.191, :all=>75.59049599999999} [[0;37mDEBUG[0m|#12434] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#12434] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#12434] Rendered project/_tabs.html.erb (3.0ms) [[32mINFO [0m|#12434] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#12434] Rendered layouts/_watch_and_search.html.erb (1.2ms) [[32mINFO [0m|#12434] Rendered layouts/_header.html.erb (2.2ms) [[32mINFO [0m|#12434] Rendered layouts/_personal_navigation.html.erb (1.5ms) [[32mINFO [0m|#12434] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#12434] Completed 200 OK in 216ms (Views: 15.0ms | ActiveRecord: 0.0ms | API: 196.3ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 9.0ms , HTTP: 119.3ms) | XML: 0.5ms) [[32mINFO [0m|#12434] Started POST "/user/logout" for 127.0.0.1 at 2013-03-25 17:16:19 +0000 [[32mINFO [0m|#12434] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#12434] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#12434] Authenticating with iChain mode: off [[32mINFO [0m|#12434] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#12434] Logging out: tom [[32mINFO [0m|#12434] Redirected to http://127.0.0.1:52683/ [[0;37mDEBUG[0m|#12434] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#12434] Completed 302 Found in 38ms (ActiveRecord: 36.1ms | XML: 0.0ms) [[32mINFO [0m|#12434] Started GET "/" for 127.0.0.1 at 2013-03-25 17:16:19 +0000 [[32mINFO [0m|#12434] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#12434] Setting return_to: "/" [[0;37mDEBUG[0m|#12434] Authenticating with iChain mode: off [[32mINFO [0m|#12434] Anonymous request to / [[0;37mDEBUG[0m|#12434] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#12434] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] ) [[0;37mDEBUG[0m|#12434] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"} [[0;37mDEBUG[0m|#12434] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=5 [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/status/messages/?limit=5 {"view"=>0.725326, "db"=>0.442496, "backend"=>0, "xml"=>0, :runtime=>5.684, :all=>8.599905999999999} [[0;37mDEBUG[0m|#12434] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#12434] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#12434] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#12434] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#12434] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.120194, "db"=>2.107405, "backend"=>0, "xml"=>0, :runtime=>16.592, :all=>60.941233999999994} [[32mINFO [0m|#12434] Rendered shared/_sign_up.html.erb (1.2ms) [[32mINFO [0m|#12434] Rendered main/_news.html.erb (0.7ms) [[32mINFO [0m|#12434] Rendered main/_latest_updates.erb (5.6ms) [[32mINFO [0m|#12434] Rendered main/_countdown.html.erb (0.1ms) [[32mINFO [0m|#12434] Rendered main/_sponsors.html.erb (0.1ms) [[32mINFO [0m|#12434] Rendered main/_feeds.html.erb (0.1ms) [[32mINFO [0m|#12434] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#12434] Rendered layouts/_header.html.erb (1.0ms) [[32mINFO [0m|#12434] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#12434] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#12434] Completed 200 OK in 90ms (Views: 16.7ms | ActiveRecord: 0.0ms | API: 69.5ms (XML: 0.0ms , View: 1.8ms , Backend: 0.0ms , DB: 2.5ms , HTTP: 47.3ms) | XML: 1.2ms) [[32mINFO [0m|#12434] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-03-25 17:16:19 +0000 [[32mINFO [0m|#12434] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#12434] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#12434] Authenticating with iChain mode: off [[32mINFO [0m|#12434] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#12434] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#12434] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#12434] Rendered main/_systemstatus.html.erb (1.2ms) [[32mINFO [0m|#12434] Completed 200 OK in 3ms (Views: 1.7ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|#12434] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#12434] RT http://localhost:3203/test/test_end {"view"=>0.837112, "db"=>22.659475999999998, "backend"=>0, "xml"=>0, :runtime=>27.652, :all=>32.179761} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' + 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
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/873/changes> Changes: [mls] [backend] fix typo in signer flavor calculation [adrian] [api] fix SQL escaping of request collection views [adrian] [webui] Expose requests as json and removing the enforcement of OBS setup for admins [adrian] [webui] Move sponsors and feeds into config/options.yml [adrian] [webui] Fix the test suite [adrian] [webui] Remove traces of the interconnect workflow in the test suite [adrian] [api] fix detection of running release requests when packages exist with the same name as prefix (bnc#811449) [adrian] [api] fix loading of ruby ldap module [adrian] [webui] Fix password/account changing [adrian] [backend] Add the feature to support multiple notify plugins [adrian] [backend] Avoid endless rebuilds if qemu-linux-user is missing [adrian] [dist] Clean worker dirs on startup [mls] [backend] always remove :dir directories when killing jobs [mls] [backend] save memory by storing the meta as a single string instead of a string array [adrian] [dist] Amazon EC2 tells the public hostname via an own command ------------------------------------------ [...truncated 623055 lines...] [[32mINFO [0m|#22036] Rendered layouts/_header.html.erb (1.8ms) [[32mINFO [0m|#22036] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#22036] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#22036] Completed 200 OK in 172ms (Views: 14.3ms | ActiveRecord: 0.0ms | API: 153.2ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 8.2ms , HTTP: 81.2ms) | XML: 0.5ms) [[32mINFO [0m|#22036] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-04-11 10:54:57 +0000 [[32mINFO [0m|#22036] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#22036] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#22036] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#22036] Authenticating with iChain mode: off [[32mINFO [0m|#22036] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#22036] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#22036] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#22036] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#22036] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/person/tom {"view"=>0.499394, "db"=>1.620433, "backend"=>0, "xml"=>0, :runtime=>13.571, :all=>16.670487} [[0;37mDEBUG[0m|#22036] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#22036] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#22036] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#22036] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#22036] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.738253, "backend"=>0, "xml"=>0, :runtime=>24.669, :all=>65.564064} [[32mINFO [0m|#22036] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#22036] Completed 200 OK in 85ms (Views: 0.6ms | ActiveRecord: 0.0ms | API: 82.2ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.4ms , HTTP: 44.0ms) | XML: 0.2ms) [[32mINFO [0m|#22036] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-11 10:54:57 +0000 [[32mINFO [0m|#22036] Processing by ProjectController#show as HTML [[32mINFO [0m|#22036] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#22036] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#22036] Authenticating with iChain mode: off [[32mINFO [0m|#22036] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#22036] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#22036] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#22036] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#22036] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/person/tom {"view"=>0.45341000000000004, "db"=>1.280097, "backend"=>0, "xml"=>0, :runtime=>11.873999999999999, :all=>50.606199999999994} [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.24428999999999998, "db"=>3.65512, "backend"=>0, "xml"=>0, :runtime=>27.313, :all=>67.156668} [[0;37mDEBUG[0m|#22036] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.440281, "db"=>3.4575429999999994, "backend"=>0, "xml"=>0, :runtime=>33.156, :all=>75.468627} [[0;37mDEBUG[0m|#22036] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#22036] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#22036] Rendered project/_tabs.html.erb (2.1ms) [[32mINFO [0m|#22036] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#22036] Rendered layouts/_watch_and_search.html.erb (1.1ms) [[32mINFO [0m|#22036] Rendered layouts/_header.html.erb (1.8ms) [[32mINFO [0m|#22036] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#22036] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#22036] Completed 200 OK in 209ms (Views: 11.5ms | ActiveRecord: 0.0ms | API: 193.2ms (XML: 0.0ms , View: 1.1ms , Backend: 0.0ms , DB: 8.4ms , HTTP: 120.9ms) | XML: 0.5ms) [[32mINFO [0m|#22036] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-11 10:54:58 +0000 [[32mINFO [0m|#22036] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#22036] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#22036] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#22036] Authenticating with iChain mode: off [[32mINFO [0m|#22036] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#22036] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#22036] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#22036] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#22036] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/person/tom {"view"=>0.442828, "db"=>1.280249, "backend"=>0, "xml"=>0, :runtime=>11.684, :all=>14.877906999999999} [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.254234, "db"=>3.5528470000000008, "backend"=>0, "xml"=>0, :runtime=>94.491, :all=>139.12987600000002} [[0;37mDEBUG[0m|#22036] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#22036] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#22036] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#22036] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#22036] 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|#22036] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/person/tom {"view"=>1.236138, "db"=>2.4464449999999998, "backend"=>0, "xml"=>0, :runtime=>20.277, :all=>25.071664000000002} [[0;37mDEBUG[0m|#22036] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#22036] params {:login=>"tom"} [[0;37mDEBUG[0m|#22036] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/person/tom/group {"view"=>0.343197, "db"=>0.663964, "backend"=>0, "xml"=>0, :runtime=>6.403, :all=>10.917845} [[0;37mDEBUG[0m|#22036] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#22036] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#22036] Redirected to http://127.0.0.1:54256/project/show?project=My%3AMaintenance [[32mINFO [0m|#22036] Completed 302 Found in 194ms (ActiveRecord: 0.0ms | API: 190.0ms (XML: 0.0ms , View: 2.3ms , Backend: 0.0ms , DB: 7.9ms , HTTP: 57.1ms) | XML: 0.3ms) [[32mINFO [0m|#22036] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-11 10:54:58 +0000 [[32mINFO [0m|#22036] Processing by ProjectController#show as HTML [[32mINFO [0m|#22036] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#22036] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#22036] Authenticating with iChain mode: off [[32mINFO [0m|#22036] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#22036] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#22036] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#22036] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#22036] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/person/tom {"view"=>0.467802, "db"=>0.858514, "backend"=>0, "xml"=>0, :runtime=>8.007, :all=>50.284809} [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.26907, "db"=>3.9910059999999996, "backend"=>0, "xml"=>0, :runtime=>30.268, :all=>71.344561} [[0;37mDEBUG[0m|#22036] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.46542300000000003, "db"=>3.3392359999999996, "backend"=>0, "xml"=>0, :runtime=>36.613, :all=>79.366907} [[0;37mDEBUG[0m|#22036] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#22036] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#22036] Rendered project/_tabs.html.erb (2.2ms) [[32mINFO [0m|#22036] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|#22036] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|#22036] Rendered layouts/_header.html.erb (1.6ms) [[32mINFO [0m|#22036] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#22036] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#22036] Completed 200 OK in 217ms (Views: 12.0ms | ActiveRecord: 0.0ms | API: 201.0ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 8.2ms , HTTP: 126.1ms) | XML: 0.4ms) [[32mINFO [0m|#22036] Started POST "/user/logout" for 127.0.0.1 at 2013-04-11 10:54:58 +0000 [[32mINFO [0m|#22036] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#22036] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#22036] Authenticating with iChain mode: off [[32mINFO [0m|#22036] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#22036] Logging out: tom [[32mINFO [0m|#22036] Redirected to http://127.0.0.1:54256/ [[0;37mDEBUG[0m|#22036] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#22036] Completed 302 Found in 11ms (ActiveRecord: 9.3ms | XML: 0.0ms) [[32mINFO [0m|#22036] Started GET "/" for 127.0.0.1 at 2013-04-11 10:54:58 +0000 [[32mINFO [0m|#22036] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#22036] Setting return_to: "/" [[0;37mDEBUG[0m|#22036] Authenticating with iChain mode: off [[32mINFO [0m|#22036] Anonymous request to / [[0;37mDEBUG[0m|#22036] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] Statusmessage_2fe508b303b3ed792c174b7580cb295c [[0;37mDEBUG[0m|#22036] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] ) [[0;37mDEBUG[0m|#22036] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"} [[0;37mDEBUG[0m|#22036] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=4 [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/status/messages/?limit=4 {"view"=>0.7810649999999999, "db"=>0.500535, "backend"=>0, "xml"=>0, :runtime=>5.906, :all=>57.89542} [[0;37mDEBUG[0m|#22036] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#22036] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#22036] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#22036] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#22036] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.1697870000000001, "db"=>2.031009, "backend"=>0, "xml"=>0, :runtime=>16.912, :all=>20.126163} [[32mINFO [0m|#22036] Rendered shared/_sign_up.html.erb (0.9ms) [[32mINFO [0m|#22036] Rendered main/_sponsors.html.erb (0.1ms) [[32mINFO [0m|#22036] Rendered main/_news.html.erb (0.1ms) [[32mINFO [0m|#22036] Rendered main/_latest_updates.erb (4.0ms) [[32mINFO [0m|#22036] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#22036] Rendered layouts/_header.html.erb (1.0ms) [[32mINFO [0m|#22036] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#22036] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#22036] Completed 200 OK in 96ms (Views: 13.8ms | ActiveRecord: 0.0ms | API: 78.0ms (XML: 0.0ms , View: 2.0ms , Backend: 0.0ms , DB: 2.5ms , HTTP: 55.2ms) | XML: 0.9ms) [[32mINFO [0m|#22036] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-04-11 10:54:59 +0000 [[32mINFO [0m|#22036] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#22036] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#22036] Authenticating with iChain mode: off [[32mINFO [0m|#22036] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#22036] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#22036] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#22036] Rendered main/_systemstatus.html.erb (1.2ms) [[32mINFO [0m|#22036] Completed 200 OK in 3ms (Views: 1.7ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|#22036] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#22036] RT http://localhost:3203/test/test_end {"view"=>0.859141, "db"=>50.607176, "backend"=>0, "xml"=>0, :runtime=>55.357000000000006, :all=>58.962108} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' + 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/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/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
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/874/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