February 2013 - Open Build Service Tests

[obs-tests] Build failed in Jenkins: obs_osc2_testsuite_master #81
by admin＠opensuse.org 21 Feb '13

21 Feb '13

See <http://ci.opensuse.org/job/obs_osc2_testsuite_master/81/changes> Changes: [suse-tux] - osc.cli.util.env.edit_message: check if the user modified the template ------------------------------------------ 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 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 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 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 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 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 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 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 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 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 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 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 Started by an SCM change Started by an SCM change Building remotely on master_deps_chroot in workspace <http://ci.opensuse.org/job/obs_osc2_testsuite_master/ws/> Checkout:obs_osc2_testsuite_master / <http://ci.opensuse.org/job/obs_osc2_testsuite_master/ws/> - hudson.remoting.Channel@23682368:master_deps_chroot Using strategy: Default Last Built Revision: Revision f23c47efbd98ec1657e99891dfb1c590952547d1 (origin/master) Cloning the remote Git repository Cloning repository git://github.com/openSUSE/osc2.git git --version git version 1.7.10.4 Fetching upstream changes from git://github.com/openSUSE/osc2.git Commencing build of Revision 7e4752d103d6a66f87512ab108599b6d946921ba (origin/master) Checking out Revision 7e4752d103d6a66f87512ab108599b6d946921ba (origin/master) [obs_osc2_testsuite_master] $ /bin/sh -xe /tmp/hudson2471208635048587571.sh + rm -rf nosetests.xml coverage.xml .coverage + nosetests --with-coverage --with-xunit --cover-package=osc /tmp/hudson2471208635048587571.sh: line 3: nosetests: command not found Build step 'Execute shell' marked build as failure Skipping Cobertura coverage report as build was not UNSTABLE or better ... 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_webui #826
by admin＠opensuse.org 20 Feb '13

