See http://ci.opensuse.org/job/obs_testsuite_api_master/298/changes
Changes:
[adrian] [api] incomplete work issue tracking per db_package object
[adrian] [backend] silly, but silent
[adrian] [api] simple issue unit test
------------------------------------------
[...truncated 115958 lines...]
[[0;37mDEBUG[0m|# 378] Validate XML response: #ActionController::Response:0x7f8875783188
[[0;37mDEBUG[0m|# 378] no schema found, skipping validation for methodgetactionpackage_wizardprojectkde4typeresponsepackagekdelibscontrollerwizard
[[32mINFO [0m|# 378] Completed in 81ms (View: 3, DB: 4) | 200 OK [http://www.example.com/source/kde4/kdelibs/_wizard]
[[32mINFO [0m|# 378] Processing WizardController#package_wizard (for 127.0.0.1 at 2011-12-09 17:38:53) [GET]
[[32mINFO [0m|# 378] Parameters: {"project"=>"HiddenProject", "package"=>"pack"}
[[0;37mDEBUG[0m|# 378] Validate XML request: #ActionController::Request:0x7f8875657818
[[0;37mDEBUG[0m|# 378] no schema found, skipping validation for methodgetactionpackage_wizardprojectHiddenProjecttyperequestpackagepackcontrollerwizard
[[0;37mDEBUG[0m|# 378] AUTH: ["Basic", "ZnJlZGxpYnM6Z2Vyw7ZsbGhlaW1lcg=="]
[[0;37mDEBUG[0m|# 378] [4;36;1mUser Load (0.4ms)[0m [0;1mSELECT * FROM `users` WHERE (login = 'fredlibs') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] USER found: fredlibs
[[0;37mDEBUG[0m|# 378] User fredlibs initialised
[[0;37mDEBUG[0m|# 378] [4;35;1mDbProject Load (0.2ms)[0m [0mSELECT * FROM `db_projects` WHERE (name = BINARY 'home:fredlibs') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;36;1mRole Load (0.2ms)[0m [0;1mSELECT * FROM `roles` WHERE (`roles`.`title` = 'Admin') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [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`.`id` = 1) AND (`roles_users`.user_id = 4 ) LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;36;1mDbProject Load (0.2ms)[0m [0;1mSELECT * FROM `db_projects` WHERE (name = BINARY 'HiddenProject') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;35;1mSQL (0.3ms)[0m [0mSELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [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|# 378] [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|# 378] [4;36;1mUser Load (0.2ms)[0m [0;1mSELECT * FROM `users` WHERE (`users`.`id` = 4) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mGroup Load (0.2ms)[0m [0mSELECT * FROM `groups` WHERE (`groups`.`id` = 99) [0m
[[0;37mDEBUG[0m|# 378] [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|# 378] [4;35;1mSQL (0.3ms)[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|# 378] DbProject::UnknownObjectError (HiddenProject):
app/models/db_project.rb:232:in `get_by_name'
app/models/db_package.rb:149:in `get_by_project_and_name'
app/controllers/wizard_controller.rb:9:in `package_wizard'
test/test_helper.rb:21:in `get'
/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:278
/usr/bin/rcov:19
[[31mERROR[0m|# 378] ReadAccessError: HiddenProject
[[32mINFO [0m|# 378] Rendering status
[[32mINFO [0m|# 378] errorcode 'unknown_project' - HiddenProject
[[32mINFO [0m|# 378] Rendering status (404)
[[32mINFO [0m|# 378] Processing WizardController#package_wizard (for 127.0.0.1 at 2011-12-09 17:38:53) [GET]
[[32mINFO [0m|# 378] Parameters: {"project"=>"HiddenProject", "package"=>"pack"}
[[0;37mDEBUG[0m|# 378] Validate XML request: #ActionController::Request:0x7f88755979c8
[[0;37mDEBUG[0m|# 378] no schema found, skipping validation for methodgetactionpackage_wizardprojectHiddenProjecttyperequestpackagepackcontrollerwizard
[[0;37mDEBUG[0m|# 378] AUTH: ["Basic", "aGlkZGVuX2hvbWVyOmhvbWVy"]
[[0;37mDEBUG[0m|# 378] [4;36;1mUser Load (0.4ms)[0m [0;1mSELECT * FROM `users` WHERE (login = 'hidden_homer') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] USER found: hidden_homer
[[0;37mDEBUG[0m|# 378] User hidden_homer initialised
[[0;37mDEBUG[0m|# 378] [4;35;1mDbProject Load (0.2ms)[0m [0mSELECT * FROM `db_projects` WHERE (name = BINARY 'home:hidden_homer') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;36;1mRole Load (0.2ms)[0m [0;1mSELECT * FROM `roles` WHERE (title = BINARY 'maintainer') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] adding user: hidden_homer, maintainer
[[0;37mDEBUG[0m|# 378] [4;35;1mSQL (0.1ms)[0m [0mSAVEPOINT active_record_1[0m
[[0;37mDEBUG[0m|# 378] [4;36;1mProjectUserRoleRelationship Load (0.2ms)[0m [0;1mSELECT * FROM `project_user_role_relationships` WHERE (db_project_id = NULL AND role_id = 3 AND bs_user_id = 46) LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;35;1mDbProject Create (0.3ms)[0m [0mINSERT INTO `db_projects` (`name`, `created_at`, `title`, `maintenance_project_id`, `updated_at`, `remoteurl`, `type_id`, `description`, `develproject_id`, `remoteproject`) VALUES(x'686f6d653a68696464656e5f686f6d6572', '2011-12-09 17:38:53', 'hidden_homer\'s Home Project', NULL, '2011-12-09 17:38:53', NULL, NULL, 'Please add a suitable description and don\'t forget to add some repositories you want to build your packages against (just click on \'Repositories\' above). Have fun!', NULL, NULL)[0m
[[0;37mDEBUG[0m|# 378] [4;36;1mProjectUserRoleRelationship Create (0.2ms)[0m [0;1mINSERT INTO `project_user_role_relationships` (`db_project_id`, `role_id`, `bs_user_id`) VALUES(5258, 3, 46)[0m
[[0;37mDEBUG[0m|# 378] [4;35;1mSQL (0.1ms)[0m [0mRELEASE SAVEPOINT active_record_1[0m
[[0;37mDEBUG[0m|# 378] [4;36;1mSQL (0.1ms)[0m [0;1mSAVEPOINT active_record_1[0m
[[0;37mDEBUG[0m|# 378] [4;35;1mSQL (0.1ms)[0m [0mRELEASE SAVEPOINT active_record_1[0m
[[0;37mDEBUG[0m|# 378] ----------------- rendering project home:hidden_homer ------------------------
[[0;37mDEBUG[0m|# 378] [4;36;1mLinkedProject Load (0.3ms)[0m [0;1mSELECT * FROM `linked_projects` WHERE (`linked_projects`.db_project_id = 5258) ORDER BY position[0m
[[0;37mDEBUG[0m|# 378] [4;35;1mUser Load (0.3ms)[0m [0mSELECT bu.*, r.title AS role_name FROM `users` bu, project_user_role_relationships purr, roles r WHERE (bu.id = purr.bs_user_id AND purr.db_project_id = 5258 AND r.id = purr.role_id) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mGroup Load (8.4ms)[0m [0;1mSELECT bg.*, r.title AS role_name FROM `groups` bg, project_group_role_relationships pgrr, roles r WHERE (bg.id = pgrr.bs_group_id AND pgrr.db_project_id = 5258 AND r.id = pgrr.role_id) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mDownload Load (0.3ms)[0m [0mSELECT * FROM `downloads` WHERE (`downloads`.db_project_id = 5258) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mFlag Load (0.3ms)[0m [0;1mSELECT * FROM `flags` WHERE (`flags`.db_project_id = 5258) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mRepository Load (0.2ms)[0m [0mSELECT * FROM `repositories` WHERE (`repositories`.db_project_id = 5258 AND (ISNULL(remote_project_name))) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mDbProject Load (0.4ms)[0m [0;1mSELECT `db_projects`.* FROM `db_projects` LEFT JOIN flags f ON f.db_project_id = db_projects.id AND (ISNULL(f.flag) OR flag = 'access') LEFT OUTER JOIN project_user_role_relationships ur ON ur.db_project_id = db_projects.id LEFT OUTER JOIN users u ON ur.bs_user_id = u.id WHERE (`db_projects`.maintenance_project_id = 5258) GROUP BY db_projects.id[0m
[[0;37mDEBUG[0m|# 378] ----------------- end rendering project home:hidden_homer ------------------------
[[0;37mDEBUG[0m|# 378] [backend] PUT: /source/home:hidden_homer/_meta?user=hidden_homer
[[0;37mDEBUG[0m|# 380] 2011-12-09 17:38:53 [4504]: PUT /source/home:hidden_homer/_meta?user=hidden_homer
[[0;37mDEBUG[0m|# 378] [4;35;1mRole Load (0.3ms)[0m [0mSELECT * FROM `roles` WHERE (`roles`.`title` = 'Admin') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [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`.`id` = 1) AND (`roles_users`.user_id = 46 ) LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;35;1mDbProject Load (0.3ms)[0m [0mSELECT * FROM `db_projects` WHERE (name = BINARY 'HiddenProject') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;36;1mSQL (0.3ms)[0m [0;1mSELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mSQL (0.2ms)[0m [0mSELECT 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|# 378] [4;36;1mProjectGroupRoleRelationship Load (0.2ms)[0m [0;1mSELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000)) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mUser Load (0.2ms)[0m [0mSELECT * FROM `users` WHERE (`users`.`id` = 46) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mGroup Load (0.2ms)[0m [0;1mSELECT * FROM `groups` WHERE (`groups`.`id` = 99) [0m
[[0;37mDEBUG[0m|# 378] [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 AND (id = 99)) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mSQL (0.3ms)[0m [0;1mSELECT 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 = 46) AND (`project_user_role_relationships`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[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|# 378] [4;35;1mCACHE (0.0ms)[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|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `users` WHERE (`users`.`id` = 46) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT * FROM `groups` WHERE (`groups`.`id` = 99) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99)) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[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 = 46) AND (`project_user_role_relationships`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mDbPackage Load (0.3ms)[0m [0;1mSELECT * FROM `db_packages` WHERE (name = BINARY 'pack') AND (`db_packages`.db_project_id = 3000) LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;35;1mDbProject Load (0.2ms)[0m [0mSELECT * FROM `db_projects` WHERE (`db_projects`.`id` = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT 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|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000)) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT * FROM `users` WHERE (`users`.`id` = 46) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `groups` WHERE (`groups`.`id` = 99) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99)) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT 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 = 46) AND (`project_user_role_relationships`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[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|# 378] [4;35;1mCACHE (0.0ms)[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|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `users` WHERE (`users`.`id` = 46) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT * FROM `groups` WHERE (`groups`.`id` = 99) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99)) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[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 = 46) AND (`project_user_role_relationships`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT 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|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000)) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT * FROM `users` WHERE (`users`.`id` = 46) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `groups` WHERE (`groups`.`id` = 99) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99)) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT 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 = 46) AND (`project_user_role_relationships`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[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|# 378] [4;35;1mCACHE (0.0ms)[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|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `users` WHERE (`users`.`id` = 46) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT * FROM `groups` WHERE (`groups`.`id` = 99) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99)) [0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[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 = 46) AND (`project_user_role_relationships`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] [4;36;1mFlag Load (0.5ms)[0m [0;1mSELECT * FROM `flags` WHERE (`flags`.db_package_id = 11000) ORDER BY position[0m
[[0;37mDEBUG[0m|# 378] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|# 378] [4;35;1mFlag Load (0.2ms)[0m [0mSELECT * FROM `flags` WHERE (`flags`.db_project_id = 3000) [0m
[[0;37mDEBUG[0m|# 378] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|# 378] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|# 378] [4;36;1mFlag Load (0.5ms)[0m [0;1mSELECT * 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|# 378] [4;35;1mFlag Load (0.2ms)[0m [0mSELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_project_id = 3000) LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;36;1mCACHE (0.0ms)[0m [0;1mSELECT * FROM `roles` WHERE (`roles`.`title` = 'Admin') LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [4;35;1mCACHE (0.0ms)[0m [0mSELECT `roles`.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`id` = 1) AND (`roles_users`.user_id = 46 ) LIMIT 1[0m
[[0;37mDEBUG[0m|# 378] [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|# 378] [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|# 378] running local permission check: user hidden_homer, package pack, permission 'change_package'
[[0;37mDEBUG[0m|# 378] [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|# 378] [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|# 378] permission not found, trying parent project 'HiddenProject'
[[0;37mDEBUG[0m|# 378] running local permission check: user hidden_homer, project HiddenProject, permission 'change_package'
[[0;37mDEBUG[0m|# 378] [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|# 378] [4;35;1mRole Load (0.2ms)[0m [0mSELECT * FROM `roles` WHERE (`roles`.`id` = 3) [0m
[[0;37mDEBUG[0m|# 378] [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|# 378] [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|# 378] permission granted
[[0;37mDEBUG[0m|# 378] package_wizard, {"method"=>"get", "action"=>"package_wizard", "project"=>"HiddenProject", "type"=>"request", "package"=>"pack", "controller"=>"wizard"}
[[0;37mDEBUG[0m|# 378] --> direct_http url: #