[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #936
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/936/changes> Changes: [Stephan Kulow] [webui] rework flash code [Stephan Kulow] [api,webui] use dalli instead of memcache-client [Stephan Kulow] [api] no need to call test_end - the next start is good enough [Stephan Kulow] [api] some random preparations for rails4 [Stephan Kulow] [webui] fix routes not to allow all methods for all routes [adrian] [webui] use a proxy when fetching configuration.json [Stephan Kulow] [webui] use a common partial for all dialogs [Stephan Kulow] [webui] Fixed button position in dialog box [adrian] Revert "[webui] use a proxy when fetching configuration.json" [adrian] [api] support remote interconnect also with credentials ------------------------------------------ [...truncated 646527 lines...] [[32mINFO [0m|# 8296] Rendered shared/_buildresult_box.html.erb (1.0ms) [[32mINFO [0m|# 8296] Rendered layouts/_watch_and_search.html.erb (1.7ms) [[32mINFO [0m|# 8296] Rendered layouts/_header.html.erb (2.9ms) [[32mINFO [0m|# 8296] Rendered layouts/_personal_navigation.html.erb (1.5ms) [[32mINFO [0m|# 8296] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 8296] Completed 200 OK in 185ms (Views: 21.6ms | ActiveRecord: 0.0ms | API: 157.9ms (XML: 0.0ms , View: 1.6ms , Backend: 0.0ms , DB: 7.8ms , HTTP: 87.0ms) | XML: 0.8ms) [[32mINFO [0m|# 8296] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-05-13 13:08:28 +0000 [[32mINFO [0m|# 8296] Processing by ProjectController#buildresult as */* [[32mINFO [0m|# 8296] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|# 8296] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|# 8296] Authenticating with iChain mode: off [[32mINFO [0m|# 8296] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|# 8296] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 8296] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 8296] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 8296] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/person/tom {"view"=>0.7513930000000001, "db"=>1.5654029999999999, "backend"=>0, "xml"=>0, :runtime=>16.09, :all=>19.805258} [[0;37mDEBUG[0m|# 8296] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|# 8296] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|# 8296] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|# 8296] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|# 8296] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.866755, "backend"=>0, "xml"=>0, :runtime=>25.537, :all=>69.220763} [[32mINFO [0m|# 8296] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|# 8296] Completed 200 OK in 93ms (Views: 1.0ms | ActiveRecord: 0.0ms | API: 89.0ms (XML: 0.0ms , View: 0.8ms , Backend: 0.0ms , DB: 2.4ms , HTTP: 47.4ms) | XML: 0.3ms) [[32mINFO [0m|# 8296] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 13:08:28 +0000 [[32mINFO [0m|# 8296] Processing by ProjectController#show as HTML [[32mINFO [0m|# 8296] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 8296] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 8296] Authenticating with iChain mode: off [[32mINFO [0m|# 8296] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 8296] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 8296] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 8296] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 8296] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/person/tom {"view"=>0.5450649999999999, "db"=>1.4691280000000002, "backend"=>0, "xml"=>0, :runtime=>16.222, :all=>57.177942} [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.241205, "db"=>4.290187, "backend"=>0, "xml"=>0, :runtime=>32.361000000000004, :all=>74.478823} [[0;37mDEBUG[0m|# 8296] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.801855, "db"=>4.451954000000001, "backend"=>0, "xml"=>0, :runtime=>37.426, :all=>79.376124} [[0;37mDEBUG[0m|# 8296] 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|# 8296] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 8296] Rendered project/_tabs.html.erb (3.8ms) [[32mINFO [0m|# 8296] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|# 8296] Rendered layouts/_watch_and_search.html.erb (2.2ms) [[32mINFO [0m|# 8296] Rendered layouts/_header.html.erb (3.6ms) [[32mINFO [0m|# 8296] Rendered layouts/_personal_navigation.html.erb (2.1ms) [[32mINFO [0m|# 8296] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 8296] Completed 200 OK in 241ms (Views: 22.5ms | ActiveRecord: 0.0ms | API: 211.0ms (XML: 0.0ms , View: 1.6ms , Backend: 0.0ms , DB: 10.2ms , HTTP: 125.0ms) | XML: 0.8ms) [[32mINFO [0m|# 8296] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 13:08:28 +0000 [[32mINFO [0m|# 8296] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|# 8296] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 8296] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 8296] Authenticating with iChain mode: off [[32mINFO [0m|# 8296] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 8296] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 8296] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 8296] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 8296] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/person/tom {"view"=>0.653047, "db"=>1.3119150000000002, "backend"=>0, "xml"=>0, :runtime=>12.141, :all=>15.785034999999999} [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.242671, "db"=>4.039295, "backend"=>0, "xml"=>0, :runtime=>27.302, :all=>67.818494} [[0;37mDEBUG[0m|# 8296] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 8296] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|# 8296] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|# 8296] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|# 8296] 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|# 8296] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/person/tom {"view"=>1.137306, "db"=>2.561864, "backend"=>0, "xml"=>0, :runtime=>18.804000000000002, :all=>24.656263000000003} [[0;37mDEBUG[0m|# 8296] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|# 8296] params {:login=>"tom"} [[0;37mDEBUG[0m|# 8296] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/person/tom/group {"view"=>0.380012, "db"=>0.62234, "backend"=>0, "xml"=>0, :runtime=>7.034999999999999, :all=>10.402237} [[0;37mDEBUG[0m|# 8296] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|# 8296] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|# 8296] Redirected to http://127.0.0.1:60759/project/show?project=My%3AMaintenance [[32mINFO [0m|# 8296] Completed 302 Found in 123ms (ActiveRecord: 0.0ms | API: 118.7ms (XML: 0.0ms , View: 2.4ms , Backend: 0.0ms , DB: 8.5ms , HTTP: 53.4ms) | XML: 0.3ms) [[32mINFO [0m|# 8296] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 13:08:29 +0000 [[32mINFO [0m|# 8296] Processing by ProjectController#show as HTML [[32mINFO [0m|# 8296] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 8296] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 8296] Authenticating with iChain mode: off [[32mINFO [0m|# 8296] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 8296] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 8296] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 8296] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 8296] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/person/tom {"view"=>0.490421, "db"=>0.808477, "backend"=>0, "xml"=>0, :runtime=>8.13, :all=>48.02901} [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.236725, "db"=>3.9502749999999995, "backend"=>0, "xml"=>0, :runtime=>27.219, :all=>67.121651} [[0;37mDEBUG[0m|# 8296] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.417558, "db"=>3.4250590000000005, "backend"=>0, "xml"=>0, :runtime=>29.763, :all=>71.521669} [[0;37mDEBUG[0m|# 8296] 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|# 8296] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 8296] Rendered project/_tabs.html.erb (3.0ms) [[32mINFO [0m|# 8296] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|# 8296] Rendered layouts/_watch_and_search.html.erb (1.0ms) [[32mINFO [0m|# 8296] Rendered layouts/_header.html.erb (2.1ms) [[32mINFO [0m|# 8296] Rendered layouts/_personal_navigation.html.erb (1.6ms) [[32mINFO [0m|# 8296] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 8296] Completed 200 OK in 208ms (Views: 15.6ms | ActiveRecord: 0.0ms | API: 186.7ms (XML: 0.0ms , View: 1.1ms , Backend: 0.0ms , DB: 8.2ms , HTTP: 121.6ms) | XML: 0.6ms) [[32mINFO [0m|# 8296] Started POST "/user/logout" for 127.0.0.1 at 2013-05-13 13:08:29 +0000 [[32mINFO [0m|# 8296] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|# 8296] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|# 8296] Authenticating with iChain mode: off [[32mINFO [0m|# 8296] Authenticated request to "/user/logout" from tom [[32mINFO [0m|# 8296] Logging out: tom [[32mINFO [0m|# 8296] Redirected to http://127.0.0.1:60759/ [[0;37mDEBUG[0m|# 8296] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|# 8296] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms) [[32mINFO [0m|# 8296] Started GET "/" for 127.0.0.1 at 2013-05-13 13:08:29 +0000 [[32mINFO [0m|# 8296] Processing by MainController#index as HTML [[0;37mDEBUG[0m|# 8296] Setting return_to: "/" [[0;37mDEBUG[0m|# 8296] Authenticating with iChain mode: off [[32mINFO [0m|# 8296] Anonymous request to / [[0;37mDEBUG[0m|# 8296] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] Statusmessage_2fe508b303b3ed792c174b7580cb295c [[0;37mDEBUG[0m|# 8296] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] ) [[0;37mDEBUG[0m|# 8296] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"} [[0;37mDEBUG[0m|# 8296] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=4 [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/status/messages/?limit=4 {"view"=>1.084632, "db"=>0.663235, "backend"=>0, "xml"=>0, :runtime=>8.184000000000001, :all=>12.844171999999999} [[0;37mDEBUG[0m|# 8296] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|# 8296] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|# 8296] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|# 8296] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|# 8296] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|# 8296] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.731159, "db"=>3.183386, "backend"=>0, "xml"=>0, :runtime=>24.230999999999998, :all=>65.300351} [[32mINFO [0m|# 8296] Rendered shared/_sign_up.html.erb (1.3ms) [[32mINFO [0m|# 8296] Rendered main/_sponsors.html.erb (0.2ms) [[32mINFO [0m|# 8296] Rendered main/_news.html.erb (0.2ms) [[32mINFO [0m|# 8296] Rendered main/_latest_updates.erb (5.8ms) [[32mINFO [0m|# 8296] Rendered layouts/_watch_and_search.html.erb (0.6ms) [[32mINFO [0m|# 8296] Rendered layouts/_header.html.erb (1.5ms) [[32mINFO [0m|# 8296] Rendered layouts/_personal_navigation.html.erb (1.8ms) [[32mINFO [0m|# 8296] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 8296] Completed 200 OK in 104ms (Views: 20.4ms | ActiveRecord: 0.0ms | API: 78.1ms (XML: 0.0ms , View: 2.8ms , Backend: 0.0ms , DB: 3.8ms , HTTP: 45.7ms) | XML: 1.3ms) [[32mINFO [0m|# 8296] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-05-13 13:08:29 +0000 [[32mINFO [0m|# 8296] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|# 8296] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|# 8296] Authenticating with iChain mode: off [[32mINFO [0m|# 8296] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|# 8296] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|# 8296] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|# 8296] Rendered main/_systemstatus.html.erb (1.2ms) [[32mINFO [0m|# 8296] Completed 200 OK in 3ms (Views: 1.7ms | ActiveRecord: 0.0ms | XML: 0.3ms) + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/scheduler.done src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/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/937/changes> Changes: [mls] [backend] use async remote gbininfo requests to check aggregates [adrian] [api] fix a missing line on /lastevents call [Stephan Kulow] [webui] include the right helper in main controller ------------------------------------------ [...truncated 649345 lines...] [[32mINFO [0m|#28532] Rendered shared/_buildresult_box.html.erb (0.6ms) [[32mINFO [0m|#28532] Rendered layouts/_watch_and_search.html.erb (1.0ms) [[32mINFO [0m|#28532] Rendered layouts/_header.html.erb (1.8ms) [[32mINFO [0m|#28532] Rendered layouts/_personal_navigation.html.erb (0.9ms) [[32mINFO [0m|#28532] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#28532] Completed 200 OK in 176ms (Views: 14.4ms | ActiveRecord: 0.0ms | API: 156.6ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 7.5ms , HTTP: 83.5ms) | XML: 0.6ms) [[32mINFO [0m|#28532] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-05-13 14:13:54 +0000 [[32mINFO [0m|#28532] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#28532] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#28532] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#28532] Authenticating with iChain mode: off [[32mINFO [0m|#28532] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#28532] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#28532] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#28532] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#28532] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/person/tom {"view"=>0.519814, "db"=>1.557816, "backend"=>0, "xml"=>0, :runtime=>14.494, :all=>18.080148} [[0;37mDEBUG[0m|#28532] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#28532] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#28532] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#28532] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#28532] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.751648, "backend"=>0, "xml"=>0, :runtime=>23.539, :all=>62.204816} [[32mINFO [0m|#28532] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#28532] Completed 200 OK in 84ms (Views: 0.9ms | ActiveRecord: 0.0ms | API: 80.3ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.3ms , HTTP: 42.3ms) | XML: 0.3ms) [[32mINFO [0m|#28532] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 14:13:54 +0000 [[32mINFO [0m|#28532] Processing by ProjectController#show as HTML [[32mINFO [0m|#28532] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#28532] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#28532] Authenticating with iChain mode: off [[32mINFO [0m|#28532] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#28532] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#28532] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#28532] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#28532] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/person/tom {"view"=>0.513588, "db"=>1.308623, "backend"=>0, "xml"=>0, :runtime=>12.059000000000001, :all=>52.124928000000004} [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.242418, "db"=>3.8837149999999996, "backend"=>0, "xml"=>0, :runtime=>27.994, :all=>67.039778} [[0;37mDEBUG[0m|#28532] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.525935, "db"=>3.653061, "backend"=>0, "xml"=>0, :runtime=>36.275, :all=>75.513184} [[0;37mDEBUG[0m|#28532] 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|#28532] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#28532] Rendered project/_tabs.html.erb (2.2ms) [[32mINFO [0m|#28532] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#28532] Rendered layouts/_watch_and_search.html.erb (1.3ms) [[32mINFO [0m|#28532] Rendered layouts/_header.html.erb (2.1ms) [[32mINFO [0m|#28532] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#28532] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#28532] Completed 200 OK in 276ms (Views: 75.1ms | ActiveRecord: 0.0ms | API: 194.7ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 8.8ms , HTTP: 118.3ms) | XML: 0.5ms) [[32mINFO [0m|#28532] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 14:13:54 +0000 [[32mINFO [0m|#28532] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#28532] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#28532] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#28532] Authenticating with iChain mode: off [[32mINFO [0m|#28532] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#28532] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#28532] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#28532] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#28532] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/person/tom {"view"=>0.487863, "db"=>1.625393, "backend"=>0, "xml"=>0, :runtime=>15.238, :all=>18.618316} [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.19532100000000002, "db"=>3.3838810000000006, "backend"=>0, "xml"=>0, :runtime=>25.115, :all=>65.94663} [[0;37mDEBUG[0m|#28532] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#28532] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#28532] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#28532] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#28532] 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|#28532] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/person/tom {"view"=>0.928668, "db"=>2.2296380000000005, "backend"=>0, "xml"=>0, :runtime=>17.955, :all=>21.850138} [[0;37mDEBUG[0m|#28532] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#28532] params {:login=>"tom"} [[0;37mDEBUG[0m|#28532] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/person/tom/group {"view"=>0.330343, "db"=>0.5278179999999999, "backend"=>0, "xml"=>0, :runtime=>5.6930000000000005, :all=>8.878654} [[0;37mDEBUG[0m|#28532] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#28532] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#28532] Redirected to http://127.0.0.1:37519/project/show?project=My%3AMaintenance [[32mINFO [0m|#28532] Completed 302 Found in 121ms (ActiveRecord: 0.0ms | API: 115.3ms (XML: 0.0ms , View: 1.9ms , Backend: 0.0ms , DB: 7.8ms , HTTP: 51.3ms) | XML: 0.5ms) [[32mINFO [0m|#28532] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 14:13:55 +0000 [[32mINFO [0m|#28532] Processing by ProjectController#show as HTML [[32mINFO [0m|#28532] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#28532] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#28532] Authenticating with iChain mode: off [[32mINFO [0m|#28532] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#28532] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#28532] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#28532] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#28532] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/person/tom {"view"=>0.508939, "db"=>0.8605560000000001, "backend"=>0, "xml"=>0, :runtime=>8.301, :all=>47.337968000000004} [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.354549, "db"=>4.067562, "backend"=>0, "xml"=>0, :runtime=>29.064, :all=>70.83943400000001} [[0;37mDEBUG[0m|#28532] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.442643, "db"=>3.8464929999999997, "backend"=>0, "xml"=>0, :runtime=>35.428000000000004, :all=>74.342657} [[0;37mDEBUG[0m|#28532] 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|#28532] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#28532] Rendered project/_tabs.html.erb (2.6ms) [[32mINFO [0m|#28532] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|#28532] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|#28532] Rendered layouts/_header.html.erb (1.9ms) [[32mINFO [0m|#28532] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#28532] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#28532] Completed 200 OK in 212ms (Views: 14.4ms | ActiveRecord: 0.0ms | API: 192.5ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 8.8ms , HTTP: 119.7ms) | XML: 0.6ms) [[32mINFO [0m|#28532] Started POST "/user/logout" for 127.0.0.1 at 2013-05-13 14:13:55 +0000 [[32mINFO [0m|#28532] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#28532] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#28532] Authenticating with iChain mode: off [[32mINFO [0m|#28532] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#28532] Logging out: tom [[32mINFO [0m|#28532] Redirected to http://127.0.0.1:37519/ [[0;37mDEBUG[0m|#28532] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#28532] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#28532] Started GET "/" for 127.0.0.1 at 2013-05-13 14:13:55 +0000 [[32mINFO [0m|#28532] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#28532] Setting return_to: "/" [[0;37mDEBUG[0m|#28532] Authenticating with iChain mode: off [[32mINFO [0m|#28532] Anonymous request to / [[0;37mDEBUG[0m|#28532] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] Statusmessage_2fe508b303b3ed792c174b7580cb295c [[0;37mDEBUG[0m|#28532] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] ) [[0;37mDEBUG[0m|#28532] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"} [[0;37mDEBUG[0m|#28532] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=4 [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/status/messages/?limit=4 {"view"=>0.7486590000000001, "db"=>0.565805, "backend"=>0, "xml"=>0, :runtime=>5.899, :all=>9.855630000000001} [[0;37mDEBUG[0m|#28532] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#28532] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#28532] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#28532] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#28532] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#28532] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.030426, "db"=>1.991235, "backend"=>0, "xml"=>0, :runtime=>15.231, :all=>56.319622} [[32mINFO [0m|#28532] Rendered shared/_sign_up.html.erb (1.1ms) [[32mINFO [0m|#28532] Rendered main/_sponsors.html.erb (0.2ms) [[32mINFO [0m|#28532] Rendered main/_news.html.erb (0.2ms) [[32mINFO [0m|#28532] Rendered main/_latest_updates.erb (5.2ms) [[32mINFO [0m|#28532] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#28532] Rendered layouts/_header.html.erb (1.0ms) [[32mINFO [0m|#28532] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#28532] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#28532] Completed 200 OK in 85ms (Views: 15.4ms | ActiveRecord: 0.0ms | API: 66.2ms (XML: 0.0ms , View: 1.8ms , Backend: 0.0ms , DB: 2.6ms , HTTP: 45.0ms) | XML: 1.1ms) [[32mINFO [0m|#28532] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-05-13 14:13:55 +0000 [[32mINFO [0m|#28532] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#28532] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#28532] Authenticating with iChain mode: off [[32mINFO [0m|#28532] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#28532] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#28532] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#28532] Rendered main/_systemstatus.html.erb (1.5ms) [[32mINFO [0m|#28532] Completed 200 OK in 4ms (Views: 2.2ms | ActiveRecord: 0.0ms | XML: 0.4ms) + 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/938/changes> Changes: [adrian] [api] found a way to stay backward compatible and still support credentials for inter connect URLs ------------------------------------------ [...truncated 649357 lines...] [[32mINFO [0m|#15876] Rendered shared/_buildresult_box.html.erb (0.7ms) [[32mINFO [0m|#15876] Rendered layouts/_watch_and_search.html.erb (1.1ms) [[32mINFO [0m|#15876] Rendered layouts/_header.html.erb (1.9ms) [[32mINFO [0m|#15876] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#15876] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#15876] Completed 200 OK in 173ms (Views: 14.9ms | ActiveRecord: 0.0ms | API: 153.0ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 7.9ms , HTTP: 82.3ms) | XML: 0.7ms) [[32mINFO [0m|#15876] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-05-13 14:54:59 +0000 [[32mINFO [0m|#15876] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#15876] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#15876] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#15876] Authenticating with iChain mode: off [[32mINFO [0m|#15876] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#15876] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#15876] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#15876] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#15876] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/person/tom {"view"=>0.484659, "db"=>1.3183239999999998, "backend"=>0, "xml"=>0, :runtime=>11.847, :all=>15.505005} [[0;37mDEBUG[0m|#15876] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#15876] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#15876] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#15876] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#15876] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.763102, "backend"=>0, "xml"=>0, :runtime=>25.529, :all=>67.173475} [[32mINFO [0m|#15876] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#15876] Completed 200 OK in 86ms (Views: 0.9ms | ActiveRecord: 0.0ms | API: 82.7ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.1ms , HTTP: 45.3ms) | XML: 0.3ms) [[32mINFO [0m|#15876] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 14:54:59 +0000 [[32mINFO [0m|#15876] Processing by ProjectController#show as HTML [[32mINFO [0m|#15876] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#15876] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#15876] Authenticating with iChain mode: off [[32mINFO [0m|#15876] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#15876] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#15876] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#15876] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#15876] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/person/tom {"view"=>0.49157300000000004, "db"=>1.286119, "backend"=>0, "xml"=>0, :runtime=>11.911, :all=>53.579176} [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.27201200000000003, "db"=>4.622155000000001, "backend"=>0, "xml"=>0, :runtime=>94.097, :all=>134.89380500000001} [[0;37mDEBUG[0m|#15876] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.615909, "db"=>3.6473320000000005, "backend"=>0, "xml"=>0, :runtime=>36.583999999999996, :all=>75.300065} [[0;37mDEBUG[0m|#15876] 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|#15876] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#15876] Rendered project/_tabs.html.erb (3.0ms) [[32mINFO [0m|#15876] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#15876] Rendered layouts/_watch_and_search.html.erb (1.1ms) [[32mINFO [0m|#15876] Rendered layouts/_header.html.erb (1.9ms) [[32mINFO [0m|#15876] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#15876] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#15876] Completed 200 OK in 282ms (Views: 13.5ms | ActiveRecord: 0.0ms | API: 263.8ms (XML: 0.0ms , View: 1.4ms , Backend: 0.0ms , DB: 9.6ms , HTTP: 121.2ms) | XML: 0.6ms) [[32mINFO [0m|#15876] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 14:54:59 +0000 [[32mINFO [0m|#15876] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#15876] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#15876] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#15876] Authenticating with iChain mode: off [[32mINFO [0m|#15876] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#15876] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#15876] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#15876] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#15876] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/person/tom {"view"=>0.55596, "db"=>1.6061360000000002, "backend"=>0, "xml"=>0, :runtime=>13.115, :all=>16.869875} [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.277072, "db"=>5.262898, "backend"=>0, "xml"=>0, :runtime=>110.347, :all=>152.605517} [[0;37mDEBUG[0m|#15876] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#15876] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#15876] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#15876] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#15876] 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|#15876] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/person/tom {"view"=>0.956462, "db"=>1.9686199999999998, "backend"=>0, "xml"=>0, :runtime=>15.635, :all=>20.10678} [[0;37mDEBUG[0m|#15876] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#15876] params {:login=>"tom"} [[0;37mDEBUG[0m|#15876] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/person/tom/group {"view"=>0.374047, "db"=>0.629092, "backend"=>0, "xml"=>0, :runtime=>6.799, :all=>10.080404} [[0;37mDEBUG[0m|#15876] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#15876] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#15876] Redirected to http://127.0.0.1:41657/project/show?project=My%3AMaintenance [[32mINFO [0m|#15876] Completed 302 Found in 205ms (ActiveRecord: 0.0ms | API: 199.7ms (XML: 0.0ms , View: 2.2ms , Backend: 0.0ms , DB: 9.5ms , HTTP: 53.8ms) | XML: 0.4ms) [[32mINFO [0m|#15876] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 14:55:00 +0000 [[32mINFO [0m|#15876] Processing by ProjectController#show as HTML [[32mINFO [0m|#15876] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#15876] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#15876] Authenticating with iChain mode: off [[32mINFO [0m|#15876] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#15876] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#15876] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#15876] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#15876] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/person/tom {"view"=>0.502529, "db"=>0.808824, "backend"=>0, "xml"=>0, :runtime=>8.417, :all=>47.821954} [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.22769899999999998, "db"=>3.960762, "backend"=>0, "xml"=>0, :runtime=>29.671, :all=>72.11647} [[0;37mDEBUG[0m|#15876] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.487938, "db"=>3.5769970000000004, "backend"=>0, "xml"=>0, :runtime=>34.361000000000004, :all=>74.28955900000001} [[0;37mDEBUG[0m|#15876] 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|#15876] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#15876] Rendered project/_tabs.html.erb (2.5ms) [[32mINFO [0m|#15876] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#15876] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|#15876] Rendered layouts/_header.html.erb (1.7ms) [[32mINFO [0m|#15876] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#15876] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#15876] Completed 200 OK in 212ms (Views: 13.3ms | ActiveRecord: 0.0ms | API: 194.2ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 8.3ms , HTTP: 121.8ms) | XML: 0.5ms) [[32mINFO [0m|#15876] Started POST "/user/logout" for 127.0.0.1 at 2013-05-13 14:55:00 +0000 [[32mINFO [0m|#15876] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#15876] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#15876] Authenticating with iChain mode: off [[32mINFO [0m|#15876] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#15876] Logging out: tom [[32mINFO [0m|#15876] Redirected to http://127.0.0.1:41657/ [[0;37mDEBUG[0m|#15876] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#15876] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#15876] Started GET "/" for 127.0.0.1 at 2013-05-13 14:55:00 +0000 [[32mINFO [0m|#15876] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#15876] Setting return_to: "/" [[0;37mDEBUG[0m|#15876] Authenticating with iChain mode: off [[32mINFO [0m|#15876] Anonymous request to / [[0;37mDEBUG[0m|#15876] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] Statusmessage_2fe508b303b3ed792c174b7580cb295c [[0;37mDEBUG[0m|#15876] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] ) [[0;37mDEBUG[0m|#15876] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"} [[0;37mDEBUG[0m|#15876] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=4 [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/status/messages/?limit=4 {"view"=>0.731371, "db"=>0.483884, "backend"=>0, "xml"=>0, :runtime=>5.899, :all=>9.103183000000001} [[0;37mDEBUG[0m|#15876] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#15876] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#15876] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#15876] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#15876] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#15876] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>0.986983, "db"=>1.9843360000000003, "backend"=>0, "xml"=>0, :runtime=>15.166, :all=>56.650611} [[32mINFO [0m|#15876] Rendered shared/_sign_up.html.erb (1.1ms) [[32mINFO [0m|#15876] Rendered main/_sponsors.html.erb (0.2ms) [[32mINFO [0m|#15876] Rendered main/_news.html.erb (0.2ms) [[32mINFO [0m|#15876] Rendered main/_latest_updates.erb (5.2ms) [[32mINFO [0m|#15876] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#15876] Rendered layouts/_header.html.erb (1.1ms) [[32mINFO [0m|#15876] Rendered layouts/_personal_navigation.html.erb (1.3ms) [[32mINFO [0m|#15876] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#15876] Completed 200 OK in 86ms (Views: 17.0ms | ActiveRecord: 0.0ms | API: 65.8ms (XML: 0.0ms , View: 1.7ms , Backend: 0.0ms , DB: 2.5ms , HTTP: 44.7ms) | XML: 1.2ms) [[32mINFO [0m|#15876] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-05-13 14:55:00 +0000 [[32mINFO [0m|#15876] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#15876] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#15876] Authenticating with iChain mode: off [[32mINFO [0m|#15876] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#15876] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#15876] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#15876] Rendered main/_systemstatus.html.erb (1.6ms) [[32mINFO [0m|#15876] Completed 200 OK in 3ms (Views: 2.2ms | ActiveRecord: 0.0ms | XML: 0.4ms) + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/scheduler.done src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/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/939/> ------------------------------------------ [...truncated 648876 lines...] [[32mINFO [0m|# 2486] Rendered shared/_buildresult_box.html.erb (0.6ms) [[32mINFO [0m|# 2486] Rendered layouts/_watch_and_search.html.erb (1.2ms) [[32mINFO [0m|# 2486] Rendered layouts/_header.html.erb (2.8ms) [[32mINFO [0m|# 2486] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|# 2486] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 2486] Completed 200 OK in 282ms (Views: 16.3ms | ActiveRecord: 0.0ms | API: 260.3ms (XML: 0.0ms , View: 1.5ms , Backend: 0.0ms , DB: 8.9ms , HTTP: 85.6ms) | XML: 0.6ms) [[32mINFO [0m|# 2486] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-05-13 15:35:46 +0000 [[32mINFO [0m|# 2486] Processing by ProjectController#buildresult as */* [[32mINFO [0m|# 2486] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|# 2486] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|# 2486] Authenticating with iChain mode: off [[32mINFO [0m|# 2486] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|# 2486] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 2486] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 2486] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 2486] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/person/tom {"view"=>0.606339, "db"=>1.665495, "backend"=>0, "xml"=>0, :runtime=>14.068999999999999, :all=>17.829442} [[0;37mDEBUG[0m|# 2486] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|# 2486] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|# 2486] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|# 2486] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|# 2486] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild... [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.907919, "backend"=>0, "xml"=>0, :runtime=>23.809, :all=>65.79889999999999} [[32mINFO [0m|# 2486] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|# 2486] Completed 200 OK in 88ms (Views: 1.1ms | ActiveRecord: 0.0ms | API: 83.6ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 2.6ms , HTTP: 45.8ms) | XML: 0.3ms) [[32mINFO [0m|# 2486] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 15:35:46 +0000 [[32mINFO [0m|# 2486] Processing by ProjectController#show as HTML [[32mINFO [0m|# 2486] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 2486] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 2486] Authenticating with iChain mode: off [[32mINFO [0m|# 2486] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 2486] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 2486] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 2486] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 2486] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/person/tom {"view"=>0.799662, "db"=>1.594446, "backend"=>0, "xml"=>0, :runtime=>16.788, :all=>20.647553} [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.33351000000000003, "db"=>4.683133, "backend"=>0, "xml"=>0, :runtime=>37.594, :all=>80.442333} [[0;37mDEBUG[0m|# 2486] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.723418, "db"=>4.4893149999999995, "backend"=>0, "xml"=>0, :runtime=>42.257000000000005, :all=>83.378121} [[0;37mDEBUG[0m|# 2486] 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|# 2486] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 2486] Rendered project/_tabs.html.erb (3.5ms) [[32mINFO [0m|# 2486] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|# 2486] Rendered layouts/_watch_and_search.html.erb (1.8ms) [[32mINFO [0m|# 2486] Rendered layouts/_header.html.erb (3.0ms) [[32mINFO [0m|# 2486] Rendered layouts/_personal_navigation.html.erb (1.6ms) [[32mINFO [0m|# 2486] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 2486] Completed 200 OK in 210ms (Views: 19.0ms | ActiveRecord: 0.0ms | API: 184.5ms (XML: 0.0ms , View: 1.9ms , Backend: 0.0ms , DB: 10.8ms , HTTP: 87.8ms) | XML: 0.7ms) [[32mINFO [0m|# 2486] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 15:35:47 +0000 [[32mINFO [0m|# 2486] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|# 2486] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 2486] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 2486] Authenticating with iChain mode: off [[32mINFO [0m|# 2486] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 2486] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 2486] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 2486] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 2486] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/person/tom {"view"=>0.5530799999999999, "db"=>1.3385340000000001, "backend"=>0, "xml"=>0, :runtime=>12.232, :all=>15.806608} [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.267214, "db"=>3.704787, "backend"=>0, "xml"=>0, :runtime=>26.522000000000002, :all=>66.32639999999999} [[0;37mDEBUG[0m|# 2486] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 2486] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|# 2486] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|# 2486] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|# 2486] 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|# 2486] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/person/tom {"view"=>0.99861, "db"=>2.0541340000000003, "backend"=>0, "xml"=>0, :runtime=>16.119999999999997, :all=>21.827589} [[0;37mDEBUG[0m|# 2486] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|# 2486] params {:login=>"tom"} [[0;37mDEBUG[0m|# 2486] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/person/tom/group {"view"=>0.43451, "db"=>0.917923, "backend"=>0, "xml"=>0, :runtime=>7.995, :all=>10.916165} [[0;37mDEBUG[0m|# 2486] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|# 2486] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|# 2486] Redirected to http://127.0.0.1:59130/project/show?project=My%3AMaintenance [[32mINFO [0m|# 2486] Completed 302 Found in 119ms (ActiveRecord: 0.0ms | API: 114.9ms (XML: 0.0ms , View: 2.3ms , Backend: 0.0ms , DB: 8.0ms , HTTP: 52.0ms) | XML: 0.3ms) [[32mINFO [0m|# 2486] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-05-13 15:35:47 +0000 [[32mINFO [0m|# 2486] Processing by ProjectController#show as HTML [[32mINFO [0m|# 2486] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 2486] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 2486] Authenticating with iChain mode: off [[32mINFO [0m|# 2486] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 2486] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 2486] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 2486] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 2486] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/person/tom {"view"=>0.44573300000000005, "db"=>0.688377, "backend"=>0, "xml"=>0, :runtime=>7.609999999999999, :all=>50.038222} [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.251762, "db"=>4.639206, "backend"=>0, "xml"=>0, :runtime=>96.435, :all=>139.11366} [[0;37mDEBUG[0m|# 2486] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.498777, "db"=>3.8440070000000004, "backend"=>0, "xml"=>0, :runtime=>34.87, :all=>75.273269} [[0;37mDEBUG[0m|# 2486] 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|# 2486] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 2486] Rendered project/_tabs.html.erb (2.4ms) [[32mINFO [0m|# 2486] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|# 2486] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|# 2486] Rendered layouts/_header.html.erb (1.5ms) [[32mINFO [0m|# 2486] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|# 2486] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|# 2486] Completed 200 OK in 281ms (Views: 12.1ms | ActiveRecord: 0.0ms | API: 264.4ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 9.2ms , HTTP: 125.5ms) | XML: 0.5ms) [[32mINFO [0m|# 2486] Started POST "/user/logout" for 127.0.0.1 at 2013-05-13 15:35:47 +0000 [[32mINFO [0m|# 2486] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|# 2486] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|# 2486] Authenticating with iChain mode: off [[32mINFO [0m|# 2486] Authenticated request to "/user/logout" from tom [[32mINFO [0m|# 2486] Logging out: tom [[32mINFO [0m|# 2486] Redirected to http://127.0.0.1:59130/ [[0;37mDEBUG[0m|# 2486] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|# 2486] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms) [[32mINFO [0m|# 2486] Started GET "/" for 127.0.0.1 at 2013-05-13 15:35:47 +0000 [[32mINFO [0m|# 2486] Processing by MainController#index as HTML [[0;37mDEBUG[0m|# 2486] Setting return_to: "/" [[0;37mDEBUG[0m|# 2486] Authenticating with iChain mode: off [[32mINFO [0m|# 2486] Anonymous request to / [[0;37mDEBUG[0m|# 2486] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] Statusmessage_2fe508b303b3ed792c174b7580cb295c [[0;37mDEBUG[0m|# 2486] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] ) [[0;37mDEBUG[0m|# 2486] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"} [[0;37mDEBUG[0m|# 2486] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=4 [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/status/messages/?limit=4 {"view"=>0.949615, "db"=>0.569526, "backend"=>0, "xml"=>0, :runtime=>6.720000000000001, :all=>10.495891} [[0;37mDEBUG[0m|# 2486] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|# 2486] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|# 2486] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|# 2486] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|# 2486] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|# 2486] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.301056, "db"=>2.204227, "backend"=>0, "xml"=>0, :runtime=>18.028, :all=>59.487342999999996} [[32mINFO [0m|# 2486] Rendered shared/_sign_up.html.erb (0.9ms) [[32mINFO [0m|# 2486] Rendered main/_sponsors.html.erb (0.1ms) [[32mINFO [0m|# 2486] Rendered main/_news.html.erb (0.2ms) [[32mINFO [0m|# 2486] Rendered main/_latest_updates.erb (4.2ms) [[32mINFO [0m|# 2486] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|# 2486] Rendered layouts/_header.html.erb (1.2ms) [[32mINFO [0m|# 2486] Rendered layouts/_personal_navigation.html.erb (1.3ms) [[32mINFO [0m|# 2486] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 2486] Completed 200 OK in 154ms (Views: 79.7ms | ActiveRecord: 0.0ms | API: 70.0ms (XML: 0.0ms , View: 2.3ms , Backend: 0.0ms , DB: 2.8ms , HTTP: 45.2ms) | XML: 1.0ms) [[32mINFO [0m|# 2486] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-05-13 15:35:48 +0000 [[32mINFO [0m|# 2486] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|# 2486] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|# 2486] Authenticating with iChain mode: off [[32mINFO [0m|# 2486] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|# 2486] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|# 2486] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|# 2486] Rendered main/_systemstatus.html.erb (1.7ms) [[32mINFO [0m|# 2486] Completed 200 OK in 4ms (Views: 2.6ms | ActiveRecord: 0.0ms | XML: 0.5ms) + 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/940/changes> Changes: [Stephan Kulow] [api, webui] do not rely on multi_json or yajl, json will do for us [Stephan Kulow] [dist] update gemfile.locks ------------------------------------------ Started by upstream project "obs_master_testsuite_api" build number 1508 originally caused by: Started by upstream project "obs_master_check_deps" build number 602 originally caused by: Started by upstream project "obs_master_update_deps" build number 262 originally caused by: Started by an SCM change [EnvInject] - Loading node environment variables. Building remotely on obs_master_deps_chroot in workspace <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> Checkout:obs_master_testsuite_webui / <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> - hudson.remoting.Channel@14a114a1:obs_master_deps_chroot Using strategy: Default Last Built Revision: Revision f4395fb8a860d2646bef65de0b8de9dde5e6f283 (origin/master) Fetching changes from 1 remote Git repository Fetching upstream changes from origin Commencing build of Revision ec1cf3768866aa798d12d63c3fc57608384b7398 (origin/master) Checking out Revision ec1cf3768866aa798d12d63c3fc57608384b7398 (origin/master) [locks-and-latches] Checking to see if we really have the locks [locks-and-latches] Have all the locks, build can start [obs_master_testsuite_webui] $ /bin/sh -xe /tmp/hudson3690998385506524260.sh + sh dist/ci/obs_testsuite_webui.sh ++ dirname dist/ci/obs_testsuite_webui.sh + . dist/ci/obs_testsuite_common.sh + setup_git + echo 'Checking status' Checking status + git status # Not currently on any branch. # Untracked files: # (use "git add <file>..." to include in what will be committed) # # src/webui/EmptySource1.c # src/webui/HomeSourceFile2.cc # src/webui/MySourceFile.cc # src/webui/results/ nothing added to commit but untracked files present (use "git add" to track) + echo 'Setup git submodules' Setup git submodules + git submodule init Submodule 'src/backend/build' () registered for path 'src/backend/build' + git submodule update + echo 'Setup backend configuration template' Setup backend configuration template + sed -i -e 's|my $hostname = .*$|my $hostname = '\''localhost'\'';|' -e 's|our $bsuser = '\''obsrun'\'';|our $bsuser = '\''jenkins'\'';|' -e 's|our $bsgroup = '\''obsrun'\'';|our $bsgroup = '\''jenkins'\'';|' src/backend/BSConfig.pm.template + cp src/backend/BSConfig.pm.template src/backend/BSConfig.pm + echo 'Set environment variables' Set environment variables + export RAILS_ENV=test + RAILS_ENV=test + ret=0 + setup_api + echo 'Enter API rails root' Enter API rails root + cd src/api + echo 'Setup database configuration' Setup database configuration + cp config/database.yml.example config/database.yml + sed -i 's|database: api|database: ci_api|' config/database.yml + echo 'Setup additional configuration' Setup additional configuration + cp config/options.yml.example config/options.yml + chmod a+x script/start_test_backend + echo 'Initialize test database, load seed data' Initialize test database, load seed data + bundle exec rake db:drop db:create db:setup --trace /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/spec_set.rb:92:in `block in materialize': Could not find pry-0.9.12.2 in any of the sources (Bundler::GemNotFound) from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/spec_set.rb:85:in `map!' from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/spec_set.rb:85:in `materialize' from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/definition.rb:114:in `specs' from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/definition.rb:159:in `specs_for' from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/definition.rb:148:in `requested_specs' from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/environment.rb:18:in `requested_specs' from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/runtime.rb:13:in `setup' from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler.rb:120:in `setup' from /usr/lib64/ruby/gems/1.9.1/gems/bundler-1.3.4/lib/bundler/setup.rb:17:in `<top (required)>' from /usr/lib64/ruby/1.9.1/rubygems/custom_require.rb:36:in `require' from /usr/lib64/ruby/1.9.1/rubygems/custom_require.rb:36:in `require' 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/941/> -- 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