20 Feb '13

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/826/changes> Changes: [adrian] [api] make it possible to configure OBS:RejectRequests for action types (bnc#804699) ------------------------------------------ [...truncated 223781 lines...] [[32mINFO [0m|#24795] Processing by ProjectController#buildresult as */* [[32mINFO [0m|#24795] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|#24795] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|#24795] Authenticating with iChain mode: off [[32mINFO [0m|#24795] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|#24795] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#24795] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#24795] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#24795] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/person/tom {"view"=>0.756149, "db"=>2.075787, "backend"=>0, "xml"=>0, :runtime=>17.599, :all=>21.861564} [[0;37mDEBUG[0m|#24795] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#24795] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#24795] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#24795] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#24795] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.7447690000000001, "backend"=>0, "xml"=>0, :runtime=>20.047, :all=>59.873509} [[32mINFO [0m|#24795] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#24795] Completed 200 OK in 86ms (Views: 0.7ms | ActiveRecord: 0.0ms | API: 81.7ms (XML: 0.0ms , View: 0.8ms , Backend: 0.0ms , DB: 2.8ms , HTTP: 44.1ms) | XML: 0.3ms) [[32mINFO [0m|#24795] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-02-20 17:16:10 +0000 [[32mINFO [0m|#24795] Processing by ProjectController#show as HTML [[32mINFO [0m|#24795] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#24795] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#24795] Authenticating with iChain mode: off [[32mINFO [0m|#24795] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#24795] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#24795] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#24795] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#24795] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/person/tom {"view"=>0.4723, "db"=>1.4847189999999997, "backend"=>0, "xml"=>0, :runtime=>12.092, :all=>51.387116} [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.26498700000000003, "db"=>3.8592879999999994, "backend"=>0, "xml"=>0, :runtime=>26.629, :all=>67.060427} [[0;37mDEBUG[0m|#24795] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.409261, "db"=>3.4380749999999995, "backend"=>0, "xml"=>0, :runtime=>36.289, :all=>75.50192899999999} [[0;37mDEBUG[0m|#24795] 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|#24795] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#24795] Rendered project/_tabs.html.erb (2.1ms) [[32mINFO [0m|#24795] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#24795] Rendered layouts/_watch_and_search.html.erb (1.2ms) [[32mINFO [0m|#24795] Rendered layouts/_header.html.erb (1.9ms) [[32mINFO [0m|#24795] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#24795] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#24795] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#24795] Completed 200 OK in 210ms (Views: 12.0ms | ActiveRecord: 0.0ms | API: 193.9ms (XML: 0.0ms , View: 1.1ms , Backend: 0.0ms , DB: 8.8ms , HTTP: 118.9ms) | XML: 0.5ms) [[32mINFO [0m|#24795] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-02-20 17:16:10 +0000 [[32mINFO [0m|#24795] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#24795] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#24795] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#24795] Authenticating with iChain mode: off [[32mINFO [0m|#24795] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#24795] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#24795] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#24795] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#24795] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/person/tom {"view"=>0.44162900000000005, "db"=>1.317453, "backend"=>0, "xml"=>0, :runtime=>11.753, :all=>14.922896} [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.246074, "db"=>3.715328, "backend"=>0, "xml"=>0, :runtime=>27.0, :all=>65.23866100000001} [[0;37mDEBUG[0m|#24795] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#24795] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#24795] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#24795] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#24795] saving object Person ({:is_current=>"true", :login=>"tom"}) to api: <person> <login>tom</login> <email>tschmidt(a)suse.de</email> <realname>Thor</realname> <state>confirmed</state> <watchlist> </watchlist> </person> [[0;37mDEBUG[0m|#24795] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/person/tom {"view"=>0.8425769999999999, "db"=>2.118108, "backend"=>0, "xml"=>0, :runtime=>15.363999999999999, :all=>18.946574000000002} [[0;37mDEBUG[0m|#24795] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#24795] params {:login=>"tom"} [[0;37mDEBUG[0m|#24795] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/person/tom/group {"view"=>0.372822, "db"=>0.7171190000000001, "backend"=>0, "xml"=>0, :runtime=>6.074999999999999, :all=>9.509172} [[0;37mDEBUG[0m|#24795] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#24795] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#24795] Redirected to http://127.0.0.1:35851/project/show?project=My%3AMaintenance [[32mINFO [0m|#24795] Completed 302 Found in 113ms (ActiveRecord: 0.0ms | API: 108.6ms (XML: 0.0ms , View: 1.9ms , Backend: 0.0ms , DB: 7.9ms , HTTP: 48.4ms) | XML: 0.3ms) [[32mINFO [0m|#24795] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-02-20 17:16:10 +0000 [[32mINFO [0m|#24795] Processing by ProjectController#show as HTML [[32mINFO [0m|#24795] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#24795] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#24795] Authenticating with iChain mode: off [[32mINFO [0m|#24795] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#24795] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#24795] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#24795] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#24795] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/person/tom {"view"=>0.480326, "db"=>1.133828, "backend"=>0, "xml"=>0, :runtime=>54.027, :all=>94.306341} [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.264114, "db"=>9.524383, "backend"=>0, "xml"=>0, :runtime=>101.05600000000001, :all=>142.964336} [[0;37mDEBUG[0m|#24795] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.400805, "db"=>3.3366700000000002, "backend"=>0, "xml"=>0, :runtime=>32.649, :all=>71.190548} [[0;37mDEBUG[0m|#24795] 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|#24795] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#24795] Rendered project/_tabs.html.erb (2.0ms) [[32mINFO [0m|#24795] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#24795] Rendered layouts/_watch_and_search.html.erb (0.9ms) [[32mINFO [0m|#24795] Rendered layouts/_header.html.erb (1.6ms) [[32mINFO [0m|#24795] Rendered layouts/_personal_navigation.html.erb (0.9ms) [[32mINFO [0m|#24795] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#24795] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#24795] Completed 200 OK in 324ms (Views: 11.2ms | ActiveRecord: 0.0ms | API: 308.5ms (XML: 0.0ms , View: 1.1ms , Backend: 0.0ms , DB: 14.0ms , HTTP: 120.7ms) | XML: 0.5ms) [[32mINFO [0m|#24795] Started POST "/user/logout" for 127.0.0.1 at 2013-02-20 17:16:11 +0000 [[32mINFO [0m|#24795] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#24795] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#24795] Authenticating with iChain mode: off [[32mINFO [0m|#24795] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#24795] Logging out: tom [[32mINFO [0m|#24795] Redirected to http://127.0.0.1:35851/ [[0;37mDEBUG[0m|#24795] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#24795] Completed 302 Found in 21ms (ActiveRecord: 18.7ms | XML: 0.0ms) [[32mINFO [0m|#24795] Started GET "/" for 127.0.0.1 at 2013-02-20 17:16:11 +0000 [[32mINFO [0m|#24795] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#24795] Setting return_to: "/" [[0;37mDEBUG[0m|#24795] Authenticating with iChain mode: off [[32mINFO [0m|#24795] Anonymous request to / [[0;37mDEBUG[0m|#24795] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#24795] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] ) [[0;37mDEBUG[0m|#24795] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"} [[0;37mDEBUG[0m|#24795] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=5 [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/status/messages/?limit=5 {"view"=>0.67055, "db"=>0.560064, "backend"=>0, "xml"=>0, :runtime=>5.983, :all=>9.016300999999999} [[0;37mDEBUG[0m|#24795] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#24795] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#24795] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#24795] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#24795] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.025008, "db"=>2.0050499999999998, "backend"=>0, "xml"=>0, :runtime=>15.091999999999999, :all=>55.478055999999995} [[32mINFO [0m|#24795] Rendered main/_news.html.erb (0.7ms) [[32mINFO [0m|#24795] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|#24795] Rendered main/_latest_updates.erb (4.0ms) [[32mINFO [0m|#24795] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|#24795] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#24795] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|#24795] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#24795] Rendered layouts/_header.html.erb (1.1ms) [[32mINFO [0m|#24795] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#24795] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#24795] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#24795] Completed 200 OK in 82ms (Views: 13.7ms | ActiveRecord: 0.0ms | API: 64.5ms (XML: 0.0ms , View: 1.7ms , Backend: 0.0ms , DB: 2.6ms , HTTP: 43.4ms) | XML: 0.9ms) [[32mINFO [0m|#24795] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-02-20 17:16:11 +0000 [[32mINFO [0m|#24795] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#24795] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#24795] Authenticating with iChain mode: off [[32mINFO [0m|#24795] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#24795] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#24795] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#24795] Rendered main/_systemstatus.html.erb (1.1ms) [[32mINFO [0m|#24795] Completed 200 OK in 3ms (Views: 1.6ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|#24795] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#24795] RT http://localhost:3203/test/test_end {"view"=>0.873153, "db"=>13.528463, "backend"=>0, "xml"=>0, :runtime=>17.942, :all=>21.629775} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/cache src/api/tmp/pids src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/capybara src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe(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 #1369
by admin＠opensuse.org 14 Feb '13

14 Feb '13

See <http://ci.opensuse.org/job/obs_master_testsuite_api/1369/changes> Changes: [adrian] [api] we have group titles with a dot inside, allow this again [adrian] [api] fix test suite on 12.3, description tag got shortend and it seems to be okay according to XML spec ------------------------------------------ [...truncated 133978 lines...] [[32mINFO [0m|#12723] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#12723] Validate XML request: #<ActionDispatch::Request:0x00000007a01340> [[0;37mDEBUG[0m|#12723] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12723] [1m[35mUser Load (0.5ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#12723] USER found: king [[0;37mDEBUG[0m|#12723] User king initialised [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] Validate XML response: #<ActionDispatch::Response:0x00000007a01318> took 2ms [[32mINFO [0m|#12723] Completed 200 OK in 11ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#12723] Started GET "/source/kde4" for 127.0.0.1 at 2013-02-14 14:13:56 +0000 [[32mINFO [0m|#12723] Processing by SourceController#index_project as XML [[32mINFO [0m|#12723] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#12723] Validate XML request: #<ActionDispatch::Request:0x00000007a51958> [[0;37mDEBUG[0m|#12723] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12723] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#12723] USER found: king [[0;37mDEBUG[0m|#12723] User king initialised [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#12723] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#12723] Validate XML response: #<ActionDispatch::Response:0x00000007a518b8> took 0ms [[32mINFO [0m|#12723] Completed 200 OK in 7ms (Views: 0.3ms | ActiveRecord: 0.9ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#12723] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-02-14 14:13:56 +0000 [[32mINFO [0m|#12723] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12723] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#12723] Validate XML request: #<ActionDispatch::Request:0x00000007ecf9d0> [[0;37mDEBUG[0m|#12723] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12723] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#12723] USER found: king [[0;37mDEBUG[0m|#12723] User king initialised [[0;37mDEBUG[0m|#12723] get_by_project_and_name {} [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [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|#12723] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#12723] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12723] Validate XML response: #<ActionDispatch::Response:0x00000007ecf9a8> took 2ms [[32mINFO [0m|#12723] Completed 200 OK in 15ms (Views: 0.3ms | ActiveRecord: 1.7ms | Backend: 0.0ms | XML: 0.2ms) [[32mINFO [0m|#12723] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-02-14 14:13:56 +0000 [[32mINFO [0m|#12723] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12723] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#12723] Validate XML request: #<ActionDispatch::Request:0x00000008055bb0> [[0;37mDEBUG[0m|#12723] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#12723] USER found: king [[0;37mDEBUG[0m|#12723] User king initialised [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [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|#12723] get_by_project_and_name {} [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [1m[35mFlag Load (0.3ms)[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|#12723] [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|#12723] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#12723] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#12723] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#12723] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#12723] xml_disabled? X({"name"=>"kdebase", "project"=>"kde4", "title"=>"blub", "description"=>"blub"}) [[0;37mDEBUG[0m|#12723] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#12723] [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|#12723] [1m[35mPackage Load (0.2ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1360851236)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000000000016714 WHERE `packages`.`id` = 2 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#12723] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 2 AND (packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#12723] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 1, `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 2[0m [[0;37mDEBUG[0m|#12723] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12723] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#12728] 2013-02-14 14:13:56 [18968]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#12723] request took 0.018018344 [[0;37mDEBUG[0m|#12723] [1m[35mPackageGroupRoleRelationship Load (0.6ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#12723] [1m[36mPackage Load (0.3ms)[0m [1mSELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1360851236)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m [[0;37mDEBUG[0m|#12723] [1m[35mSQL (0.3ms)[0m UPDATE `packages` SET `activity_index` = 10.000002963509825 WHERE `packages`.`id` = 2 AND (packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#12723] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 2 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#12723] [1m[35m (0.2ms)[0m UPDATE `packages` SET `update_counter` = 2, `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 2 [[0;37mDEBUG[0m|#12723] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12723] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#12728] 2013-02-14 14:13:56 [18969]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#12723] request took 0.012236512 [[0;37mDEBUG[0m|#12723] [1m[36mPackage Load (0.5ms)[0m [1mSELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1360851236)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m [[0;37mDEBUG[0m|#12723] [1m[35mSQL (0.3ms)[0m UPDATE `packages` SET `activity_index` = 10.000004958140629 WHERE `packages`.`id` = 2 AND (packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#12723] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 2 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#12723] [1m[35m (0.2ms)[0m UPDATE `packages` SET `update_counter` = 3, `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 2 [[0;37mDEBUG[0m|#12723] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12723] [1m[36mPackageUserRoleRelationship Load (0.3ms)[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|#12723] [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|#12723] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12723] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#12728] 2013-02-14 14:13:56 [18970]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#12723] request took 0.013650601 [[0;37mDEBUG[0m|#12723] [1m[36m (0.2ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#12723] Validate XML response: #<ActionDispatch::Response:0x00000008055b88> took 0ms [[32mINFO [0m|#12723] Completed 200 OK in 96ms (Views: 1.0ms | ActiveRecord: 7.4ms | Backend: 43.9ms | XML: 0.0ms) [[32mINFO [0m|#12723] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-02-14 14:13:56 +0000 [[32mINFO [0m|#12723] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12723] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#12723] Validate XML request: #<ActionDispatch::Request:0x000000088dad30> [[0;37mDEBUG[0m|#12723] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12723] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#12723] USER found: king [[0;37mDEBUG[0m|#12723] User king initialised [[0;37mDEBUG[0m|#12723] get_by_project_and_name {} [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [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|#12723] Validate XML response: #<ActionDispatch::Response:0x000000088dace0> took 1ms [[32mINFO [0m|#12723] Completed 200 OK in 12ms (Views: 0.4ms | ActiveRecord: 1.3ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#12723] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-02-14 14:13:56 +0000 [[32mINFO [0m|#12723] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12723] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#12723] Validate XML request: #<ActionDispatch::Request:0x00000008931ef0> [[0;37mDEBUG[0m|#12723] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12723] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12723] USER found: king [[0;37mDEBUG[0m|#12723] User king initialised [[0;37mDEBUG[0m|#12723] get_by_project_and_name {} [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [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|#12723] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [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|#12723] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#12723] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12723] Validate XML response: #<ActionDispatch::Response:0x00000008931ea0> took 1ms [[32mINFO [0m|#12723] Completed 200 OK in 18ms (Views: 0.3ms | ActiveRecord: 2.1ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#12723] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-02-14 14:13:56 +0000 [[32mINFO [0m|#12723] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12723] 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|#12723] Validate XML request: #<ActionDispatch::Request:0x000000088a2bb0> [[0;37mDEBUG[0m|#12723] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12723] USER found: king [[0;37mDEBUG[0m|#12723] User king initialised [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [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|#12723] get_by_project_and_name {} [[0;37mDEBUG[0m|#12723] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12723] [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|#12723] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mFlag Load (0.3ms)[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|#12723] [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|#12723] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#12723] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#12723] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#12723] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#12723] 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|#12723] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#12723] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mRole Load (0.1ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#12723] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|#12723] [1m[35mPackage Load (0.2ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1360851236)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mSQL (0.3ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000000000016714 WHERE `packages`.`id` = 1 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#12723] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 1 AND (packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#12723] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 1, `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 1[0m [[0;37mDEBUG[0m|#12723] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12723] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#12728] 2013-02-14 14:13:56 [18971]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#12723] request took 0.011292818 [[0;37mDEBUG[0m|#12723] [1m[35mUser Load (0.5ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'fredlibs' LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'adrian' LIMIT 1[0m [[0;37mDEBUG[0m|#12723] [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|#12723] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#12723] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#12723] [1m[35mPackage Load (0.3ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1360851236)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mSQL (0.3ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000021067758402 WHERE `packages`.`id` = 1 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#12723] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 1 AND (packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#12723] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 2, `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 1[0m [[0;37mDEBUG[0m|#12723] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12723] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#12728] 2013-02-14 14:13:56 [18972]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#12723] request took 0.010886582 [[0;37mDEBUG[0m|#12723] [1m[35mPackage Load (0.5ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1360851236)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#12723] [1m[36mSQL (0.3ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000023078863267 WHERE `packages`.`id` = 1 AND (packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#12723] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 1 AND (packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#12723] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 3, `updated_at` = '2013-02-14 14:13:56' WHERE `packages`.`id` = 1[0m [[0;37mDEBUG[0m|#12723] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12723] [1m[35mPackageUserRoleRelationship Load (0.4ms)[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|#12723] [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|#12723] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12723] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#12728] 2013-02-14 14:13:56 [18973]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#12723] request took 0.016136249 [[0;37mDEBUG[0m|#12723] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#12723] Validate XML response: #<ActionDispatch::Response:0x000000088a2b60> took 1ms [[32mINFO [0m|#12723] Completed 200 OK in 265ms (Views: 1.2ms | ActiveRecord: 9.7ms | Backend: 38.3ms | XML: 0.0ms) [[32mINFO [0m|#12723] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-02-14 14:13:56 +0000 [[32mINFO [0m|#12723] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12723] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#12723] Validate XML request: #<ActionDispatch::Request:0x00000006f84ca0> [[0;37mDEBUG[0m|#12723] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12723] [1m[36mUser Load (0.5ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12723] USER found: king [[0;37mDEBUG[0m|#12723] User king initialised [[0;37mDEBUG[0m|#12723] get_by_project_and_name {} [[0;37mDEBUG[0m|#12723] [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|#12723] [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|#12723] [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|#12723] [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|#12723] Validate XML response: #<ActionDispatch::Response:0x00000006f84c00> took 2ms [[32mINFO [0m|#12723] Completed 200 OK in 13ms (Views: 0.4ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#12723] [1m[35m (5.5ms)[0m ROLLBACK [[0;37mDEBUG[0m|#12723] kill 12728 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> + egrep 'perl|ruby' + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/cache src/api/tmp/pids src/api/tmp/sessions src/api/tmp/sockets 'src/webui/log/*' 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 1

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #813
by admin＠opensuse.org 14 Feb '13

14 Feb '13

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/813/changes> Changes: [Stephan Kulow] [dist] update gem dependencies - 3.2.12 is reason enough [adrian] [api][webui] update rubygem versions to be in sync with openSUSE:Tools:Unstable [mls] [backend] publisher: do not remove arch linux symlinks in deleterepo_staticlinks() [adrian] [webui] revert to codemirror-rails version 3.00 (3.02 complains about missing codemirror/modes/xmlpure.js) [adrian] [backend] handle "emulator" mode as virtualization when collecting the build result [Stephan Kulow] [webui] some fixes for recent gems [Stephan Kulow] [dist] one more gem synced ------------------------------------------ [...truncated 230140 lines...] [[0;37mDEBUG[0m|#15113] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#15113] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#15113] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#15113] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.674596, "backend"=>0, "xml"=>0, :runtime=>20.785, :all=>61.617496} [[32mINFO [0m|#15113] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#15113] Completed 200 OK in 81ms (Views: 0.8ms | ActiveRecord: 0.0ms | API: 77.9ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.4ms , HTTP: 44.2ms) | XML: 0.3ms) [[32mINFO [0m|#15113] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-02-13 23:21:31 +0000 [[32mINFO [0m|#15113] Processing by ProjectController#show as HTML [[32mINFO [0m|#15113] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#15113] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#15113] Authenticating with iChain mode: off [[32mINFO [0m|#15113] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#15113] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#15113] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#15113] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#15113] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/person/tom {"view"=>0.5597300000000001, "db"=>1.4986350000000002, "backend"=>0, "xml"=>0, :runtime=>12.722000000000001, :all=>54.619429999999994} [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.295784, "db"=>5.214556, "backend"=>0, "xml"=>0, :runtime=>37.925, :all=>79.39718599999999} [[0;37mDEBUG[0m|#15113] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.38916, "db"=>3.726186, "backend"=>0, "xml"=>0, :runtime=>36.532000000000004, :all=>78.261249} [[0;37mDEBUG[0m|#15113] 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|#15113] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#15113] Rendered project/_tabs.html.erb (2.1ms) [[32mINFO [0m|#15113] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#15113] Rendered layouts/_watch_and_search.html.erb (1.2ms) [[32mINFO [0m|#15113] Rendered layouts/_header.html.erb (1.9ms) [[32mINFO [0m|#15113] Rendered layouts/_personal_navigation.html.erb (0.9ms) [[32mINFO [0m|#15113] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#15113] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#15113] Completed 200 OK in 229ms (Views: 11.5ms | ActiveRecord: 0.0ms | API: 212.3ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 10.4ms , HTTP: 125.1ms) | XML: 0.5ms) [[32mINFO [0m|#15113] Started GET "/assets/application.css" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Served asset /application.css - 304 Not Modified (0ms) [[32mINFO [0m|#15113] Started GET "/assets/application.js" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Served asset /application.js - 304 Not Modified (0ms) [[32mINFO [0m|#15113] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#15113] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#15113] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#15113] Authenticating with iChain mode: off [[32mINFO [0m|#15113] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#15113] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#15113] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#15113] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#15113] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/person/tom {"view"=>0.5547599999999999, "db"=>1.505308, "backend"=>0, "xml"=>0, :runtime=>12.723999999999998, :all=>15.837454000000001} [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.24869699999999997, "db"=>3.844919, "backend"=>0, "xml"=>0, :runtime=>27.399, :all=>67.37261099999999} [[0;37mDEBUG[0m|#15113] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#15113] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#15113] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#15113] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#15113] saving object Person ({:is_current=>"true", :login=>"tom"}) to api: <person> <login>tom</login> <email>tschmidt(a)suse.de</email> <realname>Thor</realname> <state>confirmed</state> <watchlist> </watchlist> </person> [[0;37mDEBUG[0m|#15113] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/person/tom {"view"=>0.7757210000000001, "db"=>2.0242240000000002, "backend"=>0, "xml"=>0, :runtime=>16.81, :all=>20.495124999999998} [[0;37mDEBUG[0m|#15113] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#15113] params {:login=>"tom"} [[0;37mDEBUG[0m|#15113] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/person/tom/group {"view"=>0.296047, "db"=>0.594643, "backend"=>0, "xml"=>0, :runtime=>5.146999999999999, :all=>8.093387} [[0;37mDEBUG[0m|#15113] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#15113] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#15113] Redirected to http://127.0.0.1:52880/project/show?project=My%3AMaintenance [[32mINFO [0m|#15113] Completed 302 Found in 116ms (ActiveRecord: 0.0ms | API: 111.8ms (XML: 0.0ms , View: 1.9ms , Backend: 0.0ms , DB: 8.0ms , HTTP: 49.7ms) | XML: 0.4ms) [[32mINFO [0m|#15113] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Processing by ProjectController#show as HTML [[32mINFO [0m|#15113] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#15113] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#15113] Authenticating with iChain mode: off [[32mINFO [0m|#15113] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#15113] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#15113] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#15113] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#15113] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/person/tom {"view"=>0.447265, "db"=>0.806632, "backend"=>0, "xml"=>0, :runtime=>66.481, :all=>109.795658} [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.225489, "db"=>3.797187000000001, "backend"=>0, "xml"=>0, :runtime=>28.111, :all=>68.008944} [[0;37mDEBUG[0m|#15113] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.497604, "db"=>3.6921959999999996, "backend"=>0, "xml"=>0, :runtime=>34.607, :all=>74.51360199999999} [[0;37mDEBUG[0m|#15113] 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|#15113] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#15113] Rendered project/_tabs.html.erb (2.8ms) [[32mINFO [0m|#15113] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#15113] Rendered layouts/_watch_and_search.html.erb (0.9ms) [[32mINFO [0m|#15113] Rendered layouts/_header.html.erb (1.6ms) [[32mINFO [0m|#15113] Rendered layouts/_personal_navigation.html.erb (0.9ms) [[32mINFO [0m|#15113] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#15113] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#15113] Completed 200 OK in 328ms (Views: 12.5ms | ActiveRecord: 0.0ms | API: 252.3ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 8.3ms , HTTP: 123.1ms) | XML: 0.5ms) [[32mINFO [0m|#15113] Started GET "/assets/application.css" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Served asset /application.css - 304 Not Modified (0ms) [[32mINFO [0m|#15113] Started GET "/assets/application.js" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Served asset /application.js - 304 Not Modified (0ms) [[32mINFO [0m|#15113] Started POST "/user/logout" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#15113] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#15113] Authenticating with iChain mode: off [[32mINFO [0m|#15113] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#15113] Logging out: tom [[32mINFO [0m|#15113] Redirected to http://127.0.0.1:52880/ [[0;37mDEBUG[0m|#15113] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#15113] Completed 302 Found in 70ms (ActiveRecord: 68.6ms | XML: 0.0ms) [[32mINFO [0m|#15113] Started GET "/" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#15113] Setting return_to: "/" [[0;37mDEBUG[0m|#15113] Authenticating with iChain mode: off [[32mINFO [0m|#15113] Anonymous request to / [[0;37mDEBUG[0m|#15113] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|#15113] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] ) [[0;37mDEBUG[0m|#15113] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"} [[0;37mDEBUG[0m|#15113] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=5 [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/status/messages/?limit=5 {"view"=>0.9050710000000001, "db"=>0.642818, "backend"=>0, "xml"=>0, :runtime=>7.276999999999999, :all=>10.299298} [[0;37mDEBUG[0m|#15113] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#15113] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#15113] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#15113] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#15113] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>0.994336, "db"=>2.0336860000000003, "backend"=>0, "xml"=>0, :runtime=>15.458, :all=>56.860744} [[32mINFO [0m|#15113] Rendered main/_news.html.erb (0.8ms) [[32mINFO [0m|#15113] Rendered main/_contact.html.erb (0.1ms) [[32mINFO [0m|#15113] Rendered main/_latest_updates.erb (5.7ms) [[32mINFO [0m|#15113] Rendered main/_countdown.html.erb (0.1ms) [[32mINFO [0m|#15113] Rendered main/_sponsors.html.erb (0.1ms) [[32mINFO [0m|#15113] Rendered main/_feeds.html.erb (0.1ms) [[32mINFO [0m|#15113] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#15113] Rendered layouts/_header.html.erb (1.1ms) [[32mINFO [0m|#15113] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#15113] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#15113] Rendered layouts/_sponsor.html.erb (0.1ms) [[32mINFO [0m|#15113] Completed 200 OK in 89ms (Views: 17.6ms | ActiveRecord: 0.0ms | API: 67.2ms (XML: 0.0ms , View: 1.9ms , Backend: 0.0ms , DB: 2.7ms , HTTP: 44.4ms) | XML: 1.2ms) [[32mINFO [0m|#15113] Started GET "/assets/application.js" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Served asset /application.js - 304 Not Modified (0ms) [[32mINFO [0m|#15113] Started GET "/assets/application.css" for 127.0.0.1 at 2013-02-13 23:21:32 +0000 [[32mINFO [0m|#15113] Served asset /application.css - 304 Not Modified (0ms) [[32mINFO [0m|#15113] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-02-13 23:21:33 +0000 [[32mINFO [0m|#15113] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#15113] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#15113] Authenticating with iChain mode: off [[32mINFO [0m|#15113] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#15113] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#15113] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#15113] Rendered main/_systemstatus.html.erb (1.6ms) [[32mINFO [0m|#15113] Completed 200 OK in 4ms (Views: 2.2ms | ActiveRecord: 0.0ms | XML: 0.4ms) [[0;37mDEBUG[0m|#15113] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#15113] RT http://localhost:3203/test/test_end {"view"=>0.70447, "db"=>20.199404, "backend"=>0, "xml"=>0, :runtime=>24.368000000000002, :all=>27.920256000000002} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/cache src/api/tmp/pids src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/capybara src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Build failed in Jenkins: obs_osc_testsuite_master #188
by admin＠opensuse.org 12 Feb '13

12 Feb '13

See <http://ci.opensuse.org/job/obs_osc_testsuite_master/188/changes> Changes: [opensuse] - refactor assertEqualMultiline into common.py for reuse [opensuse] - add prdiff subcommand and test suite [suse-tux] - tests.test_prdiff: disabled the usage of keyrings when running the cli ------------------------------------------ Started by an SCM change Building on master in workspace <http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/> Checkout:workspace / <http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/> - hudson.remoting.LocalChannel@2e3c2e3c Using strategy: Default Last Built Revision: Revision 33f3ab420372b02d043399c642f2db05fd63fcab (origin/master) Fetching changes from 1 remote Git repository Fetching upstream changes from git://github.com/openSUSE/osc.git Commencing build of Revision d4b8fbbba47c005380e65e907beaebbbb794dfee (origin/master) Checking out Revision d4b8fbbba47c005380e65e907beaebbbb794dfee (origin/master) [workspace] $ /bin/sh -xe /tmp/hudson7112963829526015221.sh + cd tests + python suite.py Running tests... ---------------------------------------------------------------------- ...........................................................................................................................................................................E............ ====================================================================== ERROR [0.076s]: testPrdiffDiffstat (test_prdiff.TestProjectDiff) ---------------------------------------------------------------------- Traceback (most recent call last): File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/test_prdiff.py",> line 30, in wrapped_test_method test_method(*args) File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/test_prdiff.py",> line 43, in wrapped_test_method test_method(*args) File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/test_prdiff.py",> line 164, in testPrdiffDiffstat out = self._run_prdiff('--diffstat', 'old:prj', 'new:prj') File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/test_prdiff.py",> line 67, in _run_prdiff cli.main(argv=argv) File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/osc/cmdln.py",> line 310, in main return self.cmd(args) File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/osc/cmdln.py",> line 333, in cmd retval = self.onecmd(argv) File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/osc/cmdln.py",> line 449, in onecmd return self._dispatch_cmd(handler, argv) File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/osc/cmdln.py",> line 1179, in _dispatch_cmd return handler(argv[0], opts, *args) File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/osc/commandlin…",> line 3650, in do_prdiff self._prdiff_output_diff(opts, rdiff) File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/osc/commandlin…",> line 3536, in _prdiff_output_diff close_fds=True) File "/usr/lib64/python2.6/subprocess.py", line 623, in __init__ errread, errwrite) File "/usr/lib64/python2.6/subprocess.py", line 1141, in _execute_child raise child_exception OSError: [Errno 13] Permission denied ====================================================================== ERROR [0.076s]: testPrdiffDiffstat (test_prdiff.TestProjectDiff) ---------------------------------------------------------------------- Traceback (most recent call last): File "<http://ci.opensuse.org/job/obs_osc_testsuite_master/ws/tests/common.py",> line 124, in tearDown self.assertTrue(len(EXPECTED_REQUESTS) == 0) AssertionError ---------------------------------------------------------------------- Ran 184 tests in 8.785s FAILED (errors=2) Generating XML reports... Build step 'Execute shell' marked build as failure 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 17

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #796
by admin＠opensuse.org 01 Feb '13

01 Feb '13

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/796/changes> Changes: [adrian] [api][webui] support local webui's speaking to a remote api anonymously using /public/configuration route. [adrian] make it possible to exclude specific sandboxes and hostlabels in constraints ------------------------------------------ [...truncated 21712 lines...] [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.752129, "db"=>16.908129, "backend"=>0, "xml"=>0, :runtime=>20.264999999999997, :all=>23.273282} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000005ff9448 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.940674} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.5885009999999999, "db"=>12.77717, "backend"=>0, "xml"=>0, :runtime=>16.055, :all=>19.173273000000002} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006635b90 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.3791480000000003} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 3ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.560094, "db"=>10.569818999999999, "backend"=>0, "xml"=>0, :runtime=>13.442, :all=>15.906762} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006c7be50 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>3.970067} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.838141, "db"=>10.512515, "backend"=>0, "xml"=>0, :runtime=>14.023000000000001, :all=>16.607062999999997} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000007038840 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>4.135931} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.57449, "db"=>11.203959999999999, "backend"=>0, "xml"=>0, :runtime=>14.302999999999999, :all=>16.888243} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x0000000758f208 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>3.267286} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>1.043752, "db"=>13.270693999999999, "backend"=>0, "xml"=>0, :runtime=>18.011, :all=>22.111092999999997} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x000000078aa9b0 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>3.7944530000000003} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.719385, "db"=>9.287128, "backend"=>0, "xml"=>0, :runtime=>13.056999999999999, :all=>16.743615} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000003069f70 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>3.5741039999999997} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>1.028356, "db"=>11.094103, "backend"=>0, "xml"=>0, :runtime=>16.38, :all=>20.803796} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x000000040fcce8 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>3.7744660000000003} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>1.052733, "db"=>10.571383, "backend"=>0, "xml"=>0, :runtime=>15.86, :all=>20.477639} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x000000066af698 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>3.656117} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.701944, "db"=>9.526236, "backend"=>0, "xml"=>0, :runtime=>13.039, :all=>16.044133} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006376058 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>5.0581380000000005} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 6ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.930006, "db"=>10.61927, "backend"=>0, "xml"=>0, :runtime=>14.867999999999999, :all=>18.22987} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:58 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006919f00 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>4.7761640000000005} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 6ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.916833, "db"=>11.001519, "backend"=>0, "xml"=>0, :runtime=>15.257, :all=>18.792895} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x000000063594f8 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>4.430692} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 6ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.715647, "db"=>8.811787, "backend"=>0, "xml"=>0, :runtime=>13.173, :all=>16.939507} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006ab9478 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.7242830000000002} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.71747, "db"=>9.959369, "backend"=>0, "xml"=>0, :runtime=>13.871, :all=>17.264306} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006c99680 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.669216} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.932632, "db"=>10.662894, "backend"=>0, "xml"=>0, :runtime=>14.864, :all=>18.271759} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006e6a9c8 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.92228} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.871982, "db"=>9.718601, "backend"=>0, "xml"=>0, :runtime=>13.867, :all=>17.445863999999997} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000002f39c40 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.92909} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.737464, "db"=>24.022976, "backend"=>0, "xml"=>0, :runtime=>27.686, :all=>30.974102} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000003d1e6a8 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.505195} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.6524490000000001, "db"=>9.431576, "backend"=>0, "xml"=>0, :runtime=>12.721, :all=>15.414195000000001} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006843ba8 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.763151} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.806417, "db"=>13.154376000000001, "backend"=>0, "xml"=>0, :runtime=>16.896, :all=>19.944366000000002} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000005ed1890 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.650125} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.760072, "db"=>82.758581, "backend"=>0, "xml"=>0, :runtime=>86.46, :all=>89.475269} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000005fbf450 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>2.6068990000000003} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 4ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.814247, "db"=>164.072989, "backend"=>0, "xml"=>0, :runtime=>167.772, :all=>170.750055} [[32mINFO [0m|#18472] Started GET "/" for 127.0.0.1 at 2013-01-31 13:52:59 +0000 [[32mINFO [0m|#18472] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#18472] Setting return_to: "/" [[0;37mDEBUG[0m|#18472] Authenticating with iChain mode: off [[32mINFO [0m|#18472] Anonymous request to / [[0;37mDEBUG[0m|#18472] --> direct_http url: #<URI::Generic:0x00000006a71bc8 URL:public/configuration.json> [[0;37mDEBUG[0m|#18472] http_do #1: method: get url: http://localhost:3203public/configuration.json [[0;37mDEBUG[0m|#18472] RT http://localhost:3203public/configuration.json {:all=>3.627604} [[32mINFO [0m|#18472] Completed 500 Internal Server Error in 5ms [[0;37mDEBUG[0m|#18472] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#18472] RT http://localhost:3203/test/test_end {"view"=>0.893493, "db"=>653.720642, "backend"=>0, "xml"=>0, :runtime=>657.768, :all=>699.598861} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/scheduler.done src/api/tmp/sessions src/api/tmp/sockets src/webui/log/test.log src/webui/tmp/cache src/webui/tmp/capybara src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 1 Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Recording test results -- To unsubscribe, e-mail: obs-tests+unsubscribe(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 5