New subject: [obs-tests] Jenkins build is unstable: obs_master_testsuite_api #763

29 Mar 2012

      See <http://ci.opensuse.org/job/obs_master_testsuite_api/762/changes>

Changes:

[Sascha Peilicke] Revert "[webui] Simplify markup while we're at it..."

[Sascha Peilicke] [webui] Provide a 'Packages' link in breadcrumbs...

[Sascha Peilicke] [webui] Set incidents for requests

[Sascha Peilicke] [webui] Autocompleting projects should be based on prefix search by

[Sascha Peilicke] [webui] Fix funny capitalization

[Stephan Kulow] [webui-testsuite] some work on user logic

[Sascha Peilicke] [webui] Don't show forms for unauthenticated users.

[adrian] [api] fix more borked active_rbac for use with :validate_params

[Sascha Peilicke] [api,webui] Fix git log in deploy notification mails...

[Stephan Kulow] [webui-testsuite] fix delete package tests

[Stephan Kulow] [dist] move setup of api and webui into common functions and move the

[adrian] [backend] no auto-expand when diffing against [o]rev=0

------------------------------------------
[...truncated 123553 lines...]
[[0;37mDEBUG[0m|#14933]   [4;36;1mDbProject Load (0.2ms)[0m   [0;1mSELECT * FROM `db_projects` WHERE (`db_projects`.`id` = 2) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mFlag Load (0.2ms)[0m   [0mSELECT * FROM `flags` WHERE (`flags`.db_package_id = 1) ORDER BY position[0m
[[0;37mDEBUG[0m|#14933] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#14933]   [4;36;1mFlag Load (0.2ms)[0m   [0;1mSELECT * FROM `flags` WHERE (`flags`.db_project_id = 2) [0m
[[0;37mDEBUG[0m|#14933] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#14933] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#14933]   [4;35;1mFlag Load (0.2ms)[0m   [0mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_package_id = 1) ORDER BY position LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mFlag Load (0.2ms)[0m   [0;1mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_project_id = 2) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mCACHE (0.0ms)[0m   [0mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 3 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mRole Load (0.2ms)[0m   [0;1mSELECT * FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles_users`.user_id = 3 ) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mGroup Load (0.2ms)[0m   [0mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 3 ) [0m
[[0;37mDEBUG[0m|#14933] running local permission check: user tom, package kdelibs, permission 'change_package'
[[0;37mDEBUG[0m|#14933]   [4;36;1mPackageUserRoleRelationship Load (0.2ms)[0m   [0;1mSELECT * FROM `package_user_role_relationships` WHERE (`package_user_role_relationships`.bs_user_id = 3 AND (db_package_id = 1)) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mPackageGroupRoleRelationship Load (0.2ms)[0m   [0mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` LEFT OUTER JOIN groups_users ug ON ug.group_id = bs_group_id WHERE (ug.user_id = 3 and db_package_id = 1) [0m
[[0;37mDEBUG[0m|#14933] permission not found, trying parent project 'kde4'
[[0;37mDEBUG[0m|#14933] running local permission check: user tom, project kde4, permission 'change_package'
[[0;37mDEBUG[0m|#14933]   [4;36;1mProjectUserRoleRelationship Load (0.2ms)[0m   [0;1mSELECT * FROM `project_user_role_relationships` WHERE (`project_user_role_relationships`.bs_user_id = 3 AND (db_project_id = 2 )) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mProjectGroupRoleRelationship Load (0.2ms)[0m   [0mSELECT `project_group_role_relationships`.* FROM `project_group_role_relationships` LEFT OUTER JOIN groups_users ug ON ug.group_id = bs_group_id WHERE (ug.user_id = 3 and db_project_id = 2) [0m
[[32mINFO [0m|#14933] errorcode 'change_package_no_permission' - no permission to change package
[[32mINFO [0m|#14933] Rendering status (403)
[[32mINFO [0m|#14933] Completed in 17ms (Backend: 0, View: 1, XML: 0, DB: 4) | 403 Forbidden [http://www.example.com/source/kde4/kdelibs/_wizard]

[[32mINFO [0m|#14933] Processing WizardController#package_wizard (for 127.0.0.1 at 2012-03-29 11:05:32) [GET]
[[32mINFO [0m|#14933]   Parameters: {"project"=>"kde4", "package"=>"kdelibs-not"}
[[0;37mDEBUG[0m|#14933] Validate XML request: #<ActionController::Request:0x7f69470adf90>
[[0;37mDEBUG[0m|#14933] no schema found, skipping validation for {"project"=>"kde4", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"request", "method"=>"get", "package"=>"kdelibs-not"}
[[0;37mDEBUG[0m|#14933] AUTH: ["Basic", "ZnJlZGxpYnM6Z2Vyw7ZsbGhlaW1lcg=="]
[[0;37mDEBUG[0m|#14933]   [4;36;1mUser Load (0.2ms)[0m   [0;1mSELECT * FROM `users` WHERE (login = 'fredlibs') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933] USER found: fredlibs
[[0;37mDEBUG[0m|#14933] User fredlibs initialised
[[0;37mDEBUG[0m|#14933]   [4;35;1mRole Load (0.2ms)[0m   [0mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 4 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mDbProject Load (0.2ms)[0m   [0;1mSELECT * FROM `db_projects` WHERE (name = BINARY 'kde4') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mDbPackage Load (0.2ms)[0m   [0mSELECT * FROM `db_packages` WHERE (name = BINARY 'kdelibs-not') AND (`db_packages`.db_project_id = 2) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mLinkedProject Load (0.2ms)[0m   [0;1mSELECT * FROM `linked_projects` WHERE (`linked_projects`.db_project_id = 2) ORDER BY position[0m

[[0;37mDEBUG[0m|#14933] DbPackage::UnknownObjectError (kde4/kdelibs-not):
  app/models/db_package.rb:163:in `get_by_project_and_name'
  app/controllers/wizard_controller.rb:9:in `package_wizard'
  test/test_helper.rb:24:in `process'
  test/functional/wizard_controller_test.rb:17:in `test_wizard'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:34:in `run'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `each'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `run'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:34:in `run'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `each'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `run'
  /usr/lib64/ruby/1.8/test/unit/ui/testrunnermediator.rb:46:in `run_suite'
  /usr/lib64/ruby/1.8/test/unit/ui/console/testrunner.rb:67:in `start_mediator'
  /usr/lib64/ruby/1.8/test/unit/ui/console/testrunner.rb:41:in `start'
  /usr/lib64/ruby/1.8/test/unit/ui/testrunnerutilities.rb:29:in `run'
  /usr/lib64/ruby/1.8/test/unit/autorunner.rb:216:in `run'
  /usr/lib64/ruby/1.8/test/unit/autorunner.rb:12:in `run'
  /usr/lib64/ruby/1.8/test/unit.rb:279
  rake (0.9.2) lib/rake/rake_test_loader.rb:5

[[31mERROR[0m|#14933] ReadAccessError: kde4/kdelibs-not
[[32mINFO [0m|#14933] errorcode 'unknown_package' - kde4/kdelibs-not
[[32mINFO [0m|#14933] Rendering status (404)

[[32mINFO [0m|#14933] Processing WizardController#package_wizard (for 127.0.0.1 at 2012-03-29 11:05:32) [GET]
[[32mINFO [0m|#14933]   Parameters: {"project"=>"kde4", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#14933] Validate XML request: #<ActionController::Request:0x7f694704dcf8>
[[0;37mDEBUG[0m|#14933] no schema found, skipping validation for {"project"=>"kde4", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"request", "method"=>"get", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#14933] AUTH: ["Basic", "ZnJlZGxpYnM6Z2Vyw7ZsbGhlaW1lcg=="]
[[0;37mDEBUG[0m|#14933]   [4;35;1mUser Load (0.2ms)[0m   [0mSELECT * FROM `users` WHERE (login = 'fredlibs') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933] USER found: fredlibs
[[0;37mDEBUG[0m|#14933] User fredlibs initialised
[[0;37mDEBUG[0m|#14933]   [4;36;1mRole Load (0.2ms)[0m   [0;1mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 4 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mDbProject Load (0.2ms)[0m   [0mSELECT * FROM `db_projects` WHERE (name = BINARY 'kde4') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mDbPackage Load (0.2ms)[0m   [0;1mSELECT * FROM `db_packages` WHERE (name = BINARY 'kdelibs') AND (`db_packages`.db_project_id = 2) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mDbProject Load (0.2ms)[0m   [0mSELECT * FROM `db_projects` WHERE (`db_projects`.`id` = 2) [0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mFlag Load (0.2ms)[0m   [0;1mSELECT * FROM `flags` WHERE (`flags`.db_package_id = 1) ORDER BY position[0m
[[0;37mDEBUG[0m|#14933] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#14933]   [4;35;1mFlag Load (0.2ms)[0m   [0mSELECT * FROM `flags` WHERE (`flags`.db_project_id = 2) [0m
[[0;37mDEBUG[0m|#14933] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#14933] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#14933]   [4;36;1mFlag Load (0.3ms)[0m   [0;1mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_package_id = 1) ORDER BY position LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mFlag Load (0.2ms)[0m   [0mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_project_id = 2) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mCACHE (0.0ms)[0m   [0;1mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 4 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mRole Load (0.2ms)[0m   [0mSELECT * FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles_users`.user_id = 4 ) [0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mGroup Load (0.2ms)[0m   [0;1mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 4 ) [0m
[[0;37mDEBUG[0m|#14933] running local permission check: user fredlibs, package kdelibs, permission 'change_package'
[[0;37mDEBUG[0m|#14933]   [4;35;1mPackageUserRoleRelationship Load (0.2ms)[0m   [0mSELECT * FROM `package_user_role_relationships` WHERE (`package_user_role_relationships`.bs_user_id = 4 AND (db_package_id = 1)) [0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mRole Load (0.2ms)[0m   [0;1mSELECT * FROM `roles` WHERE (`roles`.`id` = 3) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mPackageGroupRoleRelationship Load (0.2ms)[0m   [0mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` LEFT OUTER JOIN groups_users ug ON ug.group_id = bs_group_id WHERE (ug.user_id = 4 and db_package_id = 1) [0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mStaticPermission Load (0.2ms)[0m   [0;1mSELECT * FROM `static_permissions` INNER JOIN `roles_static_permissions` ON `static_permissions`.id = `roles_static_permissions`.static_permission_id WHERE (`roles_static_permissions`.role_id = 3 AND (title = 'change_package')) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933] permission granted
[[0;37mDEBUG[0m|#14933] package_wizard, {"project"=>"kde4", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"request", "method"=>"get", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#14933] --> direct_http url: #<URI::Generic:0x7f694701c9c8 URL:http://localhost:3200/source/kde4/kdelibs/wizard.xml>
[[0;37mDEBUG[0m|#14933] http_do #1: method: GET url: http://localhost:3200/source/kde4/kdelibs/wizard.xml
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:32 [20405]: GET /source/kde4/kdelibs/wizard.xml?
[[0;37mDEBUG[0m|#14933] Request took 0.010196 seconds
[[0;37mDEBUG[0m|#14933] questions: [{"sourcefile"=>{"label"=>"Source file to download", "type"=>"url"}}, {"generator"=>{"options"=>[{"-"=>{"label"=>"skip"}}, {"qmake"=>{"label"=>"qmake based code generator"}}], "label"=>"Generate build description", "type"=>"select"}}]
[[0;37mDEBUG[0m|#14933] --> direct_http url: #<URI::Generic:0x7f6947015268 URL:http://localhost:3200/source/kde4/kdelibs/wizard.xml>
[[0;37mDEBUG[0m|#14933] http_do #1: method: PUT url: http://localhost:3200/source/kde4/kdelibs/wizard.xml
[[0;37mDEBUG[0m|#14935] 127.0.0.1: 404 wizard.xml: no such file
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:32 [20406]: PUT /source/kde4/kdelibs/wizard.xml?
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:33 [20407]: POST /event?type=package&project=kde4&package=kdelibs
[[0;37mDEBUG[0m|#14933] Request took 2.450968 seconds
[[32mINFO [0m|#14933] Rendering wizard (200)
[[0;37mDEBUG[0m|#14933] no schema found, skipping validation for {"project"=>"kde4", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"response", "method"=>"get", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#14933] Validate XML response: #<ActionController::Response:0x7f694704da28> took 0ms
[[32mINFO [0m|#14933] Completed in 2480ms (Backend: 0, View: 2, XML: 0, DB: 3) | 200 OK [http://www.example.com/source/kde4/kdelibs/_wizard]

[[32mINFO [0m|#14933] Processing WizardController#package_wizard (for 127.0.0.1 at 2012-03-29 11:05:35) [GET]
[[32mINFO [0m|#14933]   Parameters: {"project"=>"HiddenProject", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] Validate XML request: #<ActionController::Request:0x7f6946ff9388>
[[0;37mDEBUG[0m|#14933] no schema found, skipping validation for {"project"=>"HiddenProject", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"request", "method"=>"get", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] AUTH: ["Basic", "ZnJlZGxpYnM6Z2Vyw7ZsbGhlaW1lcg=="]
[[0;37mDEBUG[0m|#14933]   [4;35;1mUser Load (0.4ms)[0m   [0mSELECT * FROM `users` WHERE (login = 'fredlibs') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933] USER found: fredlibs
[[0;37mDEBUG[0m|#14933] User fredlibs initialised
[[0;37mDEBUG[0m|#14933]   [4;36;1mRole Load (0.3ms)[0m   [0;1mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 4 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mDbProject Load (0.2ms)[0m   [0mSELECT * FROM `db_projects` WHERE (name = BINARY 'HiddenProject') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mSQL (0.2ms)[0m   [0;1mSELECT count(*) AS count_all FROM `project_group_role_relationships` WHERE (db_project_id = 3000) AND (`project_group_role_relationships`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mProjectGroupRoleRelationship Load (0.2ms)[0m   [0mSELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000)) [0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mUser Load (0.2ms)[0m   [0;1mSELECT * FROM `users` WHERE (`users`.`id` = 4) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mGroup Load (0.2ms)[0m   [0mSELECT * FROM `groups` WHERE (`groups`.`id` = 99) [0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mGroup Load (0.2ms)[0m   [0;1mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 4 AND (id = 99)) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mSQL (11.7ms)[0m   [0mSELECT count(DISTINCT `project_user_role_relationships`.id) AS count_first FROM `project_user_role_relationships` LEFT OUTER JOIN `roles` ON `roles`.id = `project_user_role_relationships`.role_id WHERE (db_project_id = 3000 and bs_user_id = 4) AND (`project_user_role_relationships`.db_project_id = 3000) [0m

[[0;37mDEBUG[0m|#14933] DbProject::UnknownObjectError (HiddenProject):
  app/models/db_project.rb:234:in `get_by_name'
  app/models/db_package.rb:147:in `get_by_project_and_name'
  app/controllers/wizard_controller.rb:9:in `package_wizard'
  test/test_helper.rb:24:in `process'
  test/functional/wizard_controller_test.rb:25:in `test_wizard'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:34:in `run'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `each'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `run'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:34:in `run'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `each'
  /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `run'
  /usr/lib64/ruby/1.8/test/unit/ui/testrunnermediator.rb:46:in `run_suite'
  /usr/lib64/ruby/1.8/test/unit/ui/console/testrunner.rb:67:in `start_mediator'
  /usr/lib64/ruby/1.8/test/unit/ui/console/testrunner.rb:41:in `start'
  /usr/lib64/ruby/1.8/test/unit/ui/testrunnerutilities.rb:29:in `run'
  /usr/lib64/ruby/1.8/test/unit/autorunner.rb:216:in `run'
  /usr/lib64/ruby/1.8/test/unit/autorunner.rb:12:in `run'
  /usr/lib64/ruby/1.8/test/unit.rb:279
  rake (0.9.2) lib/rake/rake_test_loader.rb:5

[[31mERROR[0m|#14933] ReadAccessError: HiddenProject
[[32mINFO [0m|#14933] errorcode 'unknown_project' - HiddenProject
[[32mINFO [0m|#14933] Rendering status (404)

[[32mINFO [0m|#14933] Processing WizardController#package_wizard (for 127.0.0.1 at 2012-03-29 11:05:35) [GET]
[[32mINFO [0m|#14933]   Parameters: {"project"=>"HiddenProject", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] Validate XML request: #<ActionController::Request:0x7f694741f520>
[[0;37mDEBUG[0m|#14933] no schema found, skipping validation for {"project"=>"HiddenProject", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"request", "method"=>"get", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] AUTH: ["Basic", "aGlkZGVuX2hvbWVyOmhvbWVy"]
[[0;37mDEBUG[0m|#14933]   [4;36;1mUser Load (0.3ms)[0m   [0;1mSELECT * FROM `users` WHERE (login = 'hidden_homer') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933] USER found: hidden_homer
[[0;37mDEBUG[0m|#14933] User hidden_homer initialised
[[0;37mDEBUG[0m|#14933]   [4;35;1mRole Load (0.3ms)[0m   [0mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 46 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mDbProject Load (0.2ms)[0m   [0;1mSELECT * FROM `db_projects` WHERE (name = BINARY 'HiddenProject') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mDbPackage Load (0.2ms)[0m   [0mSELECT * FROM `db_packages` WHERE (name = BINARY 'pack') AND (`db_packages`.db_project_id = 3000) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mDbProject Load (0.2ms)[0m   [0;1mSELECT * FROM `db_projects` WHERE (`db_projects`.`id` = 3000) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mFlag Load (0.2ms)[0m   [0mSELECT * FROM `flags` WHERE (`flags`.db_package_id = 11000) ORDER BY position[0m
[[0;37mDEBUG[0m|#14933] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#14933]   [4;36;1mFlag Load (0.2ms)[0m   [0;1mSELECT * FROM `flags` WHERE (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|#14933] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#14933] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#14933]   [4;35;1mFlag Load (0.2ms)[0m   [0mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_package_id = 11000) ORDER BY position LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mFlag Load (0.2ms)[0m   [0;1mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_project_id = 3000) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mCACHE (0.0ms)[0m   [0mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 46 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mRole Load (0.2ms)[0m   [0;1mSELECT * FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles_users`.user_id = 46 ) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mGroup Load (0.2ms)[0m   [0mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 ) [0m
[[0;37mDEBUG[0m|#14933] running local permission check: user hidden_homer, package pack, permission 'change_package'
[[0;37mDEBUG[0m|#14933]   [4;36;1mPackageUserRoleRelationship Load (0.2ms)[0m   [0;1mSELECT * FROM `package_user_role_relationships` WHERE (`package_user_role_relationships`.bs_user_id = 46 AND (db_package_id = 11000)) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mPackageGroupRoleRelationship Load (0.2ms)[0m   [0mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` LEFT OUTER JOIN groups_users ug ON ug.group_id = bs_group_id WHERE (ug.user_id = 46 and db_package_id = 11000) [0m
[[0;37mDEBUG[0m|#14933] permission not found, trying parent project 'HiddenProject'
[[0;37mDEBUG[0m|#14933] running local permission check: user hidden_homer, project HiddenProject, permission 'change_package'
[[0;37mDEBUG[0m|#14933]   [4;36;1mProjectUserRoleRelationship Load (0.2ms)[0m   [0;1mSELECT * FROM `project_user_role_relationships` WHERE (`project_user_role_relationships`.bs_user_id = 46 AND (db_project_id = 3000 )) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mRole Load (0.2ms)[0m   [0mSELECT * FROM `roles` WHERE (`roles`.`id` = 3) [0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mProjectGroupRoleRelationship Load (0.2ms)[0m   [0;1mSELECT `project_group_role_relationships`.* FROM `project_group_role_relationships` LEFT OUTER JOIN groups_users ug ON ug.group_id = bs_group_id WHERE (ug.user_id = 46 and db_project_id = 3000) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mStaticPermission Load (0.2ms)[0m   [0mSELECT * FROM `static_permissions` INNER JOIN `roles_static_permissions` ON `static_permissions`.id = `roles_static_permissions`.static_permission_id WHERE (`roles_static_permissions`.role_id = 3 AND (title = 'change_package')) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933] permission granted
[[0;37mDEBUG[0m|#14933] package_wizard, {"project"=>"HiddenProject", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"request", "method"=>"get", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] --> direct_http url: #<URI::Generic:0x7f69472fd458 URL:http://localhost:3200/source/HiddenProject/pack/wizard.xml>
[[0;37mDEBUG[0m|#14933] http_do #1: method: GET url: http://localhost:3200/source/HiddenProject/pack/wizard.xml
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:35 [20408]: GET /source/HiddenProject/pack/wizard.xml?
[[0;37mDEBUG[0m|#14933] Request took 0.010319 seconds
[[0;37mDEBUG[0m|#14933] questions: [{"sourcefile"=>{"label"=>"Source file to download", "type"=>"url"}}, {"generator"=>{"options"=>[{"-"=>{"label"=>"skip"}}, {"qmake"=>{"label"=>"qmake based code generator"}}], "label"=>"Generate build description", "type"=>"select"}}]
[[0;37mDEBUG[0m|#14933] --> direct_http url: #<URI::Generic:0x7f69472daf48 URL:http://localhost:3200/source/HiddenProject/pack/wizard.xml>
[[0;37mDEBUG[0m|#14933] http_do #1: method: PUT url: http://localhost:3200/source/HiddenProject/pack/wizard.xml
[[0;37mDEBUG[0m|#14935] 127.0.0.1: 404 wizard.xml: no such file
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:35 [20409]: PUT /source/HiddenProject/pack/wizard.xml?
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:35 [20410]: POST /event?type=package&project=HiddenProject&package=pack
[[0;37mDEBUG[0m|#14933] Request took 0.432412 seconds
[[32mINFO [0m|#14933] Rendering wizard (200)
[[0;37mDEBUG[0m|#14933] no schema found, skipping validation for {"project"=>"HiddenProject", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"response", "method"=>"get", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] Validate XML response: #<ActionController::Response:0x7f694741da90> took 0ms
[[32mINFO [0m|#14933] Completed in 465ms (Backend: 0, View: 2, XML: 0, DB: 4) | 200 OK [http://www.example.com/source/HiddenProject/pack/_wizard]

[[32mINFO [0m|#14933] Processing WizardController#package_wizard (for 127.0.0.1 at 2012-03-29 11:05:36) [GET]
[[32mINFO [0m|#14933]   Parameters: {"project"=>"HiddenProject", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] Validate XML request: #<ActionController::Request:0x7f694726df38>
[[0;37mDEBUG[0m|#14933] no schema found, skipping validation for {"project"=>"HiddenProject", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"request", "method"=>"get", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="]
[[0;37mDEBUG[0m|#14933]   [4;36;1mUser Load (0.3ms)[0m   [0;1mSELECT * FROM `users` WHERE (login = 'king') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933] USER found: king
[[0;37mDEBUG[0m|#14933] User king initialised
[[0;37mDEBUG[0m|#14933]   [4;35;1mRole Load (0.3ms)[0m   [0mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 2 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mDbProject Load (0.2ms)[0m   [0;1mSELECT * FROM `db_projects` WHERE (name = BINARY 'HiddenProject') LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mDbPackage Load (0.3ms)[0m   [0mSELECT * FROM `db_packages` WHERE (name = BINARY 'pack') AND (`db_packages`.db_project_id = 3000) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mDbProject Load (0.2ms)[0m   [0;1mSELECT * FROM `db_projects` WHERE (`db_projects`.`id` = 3000) [0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mFlag Load (0.3ms)[0m   [0mSELECT * FROM `flags` WHERE (`flags`.db_package_id = 11000) ORDER BY position[0m
[[0;37mDEBUG[0m|#14933] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#14933]   [4;36;1mFlag Load (0.2ms)[0m   [0;1mSELECT * FROM `flags` WHERE (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|#14933] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#14933] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#14933]   [4;35;1mFlag Load (0.3ms)[0m   [0mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_package_id = 11000) ORDER BY position LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;36;1mFlag Load (0.2ms)[0m   [0;1mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_project_id = 3000) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933]   [4;35;1mCACHE (0.0ms)[0m   [0mSELECT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`title` = 'Admin') AND (`roles_users`.user_id = 2 ) LIMIT 1[0m
[[0;37mDEBUG[0m|#14933] package_wizard, {"project"=>"HiddenProject", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"request", "method"=>"get", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] --> direct_http url: #<URI::Generic:0x7f69471f6e60 URL:http://localhost:3200/source/HiddenProject/pack/wizard.xml>
[[0;37mDEBUG[0m|#14933] http_do #1: method: GET url: http://localhost:3200/source/HiddenProject/pack/wizard.xml
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:36 [20411]: GET /source/HiddenProject/pack/wizard.xml?
[[0;37mDEBUG[0m|#14933] Request took 0.022302 seconds
[[0;37mDEBUG[0m|#14933] questions: [{"sourcefile"=>{"label"=>"Source file to download", "type"=>"url"}}, {"generator"=>{"options"=>[{"-"=>{"label"=>"skip"}}, {"qmake"=>{"label"=>"qmake based code generator"}}], "label"=>"Generate build description", "type"=>"select"}}]
[[0;37mDEBUG[0m|#14933] --> direct_http url: #<URI::Generic:0x7f69471d3f00 URL:http://localhost:3200/source/HiddenProject/pack/wizard.xml>
[[0;37mDEBUG[0m|#14933] http_do #1: method: PUT url: http://localhost:3200/source/HiddenProject/pack/wizard.xml
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:36 [20412]: PUT /source/HiddenProject/pack/wizard.xml?
[[0;37mDEBUG[0m|#14935] 2012-03-29 11:05:36 [20413]: POST /event?type=package&project=HiddenProject&package=pack
[[0;37mDEBUG[0m|#14933] Request took 0.569486 seconds
[[32mINFO [0m|#14933] Rendering wizard (200)
[[0;37mDEBUG[0m|#14933] no schema found, skipping validation for {"project"=>"HiddenProject", "controller"=>"wizard", "action"=>"package_wizard", "type"=>"response", "method"=>"get", "package"=>"pack"}
[[0;37mDEBUG[0m|#14933] Validate XML response: #<ActionController::Response:0x7f694726dc40> took 0ms
[[32mINFO [0m|#14933] Completed in 609ms (Backend: 0, View: 1, XML: 0, DB: 2) | 200 OK [http://www.example.com/source/HiddenProject/pack/_wizard]
[[0;37mDEBUG[0m|#14933]   [4;36;1mSQL (0.1ms)[0m   [0;1mROLLBACK[0m
[[0;37mDEBUG[0m|#14933] kill 14935
+ echo

+ 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/sessions src/api/tmp/sockets
rm: cannot remove directory `src/api/tmp/backend_data/trees/home:adrian': No such file or directory
Build step 'Execute shell' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results

-- 
To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org
To contact the owner, e-mail: obs-tests+owner@opensuse.org

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #762

admin＠opensuse.org

admin＠opensuse.org

admin＠opensuse.org

tags

participants (1)