December 2012 - Open Build Service Tests

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #752
by admin＠opensuse.org 30 Dec '12

30 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/752/changes> Changes: [Stephan Kulow] [webui] test and fix "request role addition" [Stephan Kulow] [webui] make 100% of apidocs controller covered [Stephan Kulow] [api] remove unused variable [Stephan Kulow] [api] fix bug with creating repositories in remote project [Stephan Kulow] [webui] fix the url for loading of distributions ------------------------------------------ [...truncated 587008 lines...] [[32mINFO [0m|#13993] Rendered project/_tabs.html.erb (4.9ms) [[32mINFO [0m|#13993] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|#13993] Rendered shared/_buildresult_box.html.erb (0.8ms) [[32mINFO [0m|#13993] Rendered layouts/_watch_and_search.html.erb (1.3ms) [[32mINFO [0m|#13993] Rendered layouts/_header.html.erb (2.1ms) [[32mINFO [0m|#13993] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#13993] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#13993] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#13993] Completed 200 OK in 408ms (Views: 19.5ms | ActiveRecord: 0.0ms | API: 381.5ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 12.6ms , HTTP: 169.2ms) | XML: 1.1ms) [[32mINFO [0m|#13993] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2012-12-30 14:52:24 +0100 [[32mINFO [0m|#13993] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#13993] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#13993] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#13993] Authenticating with iChain mode: off [[32mINFO [0m|#13993] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#13993] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#13993] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#13993] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#13993] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/person/tom {"view"=>0.576239, "db"=>1.5601439999999998, "backend"=>0, "xml"=>0, :runtime=>14.86, :all=>18.372839} [[0;37mDEBUG[0m|#13993] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#13993] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#13993] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#13993] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#13993] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.5911899999999999, "backend"=>0, "xml"=>0, :runtime=>35.797000000000004, :all=>77.68924000000001} [[32mINFO [0m|#13993] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#13993] Completed 200 OK in 99ms (Views: 0.7ms | ActiveRecord: 0.0ms | API: 96.1ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 2.2ms , HTTP: 45.4ms) | XML: 0.2ms) [[32mINFO [0m|#13993] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2012-12-30 14:52:24 +0100 [[32mINFO [0m|#13993] Processing by ProjectController#show as HTML [[32mINFO [0m|#13993] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#13993] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#13993] Authenticating with iChain mode: off [[32mINFO [0m|#13993] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#13993] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#13993] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#13993] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#13993] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/person/tom {"view"=>0.739796, "db"=>1.4157989999999998, "backend"=>0, "xml"=>0, :runtime=>17.662, :all=>21.304920000000003} [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.26858699999999996, "db"=>3.6919119999999994, "backend"=>0, "xml"=>0, :runtime=>33.184, :all=>102.76384399999999} [[0;37mDEBUG[0m|#13993] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.40345000000000003, "db"=>3.2301550000000003, "backend"=>0, "xml"=>0, :runtime=>33.201, :all=>74.47686300000001} [[0;37mDEBUG[0m|#13993] 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=\"BaseDistro2.0:LinkedUpdateProject\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro2.0:LinkedUpdateProject" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#13993] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#13993] Rendered project/_tabs.html.erb (2.4ms) [[32mINFO [0m|#13993] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#13993] Rendered layouts/_watch_and_search.html.erb (1.4ms) [[32mINFO [0m|#13993] Rendered layouts/_header.html.erb (2.3ms) [[32mINFO [0m|#13993] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#13993] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#13993] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#13993] Completed 200 OK in 220ms (Views: 14.9ms | ActiveRecord: 0.0ms | API: 198.5ms (XML: 0.0ms , View: 1.4ms , Backend: 0.0ms , DB: 8.3ms , HTTP: 114.5ms) | XML: 0.7ms) [[32mINFO [0m|#13993] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2012-12-30 14:52:25 +0100 [[32mINFO [0m|#13993] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#13993] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#13993] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#13993] Authenticating with iChain mode: off [[32mINFO [0m|#13993] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#13993] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#13993] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#13993] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#13993] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/person/tom {"view"=>0.6320209999999999, "db"=>1.081883, "backend"=>0, "xml"=>0, :runtime=>14.442, :all=>17.789833} [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.205903, "db"=>3.0738680000000005, "backend"=>0, "xml"=>0, :runtime=>30.776, :all=>71.935891} [[0;37mDEBUG[0m|#13993] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#13993] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#13993] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#13993] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#13993] saving object Person ({:is_current=>"true", :login=>"tom"}) to api: <person> <login>tom</login> <email>tschmidt(a)suse.de</email> <realname>Thor</realname> <watchlist> </watchlist> </person> [[0;37mDEBUG[0m|#13993] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/person/tom {"view"=>0.8982359999999999, "db"=>1.8018859999999997, "backend"=>0, "xml"=>0, :runtime=>17.887, :all=>23.588583} [[0;37mDEBUG[0m|#13993] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#13993] params {:login=>"tom"} [[0;37mDEBUG[0m|#13993] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/person/tom/group {"view"=>0.49722099999999997, "db"=>0.392156, "backend"=>0, "xml"=>0, :runtime=>7.2490000000000006, :all=>14.189564} [[0;37mDEBUG[0m|#13993] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#13993] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#13993] Redirected to http://127.0.0.1:51186/project/show?project=My%3AMaintenance [[32mINFO [0m|#13993] Completed 302 Found in 133ms (ActiveRecord: 0.0ms | API: 127.5ms (XML: 0.0ms , View: 2.2ms , Backend: 0.0ms , DB: 6.3ms , HTTP: 57.1ms) | XML: 0.3ms) [[32mINFO [0m|#13993] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2012-12-30 14:52:25 +0100 [[32mINFO [0m|#13993] Processing by ProjectController#show as HTML [[32mINFO [0m|#13993] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#13993] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#13993] Authenticating with iChain mode: off [[32mINFO [0m|#13993] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#13993] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#13993] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#13993] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#13993] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/person/tom {"view"=>0.837463, "db"=>1.0116450000000001, "backend"=>0, "xml"=>0, :runtime=>9.203, :all=>50.521425} [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.310341, "db"=>3.683474, "backend"=>0, "xml"=>0, :runtime=>35.124, :all=>78.83701699999999} [[0;37mDEBUG[0m|#13993] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#13993] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.396764, "db"=>3.1734229999999997, "backend"=>0, "xml"=>0, :runtime=>102.117, :all=>143.504562} [[0;37mDEBUG[0m|#13993] 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=\"BaseDistro2.0:LinkedUpdateProject\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro2.0:LinkedUpdateProject" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#13993] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#13993] Rendered project/_tabs.html.erb (3.2ms) [[32mINFO [0m|#13993] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|#13993] Rendered layouts/_watch_and_search.html.erb (1.0ms) [[32mINFO [0m|#13993] Rendered layouts/_header.html.erb (1.8ms) [[32mINFO [0m|#13993] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#13993] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#13993] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#13993] Completed 200 OK in 293ms (Views: 14.7ms | ActiveRecord: 0.0ms | API: 272.9ms (XML: 0.0ms , View: 1.5ms , Backend: 0.0ms , DB: 7.9ms , HTTP: 126.4ms) | XML: 0.8ms) [[32mINFO [0m|#13993] Started POST "/user/logout" for 127.0.0.1 at 2012-12-30 14:52:25 +0100 [[32mINFO [0m|#13993] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#13993] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#13993] Authenticating with iChain mode: off [[32mINFO [0m|#13993] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#13993] Logging out: tom [[32mINFO [0m|#13993] Redirected to http://127.0.0.1:51186/ [[0;37mDEBUG[0m|#13993] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#13993] Completed 302 Found in 34ms (ActiveRecord: 31.4ms | XML: 0.0ms) [[32mINFO [0m|#13993] Started GET "/" for 127.0.0.1 at 2012-12-30 14:52:25 +0100 [[32mINFO [0m|#13993] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#13993] Setting return_to: "/" [[0;37mDEBUG[0m|#13993] Authenticating with iChain mode: off [[32mINFO [0m|#13993] Anonymous request to / [[0;37mDEBUG[0m|#13993] returning [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] from rails cache Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#13993] returning [{:limit=>"6", :shared=>"true"}] from rails cache LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[32mINFO [0m|#13993] Rendered main/_news.html.erb (0.6ms) [[32mINFO [0m|#13993] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|#13993] Rendered main/_latest_updates.erb (6.0ms) [[32mINFO [0m|#13993] Rendered main/_countdown.html.erb (0.1ms) [[32mINFO [0m|#13993] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#13993] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|#13993] Rendered layouts/_watch_and_search.html.erb (0.7ms) [[32mINFO [0m|#13993] Rendered layouts/_header.html.erb (1.4ms) [[32mINFO [0m|#13993] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#13993] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#13993] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#13993] Completed 200 OK in 22ms (Views: 18.1ms | ActiveRecord: 0.0ms | XML: 0.2ms) [[32mINFO [0m|#13993] Started GET "/main/systemstatus" for 127.0.0.1 at 2012-12-30 14:52:26 +0100 [[32mINFO [0m|#13993] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#13993] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#13993] Authenticating with iChain mode: off [[32mINFO [0m|#13993] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#13993] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#13993] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#13993] Rendered main/_systemstatus.html.erb (2.0ms) [[32mINFO [0m|#13993] Completed 200 OK in 4ms (Views: 2.8ms | ActiveRecord: 0.0ms | XML: 0.5ms) [[0;37mDEBUG[0m|#13993] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#13993] RT http://localhost:3203/test/test_end {"view"=>1.602541, "db"=>23.873042, "backend"=>0, "xml"=>0, :runtime=>30.963, :all=>36.499277} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. sh + 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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #749
by admin＠opensuse.org 21 Dec '12

21 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/749/changes> Changes: [adrian] [api] show also remote distributions from all remote projects [adrian] [api] complete the api docu for /distributions* operations [adrian] [api] remove remote projects from distribution database, we do import request them on the fly now ------------------------------------------ Started by upstream project "obs_master_testsuite_api" build number 1285 originally caused by: Started by upstream project "obs_master_check_deps" build number 74 originally caused by: Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Building in workspace <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> Checkout:workspace / <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> - hudson.remoting.LocalChannel@6ed56ed5 Using strategy: Default Last Built Revision: Revision 0b7bbc53661ec7708fbef72ea67766bc6b8f58f3 (origin/master) Fetching changes from 1 remote Git repository Fetching upstream changes from git://github.com/openSUSE/open-build-service.git Commencing build of Revision 7b80576ca6db635de38a921097d436b2b1a7b99b (origin/master) Checking out Revision 7b80576ca6db635de38a921097d436b2b1a7b99b (origin/master) [locks-and-latches] Checking to see if we really have the locks [locks-and-latches] Have all the locks, build can start [workspace] $ /bin/sh -xe /tmp/hudson7317031882624084432.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/api/Gemfile.lock.orig # src/webui/EmptySource1.c # src/webui/Gemfile.lock.orig # src/webui/HomeSourceFile2.cc # src/webui/MySourceFile.cc # src/webui/db/structure.sql # src/webui/public/themes/ # src/webui/results/ # src/webui/webrat.log nothing added to commit but untracked files present (use "git add" to track) + echo 'Setup git submodules' Setup git submodules + git submodule init + 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 + echo 'Install missing gems locally' Install missing gems locally + mv Gemfile.lock Gemfile.lock.orig + bundle list Gems included by the bundle: * actionmailer (3.2.9) * actionpack (3.2.9) * activemodel (3.2.9) * activerecord (3.2.9) * activesupport (3.2.9) * arel (3.0.2) * builder (3.0.4) * bundler (1.2.2) * ci_reporter (1.8.0) * coderay (1.0.8) * daemons (1.1.9) * database_cleaner (0.9.1) * delayed_job (3.0.4) * delayed_job_active_record (0.3.3) * erubis (2.7.0) * faker (1.1.2) * fast_xs (0.8.0) * hike (1.2.1) * hoptoad_notifier (2.4.11) * i18n (0.6.1) * journey (1.0.4) * json (1.7.5) * mail (2.4.4) * memcache-client (1.8.5) * method_source (0.8.1) * mime-types (1.19) * minitest (4.3.2) * multi_json (1.4.0) * mysql2 (0.3.11) * nokogiri (1.5.5) * pkg-config (1.1.4) * polyglot (0.3.3) * pry (0.9.10) * rack (1.4.1) * rack-cache (1.2) * rack-ssl (1.3.2) * rack-test (0.6.2) * rails-api (0.0.2) * railties (3.2.9) * rake (0.9.2.2) * rdoc (3.12) * simplecov (0.7.1) * simplecov-html (0.7.1) * simplecov-rcov (0.2.3) * slop (3.3.3) * sprockets (2.2.1) * thor (0.16.0) * tilt (1.3.3) * timecop (0.5.4) * treetop (1.4.12) * tzinfo (0.3.35) * xmlhash (1.3.4) * yajl-ruby (1.1.0) + diff -u Gemfile.lock.orig Gemfile.lock + chmod a+x script/start_test_backend + echo 'Initialize test database, load seed data' Initialize test database, load seed data + rake db:drop db:create db:setup --trace ** Invoke db:drop (first_time) ** Invoke db:load_config (first_time) ** Execute db:load_config ** Invoke rails_env (first_time) ** Execute rails_env ** Execute db:drop ** Invoke db:create (first_time) ** Invoke db:load_config ** Invoke rails_env ** Execute db:create ** Invoke db:setup (first_time) ** Execute db:setup ** Invoke db:structure:load (first_time) ** Invoke environment (first_time) ** Execute environment ** Invoke db:load_config ** Execute db:structure:load ** Invoke db:seed (first_time) ** Execute db:seed ** Invoke db:abort_if_pending_migrations (first_time) ** Invoke environment ** Invoke db:load_config ** Execute db:abort_if_pending_migrations Run `rake db:migrate` to update your database then try again. You have 1 pending migrations: 20121220151549 DropRemoteDistributions 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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1286
by admin＠opensuse.org 21 Dec '12

21 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_api/1286/changes> Changes: [adrian] [api] show also remote distributions from all remote projects [adrian] [api] complete the api docu for /distributions* operations [adrian] [api] remove remote projects from distribution database, we do import request them on the fly now ------------------------------------------ Started by upstream project "obs_master_check_deps" build number 75 originally caused by: Started by an SCM change Building in workspace <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> Checkout:workspace / <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> - hudson.remoting.LocalChannel@6ed56ed5 Using strategy: Default Last Built Revision: Revision 0b7bbc53661ec7708fbef72ea67766bc6b8f58f3 (origin/master) Fetching changes from 1 remote Git repository Fetching upstream changes from git://github.com/openSUSE/open-build-service.git Commencing build of Revision 7b80576ca6db635de38a921097d436b2b1a7b99b (origin/master) Checking out Revision 7b80576ca6db635de38a921097d436b2b1a7b99b (origin/master) [locks-and-latches] Checking to see if we really have the locks [locks-and-latches] Have all the locks, build can start [workspace] $ /bin/sh -xe /tmp/hudson132086174514089072.sh + sh dist/ci/obs_testsuite_api.sh ++ dirname dist/ci/obs_testsuite_api.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/api/Gemfile.lock.orig # src/api/results/ # src/webui/public/themes/ nothing added to commit but untracked files present (use "git add" to track) + echo 'Setup git submodules' Setup git submodules + git submodule init + 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 + echo 'Install missing gems locally' Install missing gems locally + mv Gemfile.lock Gemfile.lock.orig + bundle list Gems included by the bundle: * actionmailer (3.2.9) * actionpack (3.2.9) * activemodel (3.2.9) * activerecord (3.2.9) * activesupport (3.2.9) * arel (3.0.2) * builder (3.0.4) * bundler (1.2.2) * ci_reporter (1.8.0) * coderay (1.0.8) * daemons (1.1.9) * database_cleaner (0.9.1) * delayed_job (3.0.4) * delayed_job_active_record (0.3.3) * erubis (2.7.0) * faker (1.1.2) * fast_xs (0.8.0) * hike (1.2.1) * hoptoad_notifier (2.4.11) * i18n (0.6.1) * journey (1.0.4) * json (1.7.5) * mail (2.4.4) * memcache-client (1.8.5) * method_source (0.8.1) * mime-types (1.19) * minitest (4.3.2) * multi_json (1.4.0) * mysql2 (0.3.11) * nokogiri (1.5.5) * pkg-config (1.1.4) * polyglot (0.3.3) * pry (0.9.10) * rack (1.4.1) * rack-cache (1.2) * rack-ssl (1.3.2) * rack-test (0.6.2) * rails-api (0.0.2) * railties (3.2.9) * rake (0.9.2.2) * rdoc (3.12) * simplecov (0.7.1) * simplecov-html (0.7.1) * simplecov-rcov (0.2.3) * slop (3.3.3) * sprockets (2.2.1) * thor (0.16.0) * tilt (1.3.3) * timecop (0.5.4) * treetop (1.4.12) * tzinfo (0.3.35) * xmlhash (1.3.4) * yajl-ruby (1.1.0) + diff -u Gemfile.lock.orig Gemfile.lock + chmod a+x script/start_test_backend + echo 'Initialize test database, load seed data' Initialize test database, load seed data + rake db:drop db:create db:setup --trace ** Invoke db:drop (first_time) ** Invoke db:load_config (first_time) ** Execute db:load_config ** Invoke rails_env (first_time) ** Execute rails_env ** Execute db:drop ** Invoke db:create (first_time) ** Invoke db:load_config ** Invoke rails_env ** Execute db:create ** Invoke db:setup (first_time) ** Execute db:setup ** Invoke db:structure:load (first_time) ** Invoke environment (first_time) ** Execute environment ** Invoke db:load_config ** Execute db:structure:load ** Invoke db:seed (first_time) ** Execute db:seed ** Invoke db:abort_if_pending_migrations (first_time) ** Invoke environment ** Invoke db:load_config ** Execute db:abort_if_pending_migrations Run `rake db:migrate` to update your database then try again. You have 1 pending migrations: 20121220151549 DropRemoteDistributions 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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #745
by admin＠opensuse.org 19 Dec '12

19 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/745/changes> Changes: [Stephan Kulow] [api] fix and test timestamps of requests [Stephan Kulow] [api] do not show deleted issues in the webui [adrian] [api] speed up owner lookup a lot by avoiding double checks [Stephan Kulow] [api] fix the logic of the request events for webui [Stephan Kulow] [api] fix crash on factory reviews [mls] [backend] handoff diff job that are already running to the ajax server [mls] [backend] add a marker that the package list is incomplete [mls] [backend] delete .run file after it is no longer in use [Stephan Kulow] [webui] Refactor search controller and view [Stephan Kulow] [webui] Fix some search tests [Stephan Kulow] [webui] Fix defaults logic in search [Stephan Kulow] [webui] More search controller work [Stephan Kulow] [webui] Re-factor the search results to make them accessible for the search test [adrian] [api] fix branching of packages with local links containing a dot in the name (aka glibc.i686 bnc#794347) [adrian] [dist] include /bin in PATH on Fedora 17 [adrian] [dist] Unhardcoded mysql datadir path. webui db created by rake. [adrian] [dist] take OBS_BASE_DIR into account for setting up the database. [adrian] [webui] Implement owner search result with multiple people... [Stephan Kulow] [api] add a new statistics route to get the data necessary to produce reports like [Stephan Kulow] [api] add the view for the previous change - forgot git add [ro] [backend] bs_signer: do not forget to send "withpubkey" when requesting the pubkey [ro] [backend] bs_worker: use signdummy regardless of localkiwi case [adrian] [webui] Follow server side default for including devel packages or not on owner search [adrian] [webui] prefer bugowner definition if it does exist [adrian] [api] move distributions XML to real Rails model. [adrian] [dist] mention the distribution.xml change in ReleaseNotes [adrian] [api] fix random test suite failures [Stephan Kulow] [api] give package activity a meaning ------------------------------------------ [...truncated 579230 lines...] [[32mINFO [0m|# 3835] Processing by ProjectController#buildresult as */* [[32mINFO [0m|# 3835] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|# 3835] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|# 3835] Authenticating with iChain mode: off [[32mINFO [0m|# 3835] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|# 3835] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 3835] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 3835] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 3835] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/person/tom {"view"=>0.768317, "db"=>1.927823, "backend"=>0, "xml"=>0, :runtime=>13.919, :all=>17.478792} [[0;37mDEBUG[0m|# 3835] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|# 3835] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|# 3835] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|# 3835] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|# 3835] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.874136, "backend"=>0, "xml"=>0, :runtime=>32.811, :all=>77.45872} [[32mINFO [0m|# 3835] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|# 3835] Completed 200 OK in 100ms (Views: 1.0ms | ActiveRecord: 0.0ms | API: 94.9ms (XML: 0.0ms , View: 0.8ms , Backend: 0.0ms , DB: 2.8ms , HTTP: 48.2ms) | XML: 0.3ms) [[32mINFO [0m|# 3835] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2012-12-19 22:19:21 +0100 [[32mINFO [0m|# 3835] Processing by ProjectController#show as HTML [[32mINFO [0m|# 3835] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 3835] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 3835] Authenticating with iChain mode: off [[32mINFO [0m|# 3835] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 3835] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 3835] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 3835] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 3835] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/person/tom {"view"=>0.545424, "db"=>1.330499, "backend"=>0, "xml"=>0, :runtime=>13.584000000000001, :all=>16.97979} [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.260252, "db"=>3.089452, "backend"=>0, "xml"=>0, :runtime=>90.928, :all=>131.231135} [[0;37mDEBUG[0m|# 3835] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.57436, "db"=>8.139685, "backend"=>0, "xml"=>0, :runtime=>117.09, :all=>163.383072} [[0;37mDEBUG[0m|# 3835] 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|# 3835] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 3835] Rendered project/_tabs.html.erb (3.0ms) [[32mINFO [0m|# 3835] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|# 3835] Rendered layouts/_watch_and_search.html.erb (2.0ms) [[32mINFO [0m|# 3835] Rendered layouts/_header.html.erb (3.2ms) [[32mINFO [0m|# 3835] Rendered layouts/_personal_navigation.html.erb (1.5ms) [[32mINFO [0m|# 3835] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 3835] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|# 3835] Completed 200 OK in 334ms (Views: 17.1ms | ActiveRecord: 0.0ms | API: 311.6ms (XML: 0.0ms , View: 1.4ms , Backend: 0.0ms , DB: 12.6ms , HTTP: 90.0ms) | XML: 0.5ms) [[32mINFO [0m|# 3835] Started GET "/assets/application.css" for 127.0.0.1 at 2012-12-19 22:19:21 +0100 [[32mINFO [0m|# 3835] Served asset /application.css - 304 Not Modified (1ms) [[32mINFO [0m|# 3835] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2012-12-19 22:19:22 +0100 [[32mINFO [0m|# 3835] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|# 3835] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 3835] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 3835] Authenticating with iChain mode: off [[32mINFO [0m|# 3835] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 3835] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 3835] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 3835] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 3835] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/person/tom {"view"=>0.654664, "db"=>1.4462279999999998, "backend"=>0, "xml"=>0, :runtime=>13.367, :all=>17.329285} [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.293054, "db"=>3.188975000000001, "backend"=>0, "xml"=>0, :runtime=>33.389, :all=>75.00668300000001} [[0;37mDEBUG[0m|# 3835] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 3835] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|# 3835] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|# 3835] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|# 3835] saving object Person ({:is_current=>"true", :login=>"tom"}) to api: <person> <login>tom</login> <email>tschmidt(a)suse.de</email> <realname>Thor</realname> <watchlist> </watchlist> </person> [[0;37mDEBUG[0m|# 3835] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/person/tom {"view"=>0.973641, "db"=>1.7602920000000002, "backend"=>0, "xml"=>0, :runtime=>20.93, :all=>27.400957000000002} [[0;37mDEBUG[0m|# 3835] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|# 3835] params {:login=>"tom"} [[0;37mDEBUG[0m|# 3835] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/person/tom/group {"view"=>0.637215, "db"=>0.778884, "backend"=>0, "xml"=>0, :runtime=>10.953, :all=>15.311797} [[0;37mDEBUG[0m|# 3835] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|# 3835] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|# 3835] Redirected to http://127.0.0.1:40435/project/show?project=My%3AMaintenance [[32mINFO [0m|# 3835] Completed 302 Found in 140ms (ActiveRecord: 0.0ms | API: 135.0ms (XML: 0.0ms , View: 2.6ms , Backend: 0.0ms , DB: 7.2ms , HTTP: 56.4ms) | XML: 0.4ms) [[32mINFO [0m|# 3835] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2012-12-19 22:19:22 +0100 [[32mINFO [0m|# 3835] Processing by ProjectController#show as HTML [[32mINFO [0m|# 3835] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 3835] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 3835] Authenticating with iChain mode: off [[32mINFO [0m|# 3835] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 3835] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 3835] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 3835] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 3835] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/person/tom {"view"=>0.527037, "db"=>0.8782979999999999, "backend"=>0, "xml"=>0, :runtime=>10.692, :all=>51.017874} [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.24241000000000001, "db"=>3.2635339999999995, "backend"=>0, "xml"=>0, :runtime=>33.183, :all=>75.250232} [[0;37mDEBUG[0m|# 3835] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 3835] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.435194, "db"=>3.2814300000000003, "backend"=>0, "xml"=>0, :runtime=>33.591, :all=>75.482276} [[0;37mDEBUG[0m|# 3835] 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|# 3835] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 3835] Rendered project/_tabs.html.erb (2.2ms) [[32mINFO [0m|# 3835] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|# 3835] Rendered layouts/_watch_and_search.html.erb (1.0ms) [[32mINFO [0m|# 3835] Rendered layouts/_header.html.erb (1.9ms) [[32mINFO [0m|# 3835] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|# 3835] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|# 3835] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|# 3835] Completed 200 OK in 220ms (Views: 12.8ms | ActiveRecord: 0.0ms | API: 201.8ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 7.4ms , HTTP: 124.3ms) | XML: 0.6ms) [[32mINFO [0m|# 3835] Started GET "/assets/application.css" for 127.0.0.1 at 2012-12-19 22:19:22 +0100 [[32mINFO [0m|# 3835] Served asset /application.css - 304 Not Modified (1ms) [[32mINFO [0m|# 3835] Started POST "/user/logout" for 127.0.0.1 at 2012-12-19 22:19:22 +0100 [[32mINFO [0m|# 3835] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|# 3835] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|# 3835] Authenticating with iChain mode: off [[32mINFO [0m|# 3835] Authenticated request to "/user/logout" from tom [[32mINFO [0m|# 3835] Logging out: tom [[32mINFO [0m|# 3835] Redirected to http://127.0.0.1:40435/ [[0;37mDEBUG[0m|# 3835] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|# 3835] Completed 302 Found in 40ms (ActiveRecord: 37.7ms | XML: 0.0ms) [[32mINFO [0m|# 3835] Started GET "/" for 127.0.0.1 at 2012-12-19 22:19:22 +0100 [[32mINFO [0m|# 3835] Processing by MainController#index as HTML [[0;37mDEBUG[0m|# 3835] Setting return_to: "/" [[0;37mDEBUG[0m|# 3835] Authenticating with iChain mode: off [[32mINFO [0m|# 3835] Anonymous request to / [[0;37mDEBUG[0m|# 3835] returning [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] from rails cache Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|# 3835] returning [{:limit=>"6", :shared=>"true"}] from rails cache LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[32mINFO [0m|# 3835] Rendered main/_news.html.erb (0.6ms) [[32mINFO [0m|# 3835] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|# 3835] Rendered main/_latest_updates.erb (5.2ms) [[32mINFO [0m|# 3835] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|# 3835] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|# 3835] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|# 3835] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|# 3835] Rendered layouts/_header.html.erb (1.2ms) [[32mINFO [0m|# 3835] Rendered layouts/_personal_navigation.html.erb (1.3ms) [[32mINFO [0m|# 3835] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 3835] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|# 3835] Completed 200 OK in 20ms (Views: 16.5ms | ActiveRecord: 0.0ms | XML: 0.8ms) [[32mINFO [0m|# 3835] Started GET "/assets/application.css" for 127.0.0.1 at 2012-12-19 22:19:23 +0100 [[32mINFO [0m|# 3835] Served asset /application.css - 304 Not Modified (1ms) [[32mINFO [0m|# 3835] Started GET "/main/systemstatus" for 127.0.0.1 at 2012-12-19 22:19:23 +0100 [[32mINFO [0m|# 3835] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|# 3835] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|# 3835] Authenticating with iChain mode: off [[32mINFO [0m|# 3835] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|# 3835] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|# 3835] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|# 3835] Rendered main/_systemstatus.html.erb (1.2ms) [[32mINFO [0m|# 3835] Completed 200 OK in 3ms (Views: 1.8ms | ActiveRecord: 0.0ms | XML: 0.4ms) [[0;37mDEBUG[0m|# 3835] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|# 3835] RT http://localhost:3203/test/test_end {"view"=>1.222234, "db"=>30.379555000000003, "backend"=>0, "xml"=>0, :runtime=>36.166, :all=>40.824225999999996} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. sh + 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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #733
by admin＠opensuse.org 13 Dec '12

13 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/733/changes> Changes: [Stephan Kulow] [webui] shrink the repository names even more [Stephan Kulow] [webui] fix issue #113 [Stephan Kulow] [webui] fix editing of repositories [Stephan Kulow] [api] fix interface to each_group [Stephan Kulow] [api] catch timeout errors from backend... [Stephan Kulow] [api] render all backend errors as timeout ------------------------------------------ [...truncated 576007 lines...] "pack1", null ], [ "pack2", null ], [ "pack3", null ] ], "xml": "<project name=\"BaseDistro\">\n <title>This is a base distro</title>\n <description>This could be openSUSE:11.2 project for example</description>\n <repository name=\"BaseDistro_repo\">\n <releasetarget project=\"BaseDistro:Update\" repository=\"BaseDistroUpdateProject_repo\"/>\n <arch>i586</arch>\n </repository>\n</project>\n", "maintenance_project": "My:Maintenance", "linking_projects": [ "BaseDistro:Update" ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#32359] [REST] find( Project, [{:name=>"BaseDistro"}] ) [[0;37mDEBUG[0m|#32359] params {:name=>"BaseDistro"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/source/:name/_meta?:view [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/source/BaseDistro/_meta? [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/source/BaseDistro/_meta? {"view"=>0.682324, "db"=>0.938712, "backend"=>0, "xml"=>0, :runtime=>11.169, :all=>52.004087} [[32mINFO [0m|#32359] Rendered project/_tabs.html.erb (3.9ms) [[32mINFO [0m|#32359] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|#32359] Rendered shared/_buildresult_box.html.erb (1.1ms) [[32mINFO [0m|#32359] Rendered layouts/_watch_and_search.html.erb (1.4ms) [[32mINFO [0m|#32359] Rendered layouts/_header.html.erb (2.6ms) [[32mINFO [0m|#32359] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#32359] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#32359] Rendered layouts/_sponsor.html.erb (0.1ms) [[32mINFO [0m|#32359] Completed 200 OK in 271ms (Views: 73.0ms | ActiveRecord: 0.0ms | API: 242.8ms (XML: 0.0ms , View: 2.3ms , Backend: 0.0ms , DB: 9.5ms , HTTP: 130.3ms) | XML: 0.8ms) [[32mINFO [0m|#32359] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2012-12-12 21:53:57 +0100 [[32mINFO [0m|#32359] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#32359] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#32359] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#32359] Authenticating with iChain mode: off [[32mINFO [0m|#32359] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#32359] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#32359] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#32359] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/person/tom {"view"=>0.6436080000000001, "db"=>0.911347, "backend"=>0, "xml"=>0, :runtime=>11.748, :all=>15.169108000000001} [[0;37mDEBUG[0m|#32359] [REST] find( Project, [{:name=>"BaseDistro"}] ) [[0;37mDEBUG[0m|#32359] params {:name=>"BaseDistro"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/source/:name/_meta?:view [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/source/BaseDistro/_meta? [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/source/BaseDistro/_meta? {"view"=>0.669385, "db"=>0.691659, "backend"=>0, "xml"=>0, :runtime=>11.468, :all=>54.17844899999999} [[0;37mDEBUG[0m|#32359] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#32359] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#32359] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>1.031657, "backend"=>0, "xml"=>0, :runtime=>37.348, :all=>82.751141} [[32mINFO [0m|#32359] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#32359] Completed 200 OK in 157ms (Views: 0.8ms | ActiveRecord: 0.0ms | API: 152.1ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 2.6ms , HTTP: 91.5ms) | XML: 0.4ms) [[32mINFO [0m|#32359] Started GET "/project/toggle_watch?project=BaseDistro" for 127.0.0.1 at 2012-12-12 21:53:57 +0100 [[32mINFO [0m|#32359] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#32359] Parameters: {"project"=>"BaseDistro"} [[0;37mDEBUG[0m|#32359] Setting return_to: "/project/toggle_watch?project=BaseDistro" [[0;37mDEBUG[0m|#32359] Authenticating with iChain mode: off [[32mINFO [0m|#32359] Authenticated request to "/project/toggle_watch?project=BaseDistro" from tom [[0;37mDEBUG[0m|#32359] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#32359] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#32359] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/person/tom {"view"=>0.585534, "db"=>0.9947999999999999, "backend"=>0, "xml"=>0, :runtime=>11.279000000000002, :all=>14.884253} [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.254446, "db"=>3.171811999999999, "backend"=>0, "xml"=>0, :runtime=>31.891999999999996, :all=>74.140925} [[0;37mDEBUG[0m|#32359] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#32359] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#32359] Add BaseDistro to watchlist for tom [[0;37mDEBUG[0m|#32359] user 'tom' is now watching project 'BaseDistro' [[0;37mDEBUG[0m|#32359] saving object Person ({:is_current=>"true", :login=>"tom"}) to api: <person> <login>tom</login> <email>tschmidt(a)suse.de</email> <realname>Thor</realname> <watchlist><project name="BaseDistro"/></watchlist> </person> [[0;37mDEBUG[0m|#32359] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/person/tom {"view"=>1.1178780000000001, "db"=>2.741252, "backend"=>0, "xml"=>0, :runtime=>94.794, :all=>99.893845} [[0;37mDEBUG[0m|#32359] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#32359] params {:login=>"tom"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/person/tom/group {"view"=>0.437249, "db"=>0.628565, "backend"=>0, "xml"=>0, :runtime=>7.562, :all=>12.447334} [[0;37mDEBUG[0m|#32359] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#32359] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#32359] Redirected to http://127.0.0.1:36709/project/show?project=BaseDistro [[32mINFO [0m|#32359] Completed 302 Found in 208ms (ActiveRecord: 0.0ms | API: 201.4ms (XML: 0.0ms , View: 2.4ms , Backend: 0.0ms , DB: 7.5ms , HTTP: 55.8ms) | XML: 0.5ms) [[32mINFO [0m|#32359] Started GET "/project/show?project=BaseDistro" for 127.0.0.1 at 2012-12-12 21:53:57 +0100 [[32mINFO [0m|#32359] Processing by ProjectController#show as HTML [[32mINFO [0m|#32359] Parameters: {"project"=>"BaseDistro"} [[0;37mDEBUG[0m|#32359] Setting return_to: "/project/show?project=BaseDistro" [[0;37mDEBUG[0m|#32359] Authenticating with iChain mode: off [[32mINFO [0m|#32359] Authenticated request to "/project/show?project=BaseDistro" from tom [[0;37mDEBUG[0m|#32359] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#32359] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#32359] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/person/tom {"view"=>0.644919, "db"=>1.428783, "backend"=>0, "xml"=>0, :runtime=>15.309, :all=>57.012453} [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.370124, "db"=>3.180527, "backend"=>0, "xml"=>0, :runtime=>31.718000000000004, :all=>74.887451} [[0;37mDEBUG[0m|#32359] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=BaseDistro [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/webui/project_infos?project=BaseDistro {"view"=>0.5047889999999999, "db"=>2.1798840000000004, "backend"=>0, "xml"=>0, :runtime=>35.325, :all=>76.434325} [[0;37mDEBUG[0m|#32359] data { "name": "BaseDistro", "packages": [ [ "pack1", null ], [ "pack2", null ], [ "pack3", null ] ], "xml": "<project name=\"BaseDistro\">\n <title>This is a base distro</title>\n <description>This could be openSUSE:11.2 project for example</description>\n <repository name=\"BaseDistro_repo\">\n <releasetarget project=\"BaseDistro:Update\" repository=\"BaseDistroUpdateProject_repo\"/>\n <arch>i586</arch>\n </repository>\n</project>\n", "maintenance_project": "My:Maintenance", "linking_projects": [ "BaseDistro:Update" ], "requests": [ ], "nr_of_problem_packages": 0 } [[32mINFO [0m|#32359] Rendered project/_tabs.html.erb (3.1ms) [[32mINFO [0m|#32359] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#32359] Rendered shared/_buildresult_box.html.erb (0.6ms) [[32mINFO [0m|#32359] Rendered layouts/_watch_and_search.html.erb (1.3ms) [[32mINFO [0m|#32359] Rendered layouts/_header.html.erb (2.1ms) [[32mINFO [0m|#32359] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#32359] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#32359] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32359] Completed 200 OK in 230ms (Views: 15.8ms | ActiveRecord: 0.0ms | API: 208.3ms (XML: 0.0ms , View: 1.5ms , Backend: 0.0ms , DB: 6.8ms , HTTP: 126.0ms) | XML: 0.6ms) [[32mINFO [0m|#32359] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2012-12-12 21:53:58 +0100 [[32mINFO [0m|#32359] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#32359] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#32359] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#32359] Authenticating with iChain mode: off [[32mINFO [0m|#32359] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#32359] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#32359] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#32359] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/person/tom {"view"=>0.593373, "db"=>1.40069, "backend"=>0, "xml"=>0, :runtime=>14.840000000000002, :all=>19.501182999999997} [[0;37mDEBUG[0m|#32359] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#32359] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#32359] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#32359] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#32359] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|#32359] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.7399089999999999, "backend"=>0, "xml"=>0, :runtime=>30.969, :all=>72.389627} [[32mINFO [0m|#32359] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#32359] Completed 200 OK in 96ms (Views: 0.8ms | ActiveRecord: 0.0ms | API: 91.9ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 2.1ms , HTTP: 46.1ms) | XML: 0.3ms) [[32mINFO [0m|#32359] Started POST "/user/logout" for 127.0.0.1 at 2012-12-12 21:53:58 +0100 [[32mINFO [0m|#32359] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#32359] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#32359] Authenticating with iChain mode: off [[32mINFO [0m|#32359] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#32359] Logging out: tom [[32mINFO [0m|#32359] Redirected to http://127.0.0.1:36709/ [[0;37mDEBUG[0m|#32359] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#32359] Completed 302 Found in 28ms (ActiveRecord: 25.7ms | XML: 0.0ms) [[32mINFO [0m|#32359] Started GET "/" for 127.0.0.1 at 2012-12-12 21:53:58 +0100 [[32mINFO [0m|#32359] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#32359] Setting return_to: "/" [[0;37mDEBUG[0m|#32359] Authenticating with iChain mode: off [[32mINFO [0m|#32359] Anonymous request to / [[0;37mDEBUG[0m|#32359] returning [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] from rails cache Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#32359] returning [{:limit=>"6", :shared=>"true"}] from rails cache LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[32mINFO [0m|#32359] Rendered main/_news.html.erb (0.7ms) [[32mINFO [0m|#32359] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|#32359] Rendered main/_latest_updates.erb (5.7ms) [[32mINFO [0m|#32359] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|#32359] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#32359] Rendered main/_feeds.html.erb (0.1ms) [[32mINFO [0m|#32359] Rendered layouts/_watch_and_search.html.erb (0.6ms) [[32mINFO [0m|#32359] Rendered layouts/_header.html.erb (1.2ms) [[32mINFO [0m|#32359] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#32359] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#32359] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32359] Completed 200 OK in 21ms (Views: 17.6ms | ActiveRecord: 0.0ms | XML: 0.8ms) [[32mINFO [0m|#32359] Started GET "/main/systemstatus" for 127.0.0.1 at 2012-12-12 21:53:58 +0100 [[32mINFO [0m|#32359] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#32359] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#32359] Authenticating with iChain mode: off [[32mINFO [0m|#32359] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#32359] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#32359] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#32359] Rendered main/_systemstatus.html.erb (1.6ms) [[32mINFO [0m|#32359] Completed 200 OK in 4ms (Views: 2.3ms | ActiveRecord: 0.0ms | XML: 0.4ms) [[0;37mDEBUG[0m|#32359] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#32359] RT http://localhost:3203/test/test_end {"view"=>1.105156, "db"=>20.711003, "backend"=>0, "xml"=>0, :runtime=>26.624, :all=>31.37873} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>: jenkins ..c.. egrep jenkins ..c.. sh jenkins ..c.. sh + 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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 2

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui-testsuite #534
by admin＠opensuse.org 12 Dec '12

12 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/534/changes> Changes: [Stephan Kulow] [webui] fix spider test [Stephan Kulow] [webui] remove the home project link on requests page [Stephan Kulow] [webui] avoid double render error [Stephan Kulow] [webui] move test of adding package source to capybara [Stephan Kulow] [webui] trying to fix some test failures on jenkins [Stephan Kulow] [webui] move package creation test to capybara [Stephan Kulow] [webui] move project editing tests to capybara [Stephan Kulow] [api] small test case extension to verify reviews [Stephan Kulow] [api] allow to update the review comment [Stephan Kulow] [webui] fix one assertion - ruby is tricky :) [Stephan Kulow] [webui] move create project test to capybara [Stephan Kulow] [webui] the selenium test suite is now fully merged [Stephan Kulow] [webui] avoid "a race" [Stephan Kulow] [api] rework exception handling [Stephan Kulow] [webui] readd the booster's link [Stephan Kulow] [api] responding with a 400 for invalid packages is harsh [Stephan Kulow] [api] remove (broken) /public route [Stephan Kulow] [webui] catch 404 for routes - as we rescue MissingParameters [Stephan Kulow] [dist] do not count coverage if the tests fail [Stephan Kulow] Revert "[api] remove (broken) /public route" [Stephan Kulow] [webui] shrink the repository names even more ------------------------------------------ Started by upstream project "obs_master_testsuite_webui" build number 732 originally caused by: Started by upstream project "obs_master_testsuite_api" build number 1269 originally caused by: Started by upstream project "obs_master_check_deps" build number 41 originally caused by: Started by an SCM change Building in workspace <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/ws/> Checkout:workspace / <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/ws/> - hudson.remoting.LocalChannel@6ed56ed5 Using strategy: Default Last Built Revision: Revision f2b69c0928c8c3bf69f6e4ddd5c89e29bcd3f91f (origin/master) Fetching changes from 1 remote Git repository Fetching upstream changes from git://github.com/openSUSE/open-build-service.git Commencing build of Revision 9c011e89453c528aa2c41caadfcaf060e0b22ce9 (origin/master) Checking out Revision 9c011e89453c528aa2c41caadfcaf060e0b22ce9 (origin/master) Cleaning workspace Resetting working tree [locks-and-latches] Checking to see if we really have the locks [locks-and-latches] Have all the locks, build can start [workspace] $ /bin/sh -xe /tmp/hudson1279147547912819844.sh + sh dist/ci/obs_testsuite_webui-testsuite.sh sh: dist/ci/obs_testsuite_webui-testsuite.sh: No such file or directory 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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 0

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #723
by admin＠opensuse.org 12 Dec '12

12 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/723/changes> Changes: [Stephan Kulow] [webui] fix spider test [Stephan Kulow] [webui] remove the home project link on requests page [Stephan Kulow] [webui] avoid double render error ------------------------------------------ [...truncated 497164 lines...] ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#25292] returning [{:project=>"BaseDistro", :name=>"patchinfo"}] from rails cache Package_dd68b8920adb7d45b74d149ac7ad9a57 [[0;37mDEBUG[0m|#25292] [REST] find( Directory, [{:project=>"BaseDistro", :package=>"patchinfo"}] ) [[0;37mDEBUG[0m|#25292] params {:project=>"BaseDistro", :package=>"patchinfo"} [[0;37mDEBUG[0m|#25292] uri is: http://localhost:3203/source/:project/:package?:expand&:rev [[0;37mDEBUG[0m|#25292] http_do #1: method: get url: http://localhost:3203/source/BaseDistro/patchinfo? [[0;37mDEBUG[0m|#25292] RT http://localhost:3203/source/BaseDistro/patchinfo? {"view"=>nil, "db"=>1.371761, "backend"=>0, "xml"=>0, :runtime=>26.674, :all=>67.556094} [[32mINFO [0m|#25292] Rendered project/_tabs.html.erb (4.0ms) [[32mINFO [0m|#25292] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#25292] Rendered shared/_buildresult_box.html.erb (0.7ms) [[32mINFO [0m|#25292] Rendered layouts/_watch_and_search.html.erb (1.2ms) [[32mINFO [0m|#25292] Rendered layouts/_header.html.erb (2.0ms) [[32mINFO [0m|#25292] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#25292] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#25292] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#25292] Completed 200 OK in 389ms (Views: 17.1ms | ActiveRecord: 0.0ms | API: 365.8ms (XML: 0.0ms , View: 1.6ms , Backend: 0.0ms , DB: 8.8ms , HTTP: 161.6ms) | XML: 0.8ms) [[32mINFO [0m|#25292] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2012-12-07 17:35:42 +0100 [[32mINFO [0m|#25292] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#25292] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#25292] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#25292] Authenticating with iChain mode: off [[32mINFO [0m|#25292] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#25292] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#25292] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#25292] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#25292] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#25292] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#25292] RT http://localhost:3203/person/tom {"view"=>0.5789610000000001, "db"=>1.242863, "backend"=>0, "xml"=>0, :runtime=>14.594, :all=>18.106635999999998} [[0;37mDEBUG[0m|#25292] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#25292] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#25292] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#25292] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#25292] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|#25292] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#25292] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.661139, "backend"=>0, "xml"=>0, :runtime=>25.75, :all=>66.941787} [[32mINFO [0m|#25292] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#25292] Completed 200 OK in 89ms (Views: 0.8ms | ActiveRecord: 0.0ms | API: 85.0ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 1.9ms , HTTP: 44.7ms) | XML: 0.2ms) [[32mINFO [0m|#25292] Started GET "/project/list_public" for 127.0.0.1 at 2012-12-07 17:35:42 +0100 [[32mINFO [0m|#25292] Processing by ProjectController#list_public as HTML [[0;37mDEBUG[0m|#25292] Setting return_to: "/project/list_public" [[0;37mDEBUG[0m|#25292] Authenticating with iChain mode: off [[32mINFO [0m|#25292] Authenticated request to "/project/list_public" from tom [[0;37mDEBUG[0m|#25292] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#25292] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#25292] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#25292] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#25292] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#25292] RT http://localhost:3203/person/tom {"view"=>0.580776, "db"=>1.7106629999999998, "backend"=>0, "xml"=>0, :runtime=>14.815, :all=>18.207256} [[0;37mDEBUG[0m|#25292] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#25292] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.267148, "db"=>3.156691, "backend"=>0, "xml"=>0, :runtime=>31.184, :all=>73.24306299999999} [[0;37mDEBUG[0m|#25292] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#25292] http_do #1: method: get url: http://localhost:3203/webui/all_projects [[0;37mDEBUG[0m|#25292] RT http://localhost:3203/webui/all_projects {"view"=>2.235179, "db"=>1.2365970000000002, "backend"=>0, "xml"=>0, :runtime=>13.03, :all=>55.380575} [[0;37mDEBUG[0m|#25292] data { "Apache": { "title": "Up-to-date Apache packages", "important": false }, "BaseDistro": { "title": "This is a base distro", "important": true }, "BaseDistro2.0": { "title": "This is another base distro", "important": false }, "BaseDistro2.0:LinkedUpdateProject": { "title": "This is another update project for the base distro", "important": false }, "BaseDistro3": { "title": "This is another base distro, without update project", "important": false }, "BaseDistro:Update": { "title": "This is an update project for the base distro", "important": false }, "BinaryprotectedProject": { "title": "This project has unaccessable binaries except for adrian", "important": false }, "CopyTest": { "title": "This project serves as copy target/source", "important": false }, "Devel:BaseDistro:Update": { "title": "This is a a devel project container for update project for the base distro", "important": false }, "LocalProject": { "title": "This project is a local project", "important": false }, "My:Maintenance": { "title": "official maintenance space", "important": false }, "My:Maintenance:0": { "title": null, "important": false }, "RemoteInstance": { "title": "This project is offering ourself content again via OBS inter-connect", "important": false }, "SourceprotectedProject": { "title": "This project has unaccessable source except for adrian", "important": false }, "UseRemoteInstance": { "title": "This project is project linking to remote instance", "important": false }, "c++": { "title": null, "important": false }, "home:Iggy": { "title": "Iggy Home Project", "important": false }, "home:Iggy:branches:kde4": { "title": "Iggy Home Project", "important": false }, "home:adrian": { "title": "adrian's Home Project", "important": false }, "home:adrian:BaseDistro": { "title": "This is a project source linked project to BaseDistro", "important": false }, "home:adrian:ProtectionTest": { "title": "This is used to try to get source rpm binaries from SourceprotectedProject", "important": false }, "home:coolo": { "title": "", "important": false }, "home:coolo:test": { "title": "only a test", "important": false }, "home:dmayr": { "title": "my home project", "important": false }, "home:fred": { "title": "can be used for operations, to be cleaned up afterwards", "important": false }, "home:fred:DeleteProject": { "title": "This project gets deleted by request test", "important": false }, "home:tom": { "title": "�� ", "important": false }, "kde": { "title": "blub", "important": false }, "kde4": { "title": "blub", "important": false } } [[32mINFO [0m|#25292] Rendered layouts/_watch_and_search.html.erb (1.0ms) [[32mINFO [0m|#25292] Rendered layouts/_header.html.erb (1.8ms) [[32mINFO [0m|#25292] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|#25292] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#25292] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#25292] Completed 200 OK in 161ms (Views: 9.7ms | ActiveRecord: 0.0ms | API: 146.8ms (XML: 0.0ms , View: 3.1ms , Backend: 0.0ms , DB: 6.1ms , HTTP: 87.8ms) | XML: 0.1ms) [[32mINFO [0m|#25292] Started POST "/user/logout" for 127.0.0.1 at 2012-12-07 17:35:53 +0100 [[32mINFO [0m|#25292] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#25292] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#25292] Authenticating with iChain mode: off [[32mINFO [0m|#25292] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#25292] Logging out: tom [[32mINFO [0m|#25292] Redirected to http://127.0.0.1:35720/ [[0;37mDEBUG[0m|#25292] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#25292] Completed 302 Found in 31ms (ActiveRecord: 28.5ms | XML: 0.0ms) [[32mINFO [0m|#25292] Started GET "/" for 127.0.0.1 at 2012-12-07 17:35:53 +0100 [[32mINFO [0m|#25292] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#25292] Setting return_to: "/" [[0;37mDEBUG[0m|#25292] Authenticating with iChain mode: off [[32mINFO [0m|#25292] Anonymous request to / [[0;37mDEBUG[0m|#25292] returning [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] from rails cache Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#25292] returning [{:limit=>"6", :shared=>"true"}] from rails cache LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[32mINFO [0m|#25292] Rendered main/_news.html.erb (0.6ms) [[32mINFO [0m|#25292] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|#25292] Rendered main/_latest_updates.erb (4.8ms) [[32mINFO [0m|#25292] Rendered main/_countdown.html.erb (0.1ms) [[32mINFO [0m|#25292] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#25292] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|#25292] Rendered layouts/_watch_and_search.html.erb (0.6ms) [[32mINFO [0m|#25292] Rendered layouts/_header.html.erb (1.3ms) [[32mINFO [0m|#25292] Rendered layouts/_personal_navigation.html.erb (1.3ms) [[32mINFO [0m|#25292] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#25292] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#25292] Completed 200 OK in 19ms (Views: 15.9ms | ActiveRecord: 0.0ms | XML: 0.1ms) [[32mINFO [0m|#25292] Started GET "/main/systemstatus" for 127.0.0.1 at 2012-12-07 17:35:53 +0100 [[32mINFO [0m|#25292] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#25292] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#25292] Authenticating with iChain mode: off [[32mINFO [0m|#25292] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#25292] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#25292] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#25292] Rendered main/_systemstatus.html.erb (1.4ms) [[32mINFO [0m|#25292] Completed 200 OK in 4ms (Views: 2.0ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|#25292] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#25292] RT http://localhost:3203/test/test_end {"view"=>1.338573, "db"=>31.346551, "backend"=>0, "xml"=>0, :runtime=>37.837999999999994, :all=>43.415471999999994} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>: jenkins ..c.. egrep jenkins ..c.. sh jenkins ..c.. sh + 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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 9

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1267
by admin＠opensuse.org 12 Dec '12

12 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_api/1267/changes> Changes: [Stephan Kulow] [api] remove (broken) /public route ------------------------------------------ [...truncated 130684 lines...] [[0;37mDEBUG[0m|#15532] 2012-12-12 13:07:45 [21712]: PUT /source/kde4/_meta?user=king [[0;37mDEBUG[0m|#15527] request took 0.011889637 [[0;37mDEBUG[0m|#15527] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x00000007df26c0> took 1ms [[32mINFO [0m|#15527] Completed 200 OK in 185ms (Views: 1.2ms | ActiveRecord: 5.9ms | Backend: 11.9ms | XML: 0.0ms) [[32mINFO [0m|#15527] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-12-12 13:07:45 +0100 [[32mINFO [0m|#15527] Processing by SourceController#project_meta as XML [[32mINFO [0m|#15527] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#15527] Validate XML request: #<ActionDispatch::Request:0x00000006703d60> [[0;37mDEBUG[0m|#15527] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15527] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#15527] USER found: king [[0;37mDEBUG[0m|#15527] User king initialised [[0;37mDEBUG[0m|#15527] [1m[35mProjectUserRoleRelationship Load (0.2ms)[0m SELECT ur.db_project_id, ur.bs_user_id from flags f, project_user_role_relationships ur where f.flag = 'access' and ur.db_project_id = f.db_project_id [[0;37mDEBUG[0m|#15527] [1m[36mRole Load (0.3ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x00000006703d10> took 3ms [[32mINFO [0m|#15527] Completed 200 OK in 10ms (Views: 0.5ms | ActiveRecord: 1.0ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#15527] Started GET "/source/kde4" for 127.0.0.1 at 2012-12-12 13:07:45 +0100 [[32mINFO [0m|#15527] Processing by SourceController#index_project as XML [[32mINFO [0m|#15527] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#15527] Validate XML request: #<ActionDispatch::Request:0x00000006d36b88> [[0;37mDEBUG[0m|#15527] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15527] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#15527] USER found: king [[0;37mDEBUG[0m|#15527] User king initialised [[0;37mDEBUG[0m|#15527] [1m[35mRole Load (0.3ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND (packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#15527] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x00000006d36a98> took 0ms [[32mINFO [0m|#15527] Completed 200 OK in 9ms (Views: 0.4ms | ActiveRecord: 1.1ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#15527] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-12 13:07:45 +0100 [[32mINFO [0m|#15527] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15527] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#15527] Validate XML request: #<ActionDispatch::Request:0x00000006e32f00> [[0;37mDEBUG[0m|#15527] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15527] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#15527] USER found: king [[0;37mDEBUG[0m|#15527] User king initialised [[0;37mDEBUG[0m|#15527] get_by_project_and_name {} [[0;37mDEBUG[0m|#15527] [1m[35mRole Load (0.3ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.1ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15527] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#15527] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#15527] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#15527] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x00000006e32b68> took 2ms [[32mINFO [0m|#15527] Completed 200 OK in 18ms (Views: 0.4ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#15527] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-12 13:07:45 +0100 [[32mINFO [0m|#15527] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15527] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#15527] Validate XML request: #<ActionDispatch::Request:0x0000000704af68> [[0;37mDEBUG[0m|#15527] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#15527] USER found: king [[0;37mDEBUG[0m|#15527] User king initialised [[0;37mDEBUG[0m|#15527] [1m[35mRole Load (0.2ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.1ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] get_by_project_and_name {} [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#15527] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#15527] [1m[35mFlag Load (0.1ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#15527] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#15527] xml_disabled? X({"name"=>"kdebase", "project"=>"kde4", "title"=>"blub", "description"=>"blub"}) [[0;37mDEBUG[0m|#15527] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackageUserRoleRelationship Load (0.1ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#15527] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15527] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#15527] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15527] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15532] 2012-12-12 13:07:45 [21713]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15527] request took 0.009716126 [[0;37mDEBUG[0m|#15527] [1m[36mPackage Load (0.3ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#15527] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#15527] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15527] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15532] 2012-12-12 13:07:45 [21714]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15527] request took 0.012263747 [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m [[0;37mDEBUG[0m|#15527] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#15527] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15527] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15532] 2012-12-12 13:07:45 [21715]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15527] request took 0.025198354 [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36m (0.6ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x0000000704af18> took 1ms [[32mINFO [0m|#15527] Completed 200 OK in 90ms (Views: 0.6ms | ActiveRecord: 3.3ms | Backend: 47.2ms | XML: 0.0ms) [[32mINFO [0m|#15527] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-12 13:07:45 +0100 [[32mINFO [0m|#15527] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15527] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#15527] Validate XML request: #<ActionDispatch::Request:0x000000074a71d8> [[0;37mDEBUG[0m|#15527] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15527] [1m[35mUser Load (5.6ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#15527] USER found: king [[0;37mDEBUG[0m|#15527] User king initialised [[0;37mDEBUG[0m|#15527] get_by_project_and_name {} [[0;37mDEBUG[0m|#15527] [1m[36mRole Load (0.4ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mProject Load (0.3ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mPackage Load (0.4ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mProject Load (0.3ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x000000074a71b0> took 3ms [[32mINFO [0m|#15527] Completed 200 OK in 24ms (Views: 0.7ms | ActiveRecord: 7.0ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#15527] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-12 13:07:45 +0100 [[32mINFO [0m|#15527] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15527] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#15527] Validate XML request: #<ActionDispatch::Request:0x0000000732a8f0> [[0;37mDEBUG[0m|#15527] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15527] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#15527] USER found: king [[0;37mDEBUG[0m|#15527] User king initialised [[0;37mDEBUG[0m|#15527] get_by_project_and_name {} [[0;37mDEBUG[0m|#15527] [1m[35mRole Load (0.3ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15527] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`id` = 1234 AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.1ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 601 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#15527] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#15527] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x0000000732a8c8> took 2ms [[32mINFO [0m|#15527] Completed 200 OK in 22ms (Views: 0.4ms | ActiveRecord: 2.1ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#15527] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-12 13:07:45 +0100 [[32mINFO [0m|#15527] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15527] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n <devel project=\"home:coolo:test\" package=\"kdelibs_DEVEL_package\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#15527] Validate XML request: #<ActionDispatch::Request:0x000000078776f0> [[0;37mDEBUG[0m|#15527] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#15527] USER found: king [[0;37mDEBUG[0m|#15527] User king initialised [[0;37mDEBUG[0m|#15527] [1m[35mRole Load (0.2ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mProject Load (0.1ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] get_by_project_and_name {} [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#15527] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#15527] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#15527] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#15527] xml_disabled? X({"name"=>"kdelibs", "project"=>"kde4", "title"=>"blub", "description"=>"blub", "devel"=>X({"project"=>"home:coolo:test", "package"=>"kdelibs_DEVEL_package"}), "person"=>[X({"userid"=>"fredlibs", "role"=>"maintainer"}), X({"userid"=>"adrian", "role"=>"reviewer"})], "group"=>X({"groupid"=>"test_group", "role"=>"maintainer"})}) [[0;37mDEBUG[0m|#15527] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15527] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'home:coolo:test' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 601 AND `packages`.`name` = 'kdelibs_DEVEL_package' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mProject Load (0.1ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 601 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mPackageUserRoleRelationship Load (0.1ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mRole Load (0.1ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mUser Load (0.1ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mRole Load (0.1ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|#15527] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15527] [1m[35mPackageUserRoleRelationship Load (0.3ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#15527] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#15527] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15527] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15532] 2012-12-12 13:07:45 [21716]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15527] request took 0.010036888 [[0;37mDEBUG[0m|#15527] [1m[35mPackage Load (0.4ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'fredlibs' LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mUser Load (0.1ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'adrian' LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mGroup Load (0.1ms)[0m SELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mGroup Load (0.2ms)[0m SELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1 [[0;37mDEBUG[0m|#15527] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#15527] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15527] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15532] 2012-12-12 13:07:45 [21717]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15527] request took 0.017974494 [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m [[0;37mDEBUG[0m|#15527] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#15527] [1m[36mCACHE (0.0ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#15527] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15527] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15532] 2012-12-12 13:07:45 [21718]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15527] request took 0.016547355 [[0;37mDEBUG[0m|#15527] [1m[35mCACHE (0.0ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x000000078776c8> took 1ms [[32mINFO [0m|#15527] Completed 200 OK in 104ms (Views: 0.9ms | ActiveRecord: 4.7ms | Backend: 44.6ms | XML: 0.0ms) [[32mINFO [0m|#15527] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-12 13:07:45 +0100 [[32mINFO [0m|#15527] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15527] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#15527] Validate XML request: #<ActionDispatch::Request:0x00000007ab3e28> [[0;37mDEBUG[0m|#15527] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15527] [1m[35mUser Load (7.8ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#15527] USER found: king [[0;37mDEBUG[0m|#15527] User king initialised [[0;37mDEBUG[0m|#15527] get_by_project_and_name {} [[0;37mDEBUG[0m|#15527] [1m[36mRole Load (0.4ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] [1m[36mPackage Load (0.3ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15527] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15527] Validate XML response: #<ActionDispatch::Response:0x00000007ab3e00> took 2ms [[32mINFO [0m|#15527] Completed 200 OK in 23ms (Views: 0.5ms | ActiveRecord: 8.9ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#15527] [1m[36m (5.1ms)[0m [1mROLLBACK[0m [[0;37mDEBUG[0m|#15527] kill 15532 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/cache src/api/tmp/pids src/api/tmp/sessions src/api/tmp/sockets 'src/webui/log/*' src/webui/tmp/cache src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 2

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1253
by admin＠opensuse.org 07 Dec '12

07 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_api/1253/changes> Changes: [Stephan Kulow] [webui] add a 403 "template" [mls] [backend] now that the API has compatibility code in the public controller, we can switch to the correct getpackagelist function ------------------------------------------ [...truncated 130218 lines...] [[0;37mDEBUG[0m|#17923] 2012-12-06 16:41:47 [23942]: PUT /source/kde4/_meta?user=king [[0;37mDEBUG[0m|#17918] request took 0.013730283 [[0;37mDEBUG[0m|#17918] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x00000006e70a80> took 0ms [[32mINFO [0m|#17918] Completed 200 OK in 61ms (Views: 0.9ms | ActiveRecord: 5.7ms | Backend: 13.7ms | XML: 0.0ms) [[32mINFO [0m|#17918] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-12-06 16:41:47 +0100 [[32mINFO [0m|#17918] Processing by SourceController#project_meta as XML [[32mINFO [0m|#17918] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#17918] Validate XML request: #<ActionDispatch::Request:0x00000007444358> [[0;37mDEBUG[0m|#17918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17918] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#17918] USER found: king [[0;37mDEBUG[0m|#17918] User king initialised [[0;37mDEBUG[0m|#17918] [1m[36mProjectUserRoleRelationship Load (0.4ms)[0m [1mSELECT ur.db_project_id, ur.bs_user_id from flags f, project_user_role_relationships ur where f.flag = 'access' and ur.db_project_id = f.db_project_id[0m [[0;37mDEBUG[0m|#17918] [1m[35mRole Load (0.2ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x00000007444308> took 2ms [[32mINFO [0m|#17918] Completed 200 OK in 10ms (Views: 0.4ms | ActiveRecord: 1.1ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#17918] Started GET "/source/kde4" for 127.0.0.1 at 2012-12-06 16:41:47 +0100 [[32mINFO [0m|#17918] Processing by SourceController#index_project as XML [[32mINFO [0m|#17918] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#17918] Validate XML request: #<ActionDispatch::Request:0x000000074f3808> [[0;37mDEBUG[0m|#17918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17918] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#17918] USER found: king [[0;37mDEBUG[0m|#17918] User king initialised [[0;37mDEBUG[0m|#17918] [1m[36mRole Load (0.3ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mPackage Load (0.3ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#17918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x000000074f37e0> took 0ms [[32mINFO [0m|#17918] Completed 200 OK in 8ms (Views: 0.4ms | ActiveRecord: 1.0ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#17918] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-06 16:41:47 +0100 [[32mINFO [0m|#17918] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17918] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#17918] Validate XML request: #<ActionDispatch::Request:0x0000000750cce0> [[0;37mDEBUG[0m|#17918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17918] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#17918] USER found: king [[0;37mDEBUG[0m|#17918] User king initialised [[0;37mDEBUG[0m|#17918] get_by_project_and_name {} [[0;37mDEBUG[0m|#17918] [1m[36mRole Load (0.2ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.1ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17918] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#17918] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#17918] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#17918] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x0000000750cc90> took 2ms [[32mINFO [0m|#17918] Completed 200 OK in 16ms (Views: 0.4ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#17918] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-06 16:41:47 +0100 [[32mINFO [0m|#17918] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17918] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#17918] Validate XML request: #<ActionDispatch::Request:0x000000078a2c88> [[0;37mDEBUG[0m|#17918] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#17918] USER found: king [[0;37mDEBUG[0m|#17918] User king initialised [[0;37mDEBUG[0m|#17918] [1m[36mRole Load (0.3ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] get_by_project_and_name {} [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mFlag Load (0.4ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#17918] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#17918] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#17918] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#17918] xml_disabled? X({"name"=>"kdebase", "project"=>"kde4", "title"=>"blub", "description"=>"blub"}) [[0;37mDEBUG[0m|#17918] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#17918] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#17918] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17918] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#17918] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#17918] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17918] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#17923] 2012-12-06 16:41:47 [23943]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#17918] request took 0.009044156 [[0;37mDEBUG[0m|#17918] [1m[35mPackage Load (0.4ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#17918] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#17918] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17918] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#17923] 2012-12-06 16:41:47 [23944]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#17918] request took 0.008851374 [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1 [[0;37mDEBUG[0m|#17918] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#17918] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17918] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#17923] 2012-12-06 16:41:47 [23945]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#17918] request took 0.02685191 [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x000000078a2c60> took 0ms [[32mINFO [0m|#17918] Completed 200 OK in 92ms (Views: 0.8ms | ActiveRecord: 3.3ms | Backend: 44.7ms | XML: 0.0ms) [[32mINFO [0m|#17918] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-06 16:41:47 +0100 [[32mINFO [0m|#17918] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17918] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#17918] Validate XML request: #<ActionDispatch::Request:0x00000007d64640> [[0;37mDEBUG[0m|#17918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17918] [1m[36mUser Load (8.8ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#17918] USER found: king [[0;37mDEBUG[0m|#17918] User king initialised [[0;37mDEBUG[0m|#17918] get_by_project_and_name {} [[0;37mDEBUG[0m|#17918] [1m[35mRole Load (0.3ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x00000007d64618> took 147ms [[32mINFO [0m|#17918] Completed 200 OK in 167ms (Views: 0.4ms | ActiveRecord: 9.7ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#17918] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-06 16:41:47 +0100 [[32mINFO [0m|#17918] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17918] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#17918] Validate XML request: #<ActionDispatch::Request:0x000000079290d0> [[0;37mDEBUG[0m|#17918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17918] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#17918] USER found: king [[0;37mDEBUG[0m|#17918] User king initialised [[0;37mDEBUG[0m|#17918] get_by_project_and_name {} [[0;37mDEBUG[0m|#17918] [1m[36mRole Load (0.2ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17918] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`id` = 1234 AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 601 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mPackageGroupRoleRelationship Load (0.4ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#17918] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#17918] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x000000079290f8> took 2ms [[32mINFO [0m|#17918] Completed 200 OK in 22ms (Views: 0.3ms | ActiveRecord: 2.2ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#17918] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-06 16:41:47 +0100 [[32mINFO [0m|#17918] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17918] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n <devel project=\"home:coolo:test\" package=\"kdelibs_DEVEL_package\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#17918] Validate XML request: #<ActionDispatch::Request:0x00000005d968e0> [[0;37mDEBUG[0m|#17918] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#17918] USER found: king [[0;37mDEBUG[0m|#17918] User king initialised [[0;37mDEBUG[0m|#17918] [1m[36mRole Load (0.3ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] get_by_project_and_name {} [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mFlag Load (0.3ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#17918] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#17918] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#17918] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#17918] xml_disabled? X({"name"=>"kdelibs", "project"=>"kde4", "title"=>"blub", "description"=>"blub", "devel"=>X({"project"=>"home:coolo:test", "package"=>"kdelibs_DEVEL_package"}), "person"=>[X({"userid"=>"fredlibs", "role"=>"maintainer"}), X({"userid"=>"adrian", "role"=>"reviewer"})], "group"=>X({"groupid"=>"test_group", "role"=>"maintainer"})}) [[0;37mDEBUG[0m|#17918] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#17918] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'home:coolo:test' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 601 AND `packages`.`name` = 'kdelibs_DEVEL_package' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 601 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mPackageUserRoleRelationship Load (0.3ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#17918] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mRole Load (0.1ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mUser Load (0.1ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mRole Load (0.1ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1 [[0;37mDEBUG[0m|#17918] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17918] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#17918] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17918] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#17923] 2012-12-06 16:41:47 [23946]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#17918] request took 0.013209923 [[0;37mDEBUG[0m|#17918] [1m[36mPackage Load (0.3ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'fredlibs' LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'adrian' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#17918] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#17918] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#17918] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17918] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#17923] 2012-12-06 16:41:47 [23947]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#17918] request took 0.008771728 [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#17918] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mCACHE (0.0ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#17918] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17918] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#17923] 2012-12-06 16:41:47 [23948]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#17918] request took 0.012431601 [[0;37mDEBUG[0m|#17918] [1m[36mCACHE (0.0ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x00000005d96840> took 1ms [[32mINFO [0m|#17918] Completed 200 OK in 96ms (Views: 0.8ms | ActiveRecord: 4.9ms | Backend: 34.4ms | XML: 0.0ms) [[32mINFO [0m|#17918] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-06 16:41:47 +0100 [[32mINFO [0m|#17918] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17918] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#17918] Validate XML request: #<ActionDispatch::Request:0x00000006d6caa8> [[0;37mDEBUG[0m|#17918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17918] [1m[36mUser Load (12.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#17918] USER found: king [[0;37mDEBUG[0m|#17918] User king initialised [[0;37mDEBUG[0m|#17918] get_by_project_and_name {} [[0;37mDEBUG[0m|#17918] [1m[35mRole Load (0.3ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17918] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17918] Validate XML response: #<ActionDispatch::Response:0x00000006d6c9e0> took 2ms [[32mINFO [0m|#17918] Completed 200 OK in 25ms (Views: 0.4ms | ActiveRecord: 13.2ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#17918] [1m[35m (10.5ms)[0m ROLLBACK [[0;37mDEBUG[0m|#17918] kill 17923 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/scheduler.done src/api/tmp/sessions src/api/tmp/sockets 'src/webui/log/*' src/webui/tmp/cache src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 3

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1244
by admin＠opensuse.org 05 Dec '12

05 Dec '12

See <http://ci.opensuse.org/job/obs_master_testsuite_api/1244/changes> Changes: [adrian] [api] add aarch64 to xml schema file [adrian] [api] cleanup multiple respositories in one project only for local repos. We can not have a uniq key therefore unfortunatly. ------------------------------------------ [...truncated 131561 lines...] [[0;37mDEBUG[0m|#21377] 2012-12-05 13:52:13 [27549]: PUT /source/kde4/_meta?user=king [[0;37mDEBUG[0m|#21372] request took 0.012135454 [[0;37mDEBUG[0m|#21372] [1m[36m (0.4ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x00000007f4d358> took 1ms [[32mINFO [0m|#21372] Completed 200 OK in 220ms (Views: 1.1ms | ActiveRecord: 9.7ms | Backend: 12.1ms | XML: 0.0ms) [[32mINFO [0m|#21372] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-12-05 13:52:13 +0100 [[32mINFO [0m|#21372] Processing by SourceController#project_meta as XML [[32mINFO [0m|#21372] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#21372] Validate XML request: #<ActionDispatch::Request:0x000000065e9bf0> [[0;37mDEBUG[0m|#21372] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#21372] [1m[35mUser Load (0.5ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#21372] USER found: king [[0;37mDEBUG[0m|#21372] User king initialised [[0;37mDEBUG[0m|#21372] [1m[36mProjectUserRoleRelationship Load (0.3ms)[0m [1mSELECT ur.db_project_id, ur.bs_user_id from flags f, project_user_role_relationships ur where f.flag = 'access' and ur.db_project_id = f.db_project_id[0m [[0;37mDEBUG[0m|#21372] [1m[35mRole Load (0.4ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mProject Load (0.3ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x000000065e9b28> took 4ms [[32mINFO [0m|#21372] Completed 200 OK in 18ms (Views: 1.1ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#21372] Started GET "/source/kde4" for 127.0.0.1 at 2012-12-05 13:52:13 +0100 [[32mINFO [0m|#21372] Processing by SourceController#index_project as XML [[32mINFO [0m|#21372] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#21372] Validate XML request: #<ActionDispatch::Request:0x00000006b05670> [[0;37mDEBUG[0m|#21372] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#21372] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#21372] USER found: king [[0;37mDEBUG[0m|#21372] User king initialised [[0;37mDEBUG[0m|#21372] [1m[36mRole Load (0.4ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.3ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mPackage Load (0.3ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#21372] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x00000006b05648> took 0ms [[32mINFO [0m|#21372] Completed 200 OK in 15ms (Views: 0.8ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#21372] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-05 13:52:13 +0100 [[32mINFO [0m|#21372] Processing by SourceController#package_meta as XML [[32mINFO [0m|#21372] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#21372] Validate XML request: #<ActionDispatch::Request:0x00000006c467c8> [[0;37mDEBUG[0m|#21372] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#21372] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#21372] USER found: king [[0;37mDEBUG[0m|#21372] User king initialised [[0;37mDEBUG[0m|#21372] get_by_project_and_name {} [[0;37mDEBUG[0m|#21372] [1m[36mRole Load (0.4ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#21372] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#21372] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#21372] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#21372] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x00000006c467a0> took 2ms [[32mINFO [0m|#21372] Completed 200 OK in 23ms (Views: 0.5ms | ActiveRecord: 2.0ms | Backend: 0.0ms | XML: 0.4ms) [[32mINFO [0m|#21372] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-05 13:52:13 +0100 [[32mINFO [0m|#21372] Processing by SourceController#package_meta as XML [[32mINFO [0m|#21372] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#21372] Validate XML request: #<ActionDispatch::Request:0x00000006e8c168> [[0;37mDEBUG[0m|#21372] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#21372] USER found: king [[0;37mDEBUG[0m|#21372] User king initialised [[0;37mDEBUG[0m|#21372] [1m[36mRole Load (0.2ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] get_by_project_and_name {} [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#21372] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#21372] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#21372] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#21372] xml_disabled? X({"name"=>"kdebase", "project"=>"kde4", "title"=>"blub", "description"=>"blub"}) [[0;37mDEBUG[0m|#21372] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#21372] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#21372] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#21372] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#21372] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#21372] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#21372] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#21377] 2012-12-05 13:52:13 [27550]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#21372] request took 0.01196974 [[0;37mDEBUG[0m|#21372] [1m[35mPackage Load (0.4ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#21372] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#21372] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#21372] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#21377] 2012-12-05 13:52:13 [27551]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#21372] request took 0.016461052 [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1 [[0;37mDEBUG[0m|#21372] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#21372] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#21372] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#21377] 2012-12-05 13:52:13 [27552]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#21372] request took 0.025113774 [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35m (2.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x00000006e8c0c8> took 1ms [[32mINFO [0m|#21372] Completed 200 OK in 115ms (Views: 1.4ms | ActiveRecord: 5.2ms | Backend: 53.5ms | XML: 0.0ms) [[32mINFO [0m|#21372] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-12-05 13:52:13 +0100 [[32mINFO [0m|#21372] Processing by SourceController#package_meta as XML [[32mINFO [0m|#21372] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#21372] Validate XML request: #<ActionDispatch::Request:0x000000074a80d8> [[0;37mDEBUG[0m|#21372] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#21372] [1m[36mUser Load (0.5ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#21372] USER found: king [[0;37mDEBUG[0m|#21372] User king initialised [[0;37mDEBUG[0m|#21372] get_by_project_and_name {} [[0;37mDEBUG[0m|#21372] [1m[35mRole Load (0.5ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mProject Load (0.3ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mPackage Load (0.4ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mProject Load (6.4ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x000000074a80b0> took 3ms [[32mINFO [0m|#21372] Completed 200 OK in 52ms (Views: 0.9ms | ActiveRecord: 8.0ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#21372] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-05 13:52:13 +0100 [[32mINFO [0m|#21372] Processing by SourceController#package_meta as XML [[32mINFO [0m|#21372] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#21372] Validate XML request: #<ActionDispatch::Request:0x000000073132b8> [[0;37mDEBUG[0m|#21372] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#21372] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#21372] USER found: king [[0;37mDEBUG[0m|#21372] User king initialised [[0;37mDEBUG[0m|#21372] get_by_project_and_name {} [[0;37mDEBUG[0m|#21372] [1m[36mRole Load (0.3ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#21372] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`id` = 1234 AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 601 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#21372] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#21372] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x00000007313240> took 2ms [[32mINFO [0m|#21372] Completed 200 OK in 24ms (Views: 0.4ms | ActiveRecord: 2.2ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#21372] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-05 13:52:13 +0100 [[32mINFO [0m|#21372] Processing by SourceController#package_meta as XML [[32mINFO [0m|#21372] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n <devel project=\"home:coolo:test\" package=\"kdelibs_DEVEL_package\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#21372] Validate XML request: #<ActionDispatch::Request:0x000000078ae9e8> [[0;37mDEBUG[0m|#21372] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#21372] USER found: king [[0;37mDEBUG[0m|#21372] User king initialised [[0;37mDEBUG[0m|#21372] [1m[36mRole Load (0.2ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] get_by_project_and_name {} [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#21372] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#21372] [1m[36mFlag Load (0.1ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#21372] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#21372] xml_disabled? X({"name"=>"kdelibs", "project"=>"kde4", "title"=>"blub", "description"=>"blub", "devel"=>X({"project"=>"home:coolo:test", "package"=>"kdelibs_DEVEL_package"}), "person"=>[X({"userid"=>"fredlibs", "role"=>"maintainer"}), X({"userid"=>"adrian", "role"=>"reviewer"})], "group"=>X({"groupid"=>"test_group", "role"=>"maintainer"})}) [[0;37mDEBUG[0m|#21372] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#21372] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'home:coolo:test' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 601 AND `packages`.`name` = 'kdelibs_DEVEL_package' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 601 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#21372] [1m[36mUser Load (0.1ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mUser Load (0.1ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mRole Load (0.1ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1 [[0;37mDEBUG[0m|#21372] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#21372] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#21372] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#21372] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#21377] 2012-12-05 13:52:13 [27553]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#21372] request took 0.012437092 [[0;37mDEBUG[0m|#21372] [1m[36mPackage Load (0.4ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mUser Load (0.5ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'fredlibs' LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'adrian' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#21372] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mGroup Load (0.3ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#21372] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#21372] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#21372] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#21377] 2012-12-05 13:52:14 [27554]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#21372] request took 0.017031115 [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#21372] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mCACHE (0.0ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#21372] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#21372] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#21377] 2012-12-05 13:52:14 [27555]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#21372] request took 0.028417178 [[0;37mDEBUG[0m|#21372] [1m[36mCACHE (0.0ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x000000078ae9c0> took 1ms [[32mINFO [0m|#21372] Completed 200 OK in 134ms (Views: 1.4ms | ActiveRecord: 5.5ms | Backend: 57.9ms | XML: 0.0ms) [[32mINFO [0m|#21372] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-12-05 13:52:14 +0100 [[32mINFO [0m|#21372] Processing by SourceController#package_meta as XML [[32mINFO [0m|#21372] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#21372] Validate XML request: #<ActionDispatch::Request:0x00000007d73f50> [[0;37mDEBUG[0m|#21372] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#21372] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#21372] USER found: king [[0;37mDEBUG[0m|#21372] User king initialised [[0;37mDEBUG[0m|#21372] get_by_project_and_name {} [[0;37mDEBUG[0m|#21372] [1m[35mRole Load (0.4ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mProject Load (0.3ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] [1m[35mPackage Load (0.3ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#21372] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#21372] Validate XML response: #<ActionDispatch::Response:0x00000007d73f28> took 2ms [[32mINFO [0m|#21372] Completed 200 OK in 16ms (Views: 0.5ms | ActiveRecord: 1.7ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#21372] [1m[35m (43.9ms)[0m ROLLBACK [[0;37mDEBUG[0m|#21372] kill 21377 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/scheduler.done src/api/tmp/sessions src/api/tmp/sockets 'src/webui/log/*' src/webui/tmp/cache src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 4