[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1020
See <http://ci.opensuse.org/job/obs_master_testsuite_api/1020/changes> Changes: [adrian] [api] test fixed vrev handling after version update in backend [adrian] [api] fix project copy of locked projects. Test also that target contains files from _project package. [adrian] [api] avoid to write package meta data back to backend after reading it on project copy [mls] [backend] fix copyproject meta handling, also copy _project data [mls] [backend] die early if the signkey is invalid [mls] [backend] sigh, didn't think of the newline [mls] [backend] go further back if the service is in progress ------------------------------------------ [...truncated 124098 lines...] [[32mINFO [0m|#32340] Started PUT "/source/Apache/libapr-util1/_meta" for 127.0.0.1 at 2012-09-04 12:11:51 +0200 [[32mINFO [0m|#32340] Processing by SourceController#package_meta as XML [[32mINFO [0m|#32340] Parameters: {"<package name"=>"\"libapr-util1\" project=\"Apache\">\n <title>libapr-util1</title>\n <description>description</description>\n <url>http://some.url</url>\n</package>\n", "project"=>"Apache", "package"=>"libapr-util1"} [[33mWARN [0m|#32340] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#32340] Validate XML request: #<ActionDispatch::Request:0x00000006a72410> [[0;37mDEBUG[0m|#32340] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#32340] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#32340] USER found: king [[0;37mDEBUG[0m|#32340] User king initialised [[0;37mDEBUG[0m|#32340] [1m[36mRole Load (0.4ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'417061636865' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 226 AND `db_packages`.`name` = x'6c69626170722d7574696c31' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 226 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] get_by_project_and_name {} [[0;37mDEBUG[0m|#32340] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'417061636865' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mCACHE (0.0ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 226 AND `db_packages`.`name` = x'6c69626170722d7574696c31' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 226 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mFlag Load (0.4ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1356 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mFlag Load (0.3ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 226 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1356 ORDER BY position [[0;37mDEBUG[0m|#32340] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#32340] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 226[0m [[0;37mDEBUG[0m|#32340] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#32340] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#32340] [1m[36mDbPackage Load (0.3ms)[0m [1m SELECT pack.* FROM db_packages pack LEFT OUTER JOIN db_projects pro ON pack.db_project_id = pro.id WHERE pro.name = 'Apache' AND pack.name = 'libapr-util1' [0m [[0;37mDEBUG[0m|#32340] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 226 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 1356[0m [[0;37mDEBUG[0m|#32340] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 1356 [[0;37mDEBUG[0m|#32340] [1m[36mCACHE (0.0ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1356 ORDER BY position[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbPackage Load (0.3ms)[0m SELECT db_packages.*, ( @activity:=( db_packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), db_packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `db_packages` WHERE id = 1356 LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36m (0.5ms)[0m [1mUPDATE `db_packages` SET `activity_index` = 85.3110061353901, `updated_at` = '2012-09-04 10:11:51', `update_counter` = 1 WHERE `db_packages`.`id` = 1356[0m [[0;37mDEBUG[0m|#32340] ----------------- rendering package libapr-util1 ------------------------ [[0;37mDEBUG[0m|#32340] [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` = 1356 [[0;37mDEBUG[0m|#32340] [1m[36mPackageGroupRoleRelationship Load (0.3ms)[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` = 1356[0m [[0;37mDEBUG[0m|#32340] ----------------- end rendering package libapr-util1 ------------------------ [[0;37mDEBUG[0m|#32340] [backend] PUT: /source/Apache/libapr-util1/_meta?user=king [[0;37mDEBUG[0m|#32345] 2012-09-04 12:11:51 [5466]: PUT /source/Apache/libapr-util1/_meta?user=king [[0;37mDEBUG[0m|#32340] request took 0.020648437 [[0;37mDEBUG[0m|#32340] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#32340] Validate XML response: #<ActionDispatch::Response:0x00000006a723c0> took 0ms [[32mINFO [0m|#32340] Completed 200 OK in 56ms (Views: 1.1ms | ActiveRecord: 5.0ms | Backend: 20.6ms | XML: 0.1ms) [[32mINFO [0m|#32340] Started GET "/source/Apache/libapr-util1/_meta" for 127.0.0.1 at 2012-09-04 12:11:51 +0200 [[32mINFO [0m|#32340] Processing by SourceController#package_meta as XML [[32mINFO [0m|#32340] Parameters: {"project"=>"Apache", "package"=>"libapr-util1"} [[0;37mDEBUG[0m|#32340] Validate XML request: #<ActionDispatch::Request:0x00000006c73d68> [[0;37mDEBUG[0m|#32340] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"Apache", "package"=>"libapr-util1", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#32340] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#32340] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#32340] USER found: king [[0;37mDEBUG[0m|#32340] User king initialised [[0;37mDEBUG[0m|#32340] get_by_project_and_name {} [[0;37mDEBUG[0m|#32340] [1m[35mRole Load (0.5ms)[0m SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'417061636865' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 226 AND `db_packages`.`name` = x'6c69626170722d7574696c31' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 226 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] Validate XML response: #<ActionDispatch::Response:0x00000006c73cf0> took 2ms [[32mINFO [0m|#32340] Completed 200 OK in 12ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#32340] Started GET "/source/BaseDistro/_meta" for 127.0.0.1 at 2012-09-04 12:11:51 +0200 [[32mINFO [0m|#32340] Processing by SourceController#project_meta as XML [[32mINFO [0m|#32340] Parameters: {"project"=>"BaseDistro"} [[0;37mDEBUG[0m|#32340] Validate XML request: #<ActionDispatch::Request:0x00000006d0d5f8> [[0;37mDEBUG[0m|#32340] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"BaseDistro", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#32340] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#32340] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#32340] USER found: king [[0;37mDEBUG[0m|#32340] User king initialised [[0;37mDEBUG[0m|#32340] [1m[36mRole Load (0.4ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'4261736544697374726f' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] Validate XML response: #<ActionDispatch::Response:0x00000006d0d5a8> took 148ms [[32mINFO [0m|#32340] Completed 200 OK in 155ms (Views: 0.5ms | ActiveRecord: 1.0ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#32340] Started PUT "/source/BaseDistro/_meta" for 127.0.0.1 at 2012-09-04 12:11:51 +0200 [[32mINFO [0m|#32340] Processing by SourceController#project_meta as XML [[32mINFO [0m|#32340] Parameters: {"<project name"=>"\"BaseDistro\">\n <title>This is a base distro</title>\n <description>This could be openSUSE:11.2 project for example</description>\n <lock>\n <enable/>\n </lock>\n <repository name=\"BaseDistro_repo\">\n <releasetarget project=\"BaseDistro:Update\" repository=\"BaseDistroUpdateProject_repo\"/>\n <arch>i586</arch>\n </repository>\n</project>\n", "project"=>"BaseDistro"} [[33mWARN [0m|#32340] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#32340] Validate XML request: #<ActionDispatch::Request:0x00000006664738> [[0;37mDEBUG[0m|#32340] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#32340] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#32340] USER found: king [[0;37mDEBUG[0m|#32340] User king initialised [[0;37mDEBUG[0m|#32340] [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|#32340] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'4261736544697374726f' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] Checking permission for the put [[0;37mDEBUG[0m|#32340] [1m[35mFlag Load (0.3ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2042 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2042[0m [[0;37mDEBUG[0m|#32340] disabled_for access repo: arch: state:enable [[0;37mDEBUG[0m|#32340] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#32340] [1m[35mRepository Load (0.2ms)[0m SELECT `repositories`.* FROM `repositories` WHERE `repositories`.`db_project_id` = 2042 [[0;37mDEBUG[0m|#32340] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#32340] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'4261736544697374726f' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] ### name comparison: self.name -> BaseDistro, project_name -> BaseDistro [[0;37mDEBUG[0m|#32340] [1m[36mDbProjectType Load (0.2ms)[0m [1mSELECT `db_project_types`.* FROM `db_project_types` WHERE `db_project_types`.`name` = 'standard' LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35m (0.3ms)[0m UPDATE `db_projects` SET `updated_at` = '2012-09-04 10:11:51', `type_id` = 1 WHERE `db_projects`.`id` = 2042 [[0;37mDEBUG[0m|#32340] [1m[36mLinkedProject Load (0.2ms)[0m [1mSELECT `linked_projects`.* FROM `linked_projects` WHERE `linked_projects`.`db_project_id` = 2042 ORDER BY position[0m [[0;37mDEBUG[0m|#32340] [1m[35m (0.2ms)[0m UPDATE `db_projects` SET `updated_at` = '2012-09-04 10:11:51' WHERE `db_projects`.`id` = 2042 [[0;37mDEBUG[0m|#32340] [1m[36mProjectUserRoleRelationship Load (0.3ms)[0m [1mSELECT ur.db_project_id, ur.bs_user_id from flags f, project_user_role_relationships ur where f.flag = 'access' and ur.db_project_id = f.db_project_id[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`maintenance_project_id` = 2042 AND (db_projects.id not in (0)) [[0;37mDEBUG[0m|#32340] [1m[36mProjectUserRoleRelationship Load (0.2ms)[0m [1mSELECT `project_user_role_relationships`.* FROM `project_user_role_relationships` WHERE `project_user_role_relationships`.`db_project_id` = 2042[0m [[0;37mDEBUG[0m|#32340] [1m[35mProjectGroupRoleRelationship Load (0.2ms)[0m SELECT `project_group_role_relationships`.* FROM `project_group_role_relationships` WHERE `project_group_role_relationships`.`db_project_id` = 2042 [[0;37mDEBUG[0m|#32340] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2042[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2042 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36m (0.2ms)[0m [1mSELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_project_id` = 2042[0m [[0;37mDEBUG[0m|#32340] [1m[35mSQL (0.4ms)[0m INSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, NULL, 2042, 'lock', 1, NULL, 'enable') [[0;37mDEBUG[0m|#32340] [1m[36mDownload Load (0.2ms)[0m [1mSELECT `downloads`.* FROM `downloads` WHERE `downloads`.`db_project_id` = 2042[0m [[0;37mDEBUG[0m|#32340] [1m[35mRepository Load (0.3ms)[0m SELECT `repositories`.* FROM `repositories` WHERE `repositories`.`db_project_id` = 2042 [[0;37mDEBUG[0m|#32340] modifying repository 'BaseDistro_repo' [[0;37mDEBUG[0m|#32340] [1m[36mReleaseTarget Load (0.2ms)[0m [1mSELECT `release_targets`.* FROM `release_targets` WHERE `release_targets`.`repository_id` = 91[0m [[0;37mDEBUG[0m|#32340] [1m[35mSQL (0.2ms)[0m DELETE FROM `release_targets` WHERE `release_targets`.`id` = 913785863 [[0;37mDEBUG[0m|#32340] [1m[36mRepository Load (0.3ms)[0m [1mSELECT `repositories`.* FROM `repositories` INNER JOIN `db_projects` ON `db_projects`.`id` = `repositories`.`db_project_id` WHERE `repositories`.`remote_project_name` IS NULL AND `db_projects`.`name` = x'4261736544697374726f3a557064617465' AND `repositories`.`name` = 'BaseDistroUpdateProject_repo' LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mSQL (0.2ms)[0m INSERT INTO `release_targets` (`repository_id`, `target_repository_id`, `trigger`) VALUES (91, 95, NULL) [[0;37mDEBUG[0m|#32340] [1m[36mRepository Load (0.2ms)[0m [1mSELECT `repositories`.* FROM `repositories` WHERE `repositories`.`hostsystem_id` = 91 LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mPathElement Load (0.2ms)[0m SELECT `path_elements`.* FROM `path_elements` WHERE `path_elements`.`parent_id` = 91 ORDER BY position [[0;37mDEBUG[0m|#32340] [1m[36m (0.2ms)[0m [1mSELECT COUNT(*) FROM `repository_architectures` WHERE `repository_architectures`.`repository_id` = 91[0m [[0;37mDEBUG[0m|#32340] delete all of 91 [[0;37mDEBUG[0m|#32340] [1m[35mSQL (0.2ms)[0m DELETE FROM `repository_architectures` WHERE (repository_id = 91) [[0;37mDEBUG[0m|#32340] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `repository_architectures` (`architecture_id`, `position`, `repository_id`) VALUES (1, 1, 91)[0m [[0;37mDEBUG[0m|#32340] [1m[35m (0.2ms)[0m UPDATE `db_projects` SET `updated_at` = '2012-09-04 10:11:51' WHERE `db_projects`.`id` = 2042 [[0;37mDEBUG[0m|#32340] ----------------- rendering project BaseDistro ------------------------ [[0;37mDEBUG[0m|#32340] [1m[36mDbProjectType Load (0.2ms)[0m [1mSELECT `db_project_types`.* FROM `db_project_types` WHERE `db_project_types`.`id` = 1 LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mCACHE (0.0ms)[0m SELECT `db_project_types`.* FROM `db_project_types` WHERE `db_project_types`.`id` = 1 LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mProjectUserRoleRelationship Load (0.3ms)[0m [1mSELECT users.login as login, roles.title as roletitle FROM `project_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `project_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `project_user_role_relationships`.`bs_user_id` WHERE `project_user_role_relationships`.`db_project_id` = 2042[0m [[0;37mDEBUG[0m|#32340] [1m[35mProjectGroupRoleRelationship Load (0.3ms)[0m SELECT groups.title as grouptitle, roles.title as roletitle FROM `project_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `project_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `project_group_role_relationships`.`bs_group_id` WHERE `project_group_role_relationships`.`db_project_id` = 2042 [[0;37mDEBUG[0m|#32340] [1m[36mRepository Load (0.3ms)[0m [1mSELECT `repositories`.* FROM `repositories` WHERE `repositories`.`db_project_id` = 2042 AND `repositories`.`remote_project_name` IS NULL[0m [[0;37mDEBUG[0m|#32340] [1m[35mReleaseTarget Load (0.2ms)[0m SELECT `release_targets`.* FROM `release_targets` WHERE `release_targets`.`repository_id` = 91 [[0;37mDEBUG[0m|#32340] [1m[36mRepository Load (0.2ms)[0m [1mSELECT `repositories`.* FROM `repositories` WHERE `repositories`.`id` = 95 LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mProjectUserRoleRelationship Load (0.3ms)[0m SELECT ur.db_project_id, ur.bs_user_id from flags f, project_user_role_relationships ur where f.flag = 'access' and ur.db_project_id = f.db_project_id [[0;37mDEBUG[0m|#32340] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2043 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mRepository Load (0.2ms)[0m SELECT `repositories`.* FROM `repositories` WHERE `repositories`.`hostsystem_id` = 91 LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mPathElement Load (0.2ms)[0m [1mSELECT `path_elements`.* FROM `path_elements` WHERE `path_elements`.`parent_id` = 91 ORDER BY position[0m [[0;37mDEBUG[0m|#32340] [1m[35mRepositoryArchitecture Load (0.3ms)[0m SELECT architectures.name FROM `repository_architectures` INNER JOIN `architectures` ON `architectures`.`id` = `repository_architectures`.`architecture_id` WHERE `repository_architectures`.`repository_id` = 91 ORDER BY position [[0;37mDEBUG[0m|#32340] ----------------- end rendering project BaseDistro ------------------------ [[0;37mDEBUG[0m|#32340] [backend] PUT: /source/BaseDistro/_meta?user=king [[0;37mDEBUG[0m|#32345] 2012-09-04 12:11:51 [5467]: PUT /source/BaseDistro/_meta?user=king [[0;37mDEBUG[0m|#32340] request took 0.016125039 [[0;37mDEBUG[0m|#32340] [1m[36m (0.2ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#32340] Validate XML response: #<ActionDispatch::Response:0x00000006664850> took 1ms [[32mINFO [0m|#32340] Completed 200 OK in 77ms (Views: 1.2ms | ActiveRecord: 10.1ms | Backend: 16.1ms | XML: 0.5ms) [[32mINFO [0m|#32340] Started GET "/source/BaseDistro/_meta" for 127.0.0.1 at 2012-09-04 12:11:51 +0200 [[32mINFO [0m|#32340] Processing by SourceController#project_meta as XML [[32mINFO [0m|#32340] Parameters: {"project"=>"BaseDistro"} [[0;37mDEBUG[0m|#32340] Validate XML request: #<ActionDispatch::Request:0x00000005eabc08> [[0;37mDEBUG[0m|#32340] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"BaseDistro", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#32340] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#32340] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#32340] USER found: king [[0;37mDEBUG[0m|#32340] User king initialised [[0;37mDEBUG[0m|#32340] [1m[36mRole Load (0.4ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbProject Load (0.3ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'4261736544697374726f' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] Validate XML response: #<ActionDispatch::Response:0x00000005eabbe0> took 2ms [[32mINFO [0m|#32340] Completed 200 OK in 9ms (Views: 0.6ms | ActiveRecord: 1.1ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#32340] Started GET "/source/BaseDistro" for 127.0.0.1 at 2012-09-04 12:11:51 +0200 [[32mINFO [0m|#32340] Processing by SourceController#index_project as XML [[32mINFO [0m|#32340] Parameters: {"project"=>"BaseDistro"} [[0;37mDEBUG[0m|#32340] Validate XML request: #<ActionDispatch::Request:0x00000005f6f9c8> [[0;37mDEBUG[0m|#32340] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"BaseDistro", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#32340] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#32340] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#32340] USER found: king [[0;37mDEBUG[0m|#32340] User king initialised [[0;37mDEBUG[0m|#32340] [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|#32340] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'4261736544697374726f' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2042 AND (db_packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#32340] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2042 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2042 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2042 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"BaseDistro", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#32340] Validate XML response: #<ActionDispatch::Response:0x00000005f6f9a0> took 0ms [[32mINFO [0m|#32340] Completed 200 OK in 11ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#32340] Started GET "/source/BaseDistro/pack1/_meta" for 127.0.0.1 at 2012-09-04 12:11:51 +0200 [[32mINFO [0m|#32340] Processing by SourceController#package_meta as XML [[32mINFO [0m|#32340] Parameters: {"project"=>"BaseDistro", "package"=>"pack1"} [[0;37mDEBUG[0m|#32340] Validate XML request: #<ActionDispatch::Request:0x000000060d5e70> [[0;37mDEBUG[0m|#32340] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"BaseDistro", "package"=>"pack1", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#32340] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#32340] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#32340] USER found: king [[0;37mDEBUG[0m|#32340] User king initialised [[0;37mDEBUG[0m|#32340] get_by_project_and_name {} [[0;37mDEBUG[0m|#32340] [1m[36mRole Load (0.4ms)[0m [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 2 AND `roles`.`title` = 'Admin' LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'4261736544697374726f' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2042 AND `db_packages`.`name` = x'7061636b31' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2042 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] Validate XML response: #<ActionDispatch::Response:0x000000060d5b00> took 2ms [[32mINFO [0m|#32340] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#32340] Started PUT "/source/BaseDistro/pack1/_meta" for 127.0.0.1 at 2012-09-04 12:11:51 +0200 [[32mINFO [0m|#32340] Processing by SourceController#package_meta as XML [[32mINFO [0m|#32340] Parameters: {"<package name"=>"\"pack1\" project=\"BaseDistro\">\n <title>For maintenance tests</title>\n <description></description>\n <useforbuild>\n <disable/>\n </useforbuild>\n <url></url>\n</package>\n", "project"=>"BaseDistro", "package"=>"pack1"} [[33mWARN [0m|#32340] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#32340] Validate XML request: #<ActionDispatch::Request:0x000000065e05c8> [[0;37mDEBUG[0m|#32340] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#32340] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#32340] USER found: king [[0;37mDEBUG[0m|#32340] User king initialised [[0;37mDEBUG[0m|#32340] [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|#32340] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'4261736544697374726f' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2042 AND `db_packages`.`name` = x'7061636b31' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2042 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] get_by_project_and_name {} [[0;37mDEBUG[0m|#32340] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'4261736544697374726f' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2042 AND `db_packages`.`name` = x'7061636b31' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2042 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#32340] [1m[36mFlag Load (0.3ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 10096 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1[0m [[0;37mDEBUG[0m|#32340] [1m[35mFlag Load (0.3ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2042 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1 [[32mINFO [0m|#32340] errorcode 'change_package_no_permission' - no permission to modify package 'BaseDistro'/pack1 [[32mINFO [0m|#32340] Completed 403 Forbidden in 20ms (Views: 1.0ms | ActiveRecord: 2.1ms | Backend: 0.0ms | XML: 0.1ms) [[0;37mDEBUG[0m|#32340] [1m[36m (306.2ms)[0m [1mROLLBACK[0m [[0;37mDEBUG[0m|#32340] kill 32345 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. egrep jenkins ..c.. sh jenkins ..c.. sh + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/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@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
See <http://ci.opensuse.org/job/obs_master_testsuite_api/1021/changes> -- To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
participants (1)
-
admin＠opensuse.org