[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1009
See <http://ci.opensuse.org/job/obs_master_testsuite_api/1009/changes> Changes: [mls] [backend] fix blocked calc for aggregates, improve aggregates with no set package filter ------------------------------------------ [...truncated 129141 lines...] [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x000000062eb930> took 1ms [[32mINFO [0m|#17615] Completed 200 OK in 74ms (Views: 1.1ms | ActiveRecord: 9.3ms | Backend: 14.9ms | XML: 0.4ms) [[32mINFO [0m|#17615] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-08-31 14:38:25 +0200 [[32mINFO [0m|#17615] Processing by SourceController#project_meta as XML [[32mINFO [0m|#17615] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#17615] Validate XML request: #<ActionDispatch::Request:0x00000006b58910> [[0;37mDEBUG[0m|#17615] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17615] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#17615] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#17615] USER found: king [[0;37mDEBUG[0m|#17615] User king initialised [[0;37mDEBUG[0m|#17615] [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|#17615] [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|#17615] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x00000006b588e8> took 2ms [[32mINFO [0m|#17615] Completed 200 OK in 10ms (Views: 0.6ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#17615] Started GET "/source/kde4" for 127.0.0.1 at 2012-08-31 14:38:25 +0200 [[32mINFO [0m|#17615] Processing by SourceController#index_project as XML [[32mINFO [0m|#17615] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#17615] Validate XML request: #<ActionDispatch::Request:0x00000006bb5110> [[0;37mDEBUG[0m|#17615] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17615] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#17615] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#17615] USER found: king [[0;37mDEBUG[0m|#17615] User king initialised [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND (db_packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x00000006bb50c0> took 0ms [[32mINFO [0m|#17615] Completed 200 OK in 10ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#17615] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 14:38:25 +0200 [[32mINFO [0m|#17615] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17615] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#17615] Validate XML request: #<ActionDispatch::Request:0x00000006c81828> [[0;37mDEBUG[0m|#17615] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17615] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#17615] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#17615] USER found: king [[0;37mDEBUG[0m|#17615] User king initialised [[0;37mDEBUG[0m|#17615] get_by_project_and_name {} [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x00000006c817d8> took 2ms [[32mINFO [0m|#17615] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#17615] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 14:38:25 +0200 [[32mINFO [0m|#17615] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17615] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[33mWARN [0m|#17615] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#17615] Validate XML request: #<ActionDispatch::Request:0x00000006d51190> [[0;37mDEBUG[0m|#17615] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#17615] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#17615] USER found: king [[0;37mDEBUG[0m|#17615] User king initialised [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] get_by_project_and_name {} [[0;37mDEBUG[0m|#17615] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mCACHE (0.0ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mFlag Load (0.4ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mFlag Load (0.3ms)[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|#17615] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#17615] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#17615] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#17615] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#17615] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#17615] [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 = 'kde4' AND pack.name = 'kdebase' [0m [[0;37mDEBUG[0m|#17615] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#17615] [1m[36mCACHE (0.0ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#17615] [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 = 2 LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `activity_index` = 85.3110061353901, `updated_at` = '2012-08-31 12:38:25', `update_counter` = 1 WHERE `db_packages`.`id` = 2[0m [[0;37mDEBUG[0m|#17615] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17615] [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` = 2 [[0;37mDEBUG[0m|#17615] [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` = 2[0m [[0;37mDEBUG[0m|#17615] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#17615] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#17620] 2012-08-31 14:38:25 [23178]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#17615] request took 0.014716768 [[0;37mDEBUG[0m|#17615] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x00000006d510a0> took 155ms [[32mINFO [0m|#17615] Completed 200 OK in 203ms (Views: 1.1ms | ActiveRecord: 4.8ms | Backend: 14.7ms | XML: 0.1ms) [[32mINFO [0m|#17615] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 14:38:26 +0200 [[32mINFO [0m|#17615] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17615] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#17615] Validate XML request: #<ActionDispatch::Request:0x0000000663dde0> [[0;37mDEBUG[0m|#17615] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17615] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#17615] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#17615] USER found: king [[0;37mDEBUG[0m|#17615] User king initialised [[0;37mDEBUG[0m|#17615] get_by_project_and_name {} [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x0000000663de08> took 2ms [[32mINFO [0m|#17615] Completed 200 OK in 13ms (Views: 0.5ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#17615] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 14:38:26 +0200 [[32mINFO [0m|#17615] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17615] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#17615] Validate XML request: #<ActionDispatch::Request:0x00000004d05ad0> [[0;37mDEBUG[0m|#17615] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17615] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#17615] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#17615] USER found: king [[0;37mDEBUG[0m|#17615] User king initialised [[0;37mDEBUG[0m|#17615] get_by_project_and_name {} [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x00000004d058f0> took 2ms [[32mINFO [0m|#17615] Completed 200 OK in 12ms (Views: 0.4ms | ActiveRecord: 1.3ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#17615] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 14:38:26 +0200 [[32mINFO [0m|#17615] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17615] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>Changed description</description>\n <devel project=\"home:Iggy\" package=\"TestPack\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <person userid=\"Iggy\" role=\"maintainer\"/>\n <person userid=\"Iggy\" role=\"bugowner\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n <group groupid=\"test_group\" role=\"reader\"/>\n <build>\n <enable/>\n </build>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[33mWARN [0m|#17615] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#17615] Validate XML request: #<ActionDispatch::Request:0x000000053f5980> [[0;37mDEBUG[0m|#17615] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#17615] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#17615] USER found: king [[0;37mDEBUG[0m|#17615] User king initialised [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] get_by_project_and_name {} [[0;37mDEBUG[0m|#17615] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [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|#17615] [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|#17615] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#17615] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#17615] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#17615] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#17615] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbPackage Load (0.3ms)[0m SELECT pack.* FROM db_packages pack LEFT OUTER JOIN db_projects pro ON pack.db_project_id = pro.id WHERE pro.name = 'kde4' AND pack.name = 'kdelibs' [[0;37mDEBUG[0m|#17615] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'686f6d653a49676779' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mDbPackage Load (0.4ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 502 AND `db_packages`.`name` = x'546573745061636b' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 502 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 3 AND bs_user_id = 267) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mSQL (0.2ms)[0m INSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 3) [[0;37mDEBUG[0m|#17615] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 4 AND bs_user_id = 267) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 4)[0m [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE (db_package_id = 1 AND role_id = 7 AND bs_group_id = 99) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_group_role_relationships` (`bs_group_id`, `db_package_id`, `role_id`) VALUES (99, 1, 7)[0m [[0;37mDEBUG[0m|#17615] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#17615] [1m[36mDbPackage Load (0.2ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`id` = 1 AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35m (0.2ms)[0m SELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1 [[0;37mDEBUG[0m|#17615] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, 1, NULL, 'build', 1, NULL, 'enable')[0m [[0;37mDEBUG[0m|#17615] [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 = 1 LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `description` = 'Changed description', `develpackage_id` = 10095, `activity_index` = 85.3110061353901, `updated_at` = '2012-08-31 12:38:26', `update_counter` = 1 WHERE `db_packages`.`id` = 1[0m [[0;37mDEBUG[0m|#17615] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17615] [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|#17615] [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` = 1[0m [[0;37mDEBUG[0m|#17615] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#17615] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#17620] 2012-08-31 14:38:26 [23179]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#17615] request took 0.019755033 [[0;37mDEBUG[0m|#17615] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x000000053f5908> took 1ms [[32mINFO [0m|#17615] Completed 200 OK in 82ms (Views: 1.1ms | ActiveRecord: 9.2ms | Backend: 19.8ms | XML: 0.4ms) [[32mINFO [0m|#17615] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 14:38:26 +0200 [[32mINFO [0m|#17615] Processing by SourceController#package_meta as XML [[32mINFO [0m|#17615] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#17615] Validate XML request: #<ActionDispatch::Request:0x000000068d8ca8> [[0;37mDEBUG[0m|#17615] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#17615] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#17615] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#17615] USER found: king [[0;37mDEBUG[0m|#17615] User king initialised [[0;37mDEBUG[0m|#17615] get_by_project_and_name {} [[0;37mDEBUG[0m|#17615] [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|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#17615] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#17615] Validate XML response: #<ActionDispatch::Response:0x000000068d8a78> took 2ms [[32mINFO [0m|#17615] Completed 200 OK in 13ms (Views: 0.6ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#17615] [1m[35m (178.2ms)[0m ROLLBACK [[0;37mDEBUG[0m|#17615] kill 17620 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/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/1010/changes> Changes: [mls] [backend] don't check all packages if an aggregate has no package filter ------------------------------------------ [...truncated 129148 lines...] [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x000000070f7cb8> took 1ms [[32mINFO [0m|#25359] Completed 200 OK in 216ms (Views: 1.1ms | ActiveRecord: 9.0ms | Backend: 16.5ms | XML: 0.3ms) [[32mINFO [0m|#25359] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-08-31 15:06:07 +0200 [[32mINFO [0m|#25359] Processing by SourceController#project_meta as XML [[32mINFO [0m|#25359] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#25359] Validate XML request: #<ActionDispatch::Request:0x00000005e81cc8> [[0;37mDEBUG[0m|#25359] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#25359] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#25359] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#25359] USER found: king [[0;37mDEBUG[0m|#25359] User king initialised [[0;37mDEBUG[0m|#25359] [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|#25359] [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|#25359] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x00000005e81c78> took 2ms [[32mINFO [0m|#25359] Completed 200 OK in 10ms (Views: 0.6ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#25359] Started GET "/source/kde4" for 127.0.0.1 at 2012-08-31 15:06:07 +0200 [[32mINFO [0m|#25359] Processing by SourceController#index_project as XML [[32mINFO [0m|#25359] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#25359] Validate XML request: #<ActionDispatch::Request:0x0000000626a718> [[0;37mDEBUG[0m|#25359] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#25359] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#25359] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#25359] USER found: king [[0;37mDEBUG[0m|#25359] User king initialised [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND (db_packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#25359] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x0000000626a6a0> took 0ms [[32mINFO [0m|#25359] Completed 200 OK in 10ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#25359] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 15:06:07 +0200 [[32mINFO [0m|#25359] Processing by SourceController#package_meta as XML [[32mINFO [0m|#25359] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#25359] Validate XML request: #<ActionDispatch::Request:0x000000065d7428> [[0;37mDEBUG[0m|#25359] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#25359] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#25359] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#25359] USER found: king [[0;37mDEBUG[0m|#25359] User king initialised [[0;37mDEBUG[0m|#25359] get_by_project_and_name {} [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x000000065d73b0> took 2ms [[32mINFO [0m|#25359] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#25359] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 15:06:07 +0200 [[32mINFO [0m|#25359] Processing by SourceController#package_meta as XML [[32mINFO [0m|#25359] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[33mWARN [0m|#25359] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#25359] Validate XML request: #<ActionDispatch::Request:0x0000000686bef0> [[0;37mDEBUG[0m|#25359] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#25359] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#25359] USER found: king [[0;37mDEBUG[0m|#25359] User king initialised [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] get_by_project_and_name {} [[0;37mDEBUG[0m|#25359] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mCACHE (0.0ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mFlag Load (0.4ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#25359] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#25359] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#25359] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#25359] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#25359] [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 = 'kde4' AND pack.name = 'kdebase' [0m [[0;37mDEBUG[0m|#25359] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#25359] [1m[36mCACHE (0.0ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#25359] [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 = 2 LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `activity_index` = 85.3110061353901, `updated_at` = '2012-08-31 13:06:07', `update_counter` = 1 WHERE `db_packages`.`id` = 2[0m [[0;37mDEBUG[0m|#25359] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#25359] [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|#25359] [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|#25359] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#25359] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#25364] 2012-08-31 15:06:07 [30886]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#25359] request took 0.014664438 [[0;37mDEBUG[0m|#25359] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x0000000686bec8> took 1ms [[32mINFO [0m|#25359] Completed 200 OK in 49ms (Views: 1.1ms | ActiveRecord: 4.6ms | Backend: 14.7ms | XML: 0.1ms) [[32mINFO [0m|#25359] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 15:06:07 +0200 [[32mINFO [0m|#25359] Processing by SourceController#package_meta as XML [[32mINFO [0m|#25359] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#25359] Validate XML request: #<ActionDispatch::Request:0x00000006af2ea8> [[0;37mDEBUG[0m|#25359] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#25359] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#25359] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#25359] USER found: king [[0;37mDEBUG[0m|#25359] User king initialised [[0;37mDEBUG[0m|#25359] get_by_project_and_name {} [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x000000065bdcf8> took 2ms [[32mINFO [0m|#25359] Completed 200 OK in 13ms (Views: 0.8ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#25359] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 15:06:07 +0200 [[32mINFO [0m|#25359] Processing by SourceController#package_meta as XML [[32mINFO [0m|#25359] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#25359] Validate XML request: #<ActionDispatch::Request:0x00000006bf7a38> [[0;37mDEBUG[0m|#25359] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#25359] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#25359] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#25359] USER found: king [[0;37mDEBUG[0m|#25359] User king initialised [[0;37mDEBUG[0m|#25359] get_by_project_and_name {} [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x00000006bf7a10> took 2ms [[32mINFO [0m|#25359] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#25359] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 15:06:07 +0200 [[32mINFO [0m|#25359] Processing by SourceController#package_meta as XML [[32mINFO [0m|#25359] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>Changed description</description>\n <devel project=\"home:Iggy\" package=\"TestPack\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <person userid=\"Iggy\" role=\"maintainer\"/>\n <person userid=\"Iggy\" role=\"bugowner\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n <group groupid=\"test_group\" role=\"reader\"/>\n <build>\n <enable/>\n </build>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[33mWARN [0m|#25359] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#25359] Validate XML request: #<ActionDispatch::Request:0x00000006ca4cb0> [[0;37mDEBUG[0m|#25359] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#25359] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#25359] USER found: king [[0;37mDEBUG[0m|#25359] User king initialised [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] get_by_project_and_name {} [[0;37mDEBUG[0m|#25359] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mFlag Load (0.4ms)[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|#25359] [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|#25359] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#25359] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#25359] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#25359] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#25359] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbPackage Load (0.3ms)[0m SELECT pack.* FROM db_packages pack LEFT OUTER JOIN db_projects pro ON pack.db_project_id = pro.id WHERE pro.name = 'kde4' AND pack.name = 'kdelibs' [[0;37mDEBUG[0m|#25359] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'686f6d653a49676779' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 502 AND `db_packages`.`name` = x'546573745061636b' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 502 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 3 AND bs_user_id = 267) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mSQL (0.2ms)[0m INSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 3) [[0;37mDEBUG[0m|#25359] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 4 AND bs_user_id = 267) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 4)[0m [[0;37mDEBUG[0m|#25359] [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|#25359] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE (db_package_id = 1 AND role_id = 7 AND bs_group_id = 99) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_group_role_relationships` (`bs_group_id`, `db_package_id`, `role_id`) VALUES (99, 1, 7)[0m [[0;37mDEBUG[0m|#25359] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#25359] [1m[36mDbPackage Load (0.2ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`id` = 1 AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35m (0.2ms)[0m SELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1 [[0;37mDEBUG[0m|#25359] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, 1, NULL, 'build', 1, NULL, 'enable')[0m [[0;37mDEBUG[0m|#25359] [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 = 1 LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `description` = 'Changed description', `develpackage_id` = 10095, `activity_index` = 85.3110061353901, `updated_at` = '2012-08-31 13:06:08', `update_counter` = 1 WHERE `db_packages`.`id` = 1[0m [[0;37mDEBUG[0m|#25359] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#25359] [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|#25359] [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` = 1[0m [[0;37mDEBUG[0m|#25359] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#25359] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#25364] 2012-08-31 15:06:08 [30887]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#25359] request took 0.018434607 [[0;37mDEBUG[0m|#25359] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x00000006ca4c60> took 1ms [[32mINFO [0m|#25359] Completed 200 OK in 80ms (Views: 1.1ms | ActiveRecord: 9.6ms | Backend: 18.4ms | XML: 0.4ms) [[32mINFO [0m|#25359] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 15:06:08 +0200 [[32mINFO [0m|#25359] Processing by SourceController#package_meta as XML [[32mINFO [0m|#25359] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#25359] Validate XML request: #<ActionDispatch::Request:0x000000071a0de0> [[0;37mDEBUG[0m|#25359] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#25359] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#25359] [1m[36mUser Load (3.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#25359] USER found: king [[0;37mDEBUG[0m|#25359] User king initialised [[0;37mDEBUG[0m|#25359] get_by_project_and_name {} [[0;37mDEBUG[0m|#25359] [1m[35mRole Load (3.1ms)[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|#25359] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#25359] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#25359] Validate XML response: #<ActionDispatch::Response:0x000000071a0db8> took 2ms [[32mINFO [0m|#25359] Completed 200 OK in 19ms (Views: 0.6ms | ActiveRecord: 7.1ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#25359] [1m[35m (325.9ms)[0m ROLLBACK [[0;37mDEBUG[0m|#25359] kill 25364 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/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/1011/changes> Changes: [mls] [backend] support project binary versions for remote projects, support package filtering ------------------------------------------ [...truncated 129135 lines...] [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x00000006c070c8> took 1ms [[32mINFO [0m|# 4918] Completed 200 OK in 78ms (Views: 1.2ms | ActiveRecord: 9.2ms | Backend: 18.2ms | XML: 0.3ms) [[32mINFO [0m|# 4918] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-08-31 17:24:30 +0200 [[32mINFO [0m|# 4918] Processing by SourceController#project_meta as XML [[32mINFO [0m|# 4918] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|# 4918] Validate XML request: #<ActionDispatch::Request:0x00000005f46be0> [[0;37mDEBUG[0m|# 4918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|# 4918] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|# 4918] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] USER found: king [[0;37mDEBUG[0m|# 4918] User king initialised [[0;37mDEBUG[0m|# 4918] [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|# 4918] [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|# 4918] [1m[35mDbProject Load (0.3ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x00000005f46848> took 2ms [[32mINFO [0m|# 4918] Completed 200 OK in 11ms (Views: 0.6ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|# 4918] Started GET "/source/kde4" for 127.0.0.1 at 2012-08-31 17:24:30 +0200 [[32mINFO [0m|# 4918] Processing by SourceController#index_project as XML [[32mINFO [0m|# 4918] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|# 4918] Validate XML request: #<ActionDispatch::Request:0x000000062fcc30> [[0;37mDEBUG[0m|# 4918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|# 4918] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|# 4918] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] USER found: king [[0;37mDEBUG[0m|# 4918] User king initialised [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND (db_packages.db_project_id not in (0)) [[0;37mDEBUG[0m|# 4918] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x000000062fcc08> took 0ms [[32mINFO [0m|# 4918] Completed 200 OK in 10ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|# 4918] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 17:24:30 +0200 [[32mINFO [0m|# 4918] Processing by SourceController#package_meta as XML [[32mINFO [0m|# 4918] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|# 4918] Validate XML request: #<ActionDispatch::Request:0x00000006778bb0> [[0;37mDEBUG[0m|# 4918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|# 4918] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|# 4918] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] USER found: king [[0;37mDEBUG[0m|# 4918] User king initialised [[0;37mDEBUG[0m|# 4918] get_by_project_and_name {} [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x00000006778b10> took 2ms [[32mINFO [0m|# 4918] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|# 4918] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 17:24:30 +0200 [[32mINFO [0m|# 4918] Processing by SourceController#package_meta as XML [[32mINFO [0m|# 4918] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[33mWARN [0m|# 4918] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|# 4918] Validate XML request: #<ActionDispatch::Request:0x00000006859070> [[0;37mDEBUG[0m|# 4918] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|# 4918] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|# 4918] USER found: king [[0;37mDEBUG[0m|# 4918] User king initialised [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] get_by_project_and_name {} [[0;37mDEBUG[0m|# 4918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mCACHE (0.0ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mFlag Load (0.4ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mFlag Load (0.3ms)[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|# 4918] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|# 4918] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|# 4918] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|# 4918] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|# 4918] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|# 4918] [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 = 'kde4' AND pack.name = 'kdebase' [0m [[0;37mDEBUG[0m|# 4918] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|# 4918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|# 4918] [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 = 2 LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `activity_index` = 85.3110061353901, `updated_at` = '2012-08-31 15:24:30', `update_counter` = 1 WHERE `db_packages`.`id` = 2[0m [[0;37mDEBUG[0m|# 4918] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|# 4918] [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` = 2 [[0;37mDEBUG[0m|# 4918] [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` = 2[0m [[0;37mDEBUG[0m|# 4918] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|# 4918] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|# 4923] 2012-08-31 17:24:30 [10338]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|# 4918] request took 0.015846357 [[0;37mDEBUG[0m|# 4918] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x00000006859048> took 1ms [[32mINFO [0m|# 4918] Completed 200 OK in 51ms (Views: 1.2ms | ActiveRecord: 4.8ms | Backend: 15.8ms | XML: 0.1ms) [[32mINFO [0m|# 4918] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 17:24:30 +0200 [[32mINFO [0m|# 4918] Processing by SourceController#package_meta as XML [[32mINFO [0m|# 4918] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|# 4918] Validate XML request: #<ActionDispatch::Request:0x000000068fe480> [[0;37mDEBUG[0m|# 4918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|# 4918] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|# 4918] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] USER found: king [[0;37mDEBUG[0m|# 4918] User king initialised [[0;37mDEBUG[0m|# 4918] get_by_project_and_name {} [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x000000068fe458> took 2ms [[32mINFO [0m|# 4918] Completed 200 OK in 13ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|# 4918] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 17:24:30 +0200 [[32mINFO [0m|# 4918] Processing by SourceController#package_meta as XML [[32mINFO [0m|# 4918] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|# 4918] Validate XML request: #<ActionDispatch::Request:0x00000006c39258> [[0;37mDEBUG[0m|# 4918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|# 4918] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|# 4918] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|# 4918] USER found: king [[0;37mDEBUG[0m|# 4918] User king initialised [[0;37mDEBUG[0m|# 4918] get_by_project_and_name {} [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x00000006c39230> took 2ms [[32mINFO [0m|# 4918] Completed 200 OK in 12ms (Views: 0.6ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|# 4918] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 17:24:30 +0200 [[32mINFO [0m|# 4918] Processing by SourceController#package_meta as XML [[32mINFO [0m|# 4918] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>Changed description</description>\n <devel project=\"home:Iggy\" package=\"TestPack\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <person userid=\"Iggy\" role=\"maintainer\"/>\n <person userid=\"Iggy\" role=\"bugowner\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n <group groupid=\"test_group\" role=\"reader\"/>\n <build>\n <enable/>\n </build>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[33mWARN [0m|# 4918] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|# 4918] Validate XML request: #<ActionDispatch::Request:0x00000006cd2610> [[0;37mDEBUG[0m|# 4918] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|# 4918] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] USER found: king [[0;37mDEBUG[0m|# 4918] User king initialised [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] get_by_project_and_name {} [[0;37mDEBUG[0m|# 4918] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[35mFlag Load (0.3ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|# 4918] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|# 4918] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|# 4918] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|# 4918] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbPackage Load (0.3ms)[0m SELECT pack.* FROM db_packages pack LEFT OUTER JOIN db_projects pro ON pack.db_project_id = pro.id WHERE pro.name = 'kde4' AND pack.name = 'kdelibs' [[0;37mDEBUG[0m|# 4918] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'686f6d653a49676779' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 502 AND `db_packages`.`name` = x'546573745061636b' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 502 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 3 AND bs_user_id = 267) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mSQL (0.2ms)[0m INSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 3) [[0;37mDEBUG[0m|# 4918] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 4 AND bs_user_id = 267) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 4)[0m [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE (db_package_id = 1 AND role_id = 7 AND bs_group_id = 99) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_group_role_relationships` (`bs_group_id`, `db_package_id`, `role_id`) VALUES (99, 1, 7)[0m [[0;37mDEBUG[0m|# 4918] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|# 4918] [1m[36mDbPackage Load (0.2ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`id` = 1 AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35m (0.2ms)[0m SELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1 [[0;37mDEBUG[0m|# 4918] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, 1, NULL, 'build', 1, NULL, 'enable')[0m [[0;37mDEBUG[0m|# 4918] [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 = 1 LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `description` = 'Changed description', `develpackage_id` = 10095, `activity_index` = 85.3110061353901, `updated_at` = '2012-08-31 15:24:30', `update_counter` = 1 WHERE `db_packages`.`id` = 1[0m [[0;37mDEBUG[0m|# 4918] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|# 4918] [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|# 4918] [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` = 1[0m [[0;37mDEBUG[0m|# 4918] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|# 4918] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|# 4923] 2012-08-31 17:24:30 [10339]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|# 4918] request took 0.017733113 [[0;37mDEBUG[0m|# 4918] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x00000006cd25c0> took 1ms [[32mINFO [0m|# 4918] Completed 200 OK in 80ms (Views: 1.2ms | ActiveRecord: 9.5ms | Backend: 17.7ms | XML: 0.4ms) [[32mINFO [0m|# 4918] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 17:24:30 +0200 [[32mINFO [0m|# 4918] Processing by SourceController#package_meta as XML [[32mINFO [0m|# 4918] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|# 4918] Validate XML request: #<ActionDispatch::Request:0x0000000727ed20> [[0;37mDEBUG[0m|# 4918] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|# 4918] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|# 4918] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] USER found: king [[0;37mDEBUG[0m|# 4918] User king initialised [[0;37mDEBUG[0m|# 4918] get_by_project_and_name {} [[0;37mDEBUG[0m|# 4918] [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|# 4918] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|# 4918] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|# 4918] Validate XML response: #<ActionDispatch::Response:0x0000000727ec58> took 149ms [[32mINFO [0m|# 4918] Completed 200 OK in 160ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|# 4918] [1m[35m (227.9ms)[0m ROLLBACK [[0;37mDEBUG[0m|# 4918] kill 4923 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/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/1012/changes> Changes: [mls] [backend] support project binary version query for remote projects in product building ------------------------------------------ [...truncated 129164 lines...] [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x0000000627e358> took 1ms [[32mINFO [0m|#12550] Completed 200 OK in 74ms (Views: 1.1ms | ActiveRecord: 9.8ms | Backend: 15.1ms | XML: 0.4ms) [[32mINFO [0m|#12550] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-08-31 17:58:16 +0200 [[32mINFO [0m|#12550] Processing by SourceController#project_meta as XML [[32mINFO [0m|#12550] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#12550] Validate XML request: #<ActionDispatch::Request:0x00000006b4e1b8> [[0;37mDEBUG[0m|#12550] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12550] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#12550] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12550] USER found: king [[0;37mDEBUG[0m|#12550] User king initialised [[0;37mDEBUG[0m|#12550] [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|#12550] [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|#12550] [1m[35mDbProject Load (0.3ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x00000006b4e140> took 2ms [[32mINFO [0m|#12550] Completed 200 OK in 10ms (Views: 0.6ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#12550] Started GET "/source/kde4" for 127.0.0.1 at 2012-08-31 17:58:16 +0200 [[32mINFO [0m|#12550] Processing by SourceController#index_project as XML [[32mINFO [0m|#12550] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#12550] Validate XML request: #<ActionDispatch::Request:0x00000006ba82d0> [[0;37mDEBUG[0m|#12550] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12550] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#12550] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12550] USER found: king [[0;37mDEBUG[0m|#12550] User king initialised [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND (db_packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#12550] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x00000006ba82a8> took 0ms [[32mINFO [0m|#12550] Completed 200 OK in 10ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#12550] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 17:58:16 +0200 [[32mINFO [0m|#12550] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12550] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#12550] Validate XML request: #<ActionDispatch::Request:0x00000006c5e350> [[0;37mDEBUG[0m|#12550] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12550] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#12550] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12550] USER found: king [[0;37mDEBUG[0m|#12550] User king initialised [[0;37mDEBUG[0m|#12550] get_by_project_and_name {} [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x00000006c5e328> took 2ms [[32mINFO [0m|#12550] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#12550] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 17:58:16 +0200 [[32mINFO [0m|#12550] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12550] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[33mWARN [0m|#12550] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#12550] Validate XML request: #<ActionDispatch::Request:0x00000006d2b580> [[0;37mDEBUG[0m|#12550] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#12550] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#12550] USER found: king [[0;37mDEBUG[0m|#12550] User king initialised [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[35mDbProject Load (0.3ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] get_by_project_and_name {} [[0;37mDEBUG[0m|#12550] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mCACHE (0.0ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mFlag Load (0.5ms)[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|#12550] [1m[36mFlag Load (0.3ms)[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|#12550] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#12550] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#12550] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#12550] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#12550] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#12550] [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 = 'kde4' AND pack.name = 'kdebase' [0m [[0;37mDEBUG[0m|#12550] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#12550] [1m[36mCACHE (0.0ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#12550] [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 = 2 LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `activity_index` = 85.3110061353901, `updated_at` = '2012-08-31 15:58:16', `update_counter` = 1 WHERE `db_packages`.`id` = 2[0m [[0;37mDEBUG[0m|#12550] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12550] [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` = 2 [[0;37mDEBUG[0m|#12550] [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` = 2[0m [[0;37mDEBUG[0m|#12550] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#12550] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#12555] 2012-08-31 17:58:16 [18221]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#12550] request took 0.014800539 [[0;37mDEBUG[0m|#12550] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x00000006d2b530> took 1ms [[32mINFO [0m|#12550] Completed 200 OK in 49ms (Views: 1.1ms | ActiveRecord: 4.9ms | Backend: 14.8ms | XML: 0.1ms) [[32mINFO [0m|#12550] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-08-31 17:58:16 +0200 [[32mINFO [0m|#12550] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12550] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#12550] Validate XML request: #<ActionDispatch::Request:0x0000000701cc30> [[0;37mDEBUG[0m|#12550] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12550] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#12550] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12550] USER found: king [[0;37mDEBUG[0m|#12550] User king initialised [[0;37mDEBUG[0m|#12550] get_by_project_and_name {} [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x0000000701cc08> took 154ms [[32mINFO [0m|#12550] Completed 200 OK in 165ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#12550] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 17:58:16 +0200 [[32mINFO [0m|#12550] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12550] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#12550] Validate XML request: #<ActionDispatch::Request:0x00000006b15228> [[0;37mDEBUG[0m|#12550] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12550] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#12550] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#12550] USER found: king [[0;37mDEBUG[0m|#12550] User king initialised [[0;37mDEBUG[0m|#12550] get_by_project_and_name {} [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x00000006b15688> took 2ms [[32mINFO [0m|#12550] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#12550] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 17:58:16 +0200 [[32mINFO [0m|#12550] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12550] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>Changed description</description>\n <devel project=\"home:Iggy\" package=\"TestPack\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <person userid=\"Iggy\" role=\"maintainer\"/>\n <person userid=\"Iggy\" role=\"bugowner\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n <group groupid=\"test_group\" role=\"reader\"/>\n <build>\n <enable/>\n </build>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[33mWARN [0m|#12550] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#12550] Validate XML request: #<ActionDispatch::Request:0x00000004dca010> [[0;37mDEBUG[0m|#12550] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#12550] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12550] USER found: king [[0;37mDEBUG[0m|#12550] User king initialised [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] get_by_project_and_name {} [[0;37mDEBUG[0m|#12550] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [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|#12550] [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|#12550] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#12550] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#12550] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#12550] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#12550] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbPackage Load (0.3ms)[0m SELECT pack.* FROM db_packages pack LEFT OUTER JOIN db_projects pro ON pack.db_project_id = pro.id WHERE pro.name = 'kde4' AND pack.name = 'kdelibs' [[0;37mDEBUG[0m|#12550] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'686f6d653a49676779' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mDbPackage Load (0.2ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 502 AND `db_packages`.`name` = x'546573745061636b' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 502 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 3 AND bs_user_id = 267) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mSQL (0.2ms)[0m INSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 3) [[0;37mDEBUG[0m|#12550] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 4 AND bs_user_id = 267) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 4)[0m [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE (db_package_id = 1 AND role_id = 7 AND bs_group_id = 99) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_group_role_relationships` (`bs_group_id`, `db_package_id`, `role_id`) VALUES (99, 1, 7)[0m [[0;37mDEBUG[0m|#12550] [1m[35mFlag Load (0.3ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#12550] [1m[36mDbPackage Load (0.2ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`id` = 1 AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35m (0.2ms)[0m SELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1 [[0;37mDEBUG[0m|#12550] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, 1, NULL, 'build', 1, NULL, 'enable')[0m [[0;37mDEBUG[0m|#12550] [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 = 1 LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `description` = 'Changed description', `develpackage_id` = 10095, `activity_index` = 85.3110061353901, `updated_at` = '2012-08-31 15:58:16', `update_counter` = 1 WHERE `db_packages`.`id` = 1[0m [[0;37mDEBUG[0m|#12550] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12550] [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|#12550] [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` = 1[0m [[0;37mDEBUG[0m|#12550] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#12550] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#12555] 2012-08-31 17:58:16 [18222]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#12550] request took 0.018686093 [[0;37mDEBUG[0m|#12550] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x00000004dc9fe8> took 1ms [[32mINFO [0m|#12550] Completed 200 OK in 80ms (Views: 1.1ms | ActiveRecord: 9.0ms | Backend: 18.7ms | XML: 0.3ms) [[32mINFO [0m|#12550] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-08-31 17:58:16 +0200 [[32mINFO [0m|#12550] Processing by SourceController#package_meta as XML [[32mINFO [0m|#12550] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#12550] Validate XML request: #<ActionDispatch::Request:0x00000006539610> [[0;37mDEBUG[0m|#12550] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#12550] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#12550] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#12550] USER found: king [[0;37mDEBUG[0m|#12550] User king initialised [[0;37mDEBUG[0m|#12550] get_by_project_and_name {} [[0;37mDEBUG[0m|#12550] [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|#12550] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#12550] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#12550] Validate XML response: #<ActionDispatch::Response:0x000000065395e8> took 2ms [[32mINFO [0m|#12550] Completed 200 OK in 13ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#12550] [1m[35m (277.2ms)[0m ROLLBACK [[0;37mDEBUG[0m|#12550] kill 12555 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/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/1013/changes> Changes: [Stephan Kulow] [dist] do not fail ci jobs if the gems are not yet uptodate ------------------------------------------ [...truncated 129204 lines...] [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x00000005f434b8> took 1ms [[32mINFO [0m|#10975] Completed 200 OK in 75ms (Views: 1.1ms | ActiveRecord: 9.6ms | Backend: 15.8ms | XML: 0.4ms) [[32mINFO [0m|#10975] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-09-03 08:41:43 +0200 [[32mINFO [0m|#10975] Processing by SourceController#project_meta as XML [[32mINFO [0m|#10975] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#10975] Validate XML request: #<ActionDispatch::Request:0x00000006a98d18> [[0;37mDEBUG[0m|#10975] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10975] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10975] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#10975] USER found: king [[0;37mDEBUG[0m|#10975] User king initialised [[0;37mDEBUG[0m|#10975] [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|#10975] [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|#10975] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x00000006a98cf0> took 2ms [[32mINFO [0m|#10975] Completed 200 OK in 10ms (Views: 0.6ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#10975] Started GET "/source/kde4" for 127.0.0.1 at 2012-09-03 08:41:43 +0200 [[32mINFO [0m|#10975] Processing by SourceController#index_project as XML [[32mINFO [0m|#10975] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#10975] Validate XML request: #<ActionDispatch::Request:0x00000006b809d8> [[0;37mDEBUG[0m|#10975] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10975] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10975] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#10975] USER found: king [[0;37mDEBUG[0m|#10975] User king initialised [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND (db_packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x00000006b809b0> took 0ms [[32mINFO [0m|#10975] Completed 200 OK in 10ms (Views: 0.5ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#10975] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-03 08:41:43 +0200 [[32mINFO [0m|#10975] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10975] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#10975] Validate XML request: #<ActionDispatch::Request:0x00000006c5c190> [[0;37mDEBUG[0m|#10975] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10975] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10975] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#10975] USER found: king [[0;37mDEBUG[0m|#10975] User king initialised [[0;37mDEBUG[0m|#10975] get_by_project_and_name {} [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x00000006c5c168> took 2ms [[32mINFO [0m|#10975] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#10975] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-03 08:41:43 +0200 [[32mINFO [0m|#10975] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10975] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[33mWARN [0m|#10975] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#10975] Validate XML request: #<ActionDispatch::Request:0x00000006d026f8> [[0;37mDEBUG[0m|#10975] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10975] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#10975] USER found: king [[0;37mDEBUG[0m|#10975] User king initialised [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] get_by_project_and_name {} [[0;37mDEBUG[0m|#10975] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mCACHE (0.0ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mFlag Load (0.4ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mFlag Load (0.3ms)[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|#10975] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#10975] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#10975] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#10975] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#10975] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#10975] [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 = 'kde4' AND pack.name = 'kdebase' [0m [[0;37mDEBUG[0m|#10975] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#10975] [1m[36mCACHE (0.0ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#10975] [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 = 2 LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `activity_index` = 85.3110061353901, `updated_at` = '2012-09-03 06:41:43', `update_counter` = 1 WHERE `db_packages`.`id` = 2[0m [[0;37mDEBUG[0m|#10975] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#10975] [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` = 2 [[0;37mDEBUG[0m|#10975] [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` = 2[0m [[0;37mDEBUG[0m|#10975] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#10975] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#10980] 2012-09-03 08:41:43 [16399]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#10975] request took 0.018745484 [[0;37mDEBUG[0m|#10975] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x00000006d026d0> took 1ms [[32mINFO [0m|#10975] Completed 200 OK in 53ms (Views: 1.1ms | ActiveRecord: 4.7ms | Backend: 18.7ms | XML: 0.1ms) [[32mINFO [0m|#10975] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-03 08:41:43 +0200 [[32mINFO [0m|#10975] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10975] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#10975] Validate XML request: #<ActionDispatch::Request:0x00000006fc4e18> [[0;37mDEBUG[0m|#10975] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10975] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10975] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#10975] USER found: king [[0;37mDEBUG[0m|#10975] User king initialised [[0;37mDEBUG[0m|#10975] get_by_project_and_name {} [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x00000006fc4df0> took 2ms [[32mINFO [0m|#10975] Completed 200 OK in 12ms (Views: 0.6ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#10975] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-03 08:41:43 +0200 [[32mINFO [0m|#10975] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10975] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#10975] Validate XML request: #<ActionDispatch::Request:0x000000071bbfa0> [[0;37mDEBUG[0m|#10975] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10975] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10975] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#10975] USER found: king [[0;37mDEBUG[0m|#10975] User king initialised [[0;37mDEBUG[0m|#10975] get_by_project_and_name {} [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mDbPackage Load (0.5ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x000000071bbf28> took 3ms [[32mINFO [0m|#10975] Completed 200 OK in 155ms (Views: 0.5ms | ActiveRecord: 1.8ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#10975] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-03 08:41:43 +0200 [[32mINFO [0m|#10975] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10975] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>Changed description</description>\n <devel project=\"home:Iggy\" package=\"TestPack\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <person userid=\"Iggy\" role=\"maintainer\"/>\n <person userid=\"Iggy\" role=\"bugowner\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n <group groupid=\"test_group\" role=\"reader\"/>\n <build>\n <enable/>\n </build>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[33mWARN [0m|#10975] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#10975] Validate XML request: #<ActionDispatch::Request:0x00000005940d90> [[0;37mDEBUG[0m|#10975] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10975] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#10975] USER found: king [[0;37mDEBUG[0m|#10975] User king initialised [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] get_by_project_and_name {} [[0;37mDEBUG[0m|#10975] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [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|#10975] [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|#10975] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#10975] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#10975] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#10975] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#10975] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbPackage Load (0.3ms)[0m SELECT pack.* FROM db_packages pack LEFT OUTER JOIN db_projects pro ON pack.db_project_id = pro.id WHERE pro.name = 'kde4' AND pack.name = 'kdelibs' [[0;37mDEBUG[0m|#10975] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'686f6d653a49676779' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mDbPackage Load (0.2ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 502 AND `db_packages`.`name` = x'546573745061636b' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 502 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 3 AND bs_user_id = 267) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mSQL (0.3ms)[0m INSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 3) [[0;37mDEBUG[0m|#10975] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 4 AND bs_user_id = 267) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 4)[0m [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE (db_package_id = 1 AND role_id = 7 AND bs_group_id = 99) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_group_role_relationships` (`bs_group_id`, `db_package_id`, `role_id`) VALUES (99, 1, 7)[0m [[0;37mDEBUG[0m|#10975] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#10975] [1m[36mDbPackage Load (0.2ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`id` = 1 AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35m (0.2ms)[0m SELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1 [[0;37mDEBUG[0m|#10975] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, 1, NULL, 'build', 1, NULL, 'enable')[0m [[0;37mDEBUG[0m|#10975] [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 = 1 LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `description` = 'Changed description', `develpackage_id` = 10095, `activity_index` = 85.3110061353901, `updated_at` = '2012-09-03 06:41:43', `update_counter` = 1 WHERE `db_packages`.`id` = 1[0m [[0;37mDEBUG[0m|#10975] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#10975] [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|#10975] [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` = 1[0m [[0;37mDEBUG[0m|#10975] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#10975] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#10980] 2012-09-03 08:41:43 [16400]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#10975] request took 0.020253426 [[0;37mDEBUG[0m|#10975] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x00000005941880> took 1ms [[32mINFO [0m|#10975] Completed 200 OK in 82ms (Views: 1.1ms | ActiveRecord: 9.2ms | Backend: 20.3ms | XML: 0.4ms) [[32mINFO [0m|#10975] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-03 08:41:43 +0200 [[32mINFO [0m|#10975] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10975] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#10975] Validate XML request: #<ActionDispatch::Request:0x000000060e69c8> [[0;37mDEBUG[0m|#10975] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10975] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10975] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#10975] USER found: king [[0;37mDEBUG[0m|#10975] User king initialised [[0;37mDEBUG[0m|#10975] get_by_project_and_name {} [[0;37mDEBUG[0m|#10975] [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|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10975] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10975] Validate XML response: #<ActionDispatch::Response:0x000000060e69a0> took 2ms [[32mINFO [0m|#10975] Completed 200 OK in 13ms (Views: 0.6ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#10975] [1m[35m (461.9ms)[0m ROLLBACK [[0;37mDEBUG[0m|#10975] kill 10980 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. egrep + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/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/1014/changes> Changes: [Stephan Kulow] [api] remove one left over from test::unit ------------------------------------------ [...truncated 129186 lines...] [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x0000000493e640> took 1ms [[32mINFO [0m|#31889] Completed 200 OK in 76ms (Views: 1.1ms | ActiveRecord: 8.9ms | Backend: 18.4ms | XML: 0.3ms) [[32mINFO [0m|#31889] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-09-03 11:00:32 +0200 [[32mINFO [0m|#31889] Processing by SourceController#project_meta as XML [[32mINFO [0m|#31889] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#31889] Validate XML request: #<ActionDispatch::Request:0x000000065e2bc0> [[0;37mDEBUG[0m|#31889] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#31889] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#31889] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#31889] USER found: king [[0;37mDEBUG[0m|#31889] User king initialised [[0;37mDEBUG[0m|#31889] [1m[35mProjectUserRoleRelationship Load (0.4ms)[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|#31889] [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|#31889] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x000000065e2b98> took 2ms [[32mINFO [0m|#31889] Completed 200 OK in 10ms (Views: 0.6ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#31889] Started GET "/source/kde4" for 127.0.0.1 at 2012-09-03 11:00:32 +0200 [[32mINFO [0m|#31889] Processing by SourceController#index_project as XML [[32mINFO [0m|#31889] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#31889] Validate XML request: #<ActionDispatch::Request:0x00000006590460> [[0;37mDEBUG[0m|#31889] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#31889] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#31889] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#31889] USER found: king [[0;37mDEBUG[0m|#31889] User king initialised [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND (db_packages.db_project_id not in (0)) [[0;37mDEBUG[0m|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x00000006590168> took 0ms [[32mINFO [0m|#31889] Completed 200 OK in 10ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#31889] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-03 11:00:32 +0200 [[32mINFO [0m|#31889] Processing by SourceController#package_meta as XML [[32mINFO [0m|#31889] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#31889] Validate XML request: #<ActionDispatch::Request:0x00000006a9d750> [[0;37mDEBUG[0m|#31889] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#31889] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#31889] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#31889] USER found: king [[0;37mDEBUG[0m|#31889] User king initialised [[0;37mDEBUG[0m|#31889] get_by_project_and_name {} [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x00000006a9d728> took 2ms [[32mINFO [0m|#31889] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#31889] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-03 11:00:32 +0200 [[32mINFO [0m|#31889] Processing by SourceController#package_meta as XML [[32mINFO [0m|#31889] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[33mWARN [0m|#31889] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#31889] Validate XML request: #<ActionDispatch::Request:0x000000068f8cd8> [[0;37mDEBUG[0m|#31889] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#31889] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#31889] USER found: king [[0;37mDEBUG[0m|#31889] User king initialised [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] get_by_project_and_name {} [[0;37mDEBUG[0m|#31889] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mCACHE (0.0ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mFlag Load (0.4ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#31889] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#31889] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#31889] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#31889] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#31889] [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 = 'kde4' AND pack.name = 'kdebase' [0m [[0;37mDEBUG[0m|#31889] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#31889] [1m[36mCACHE (0.0ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#31889] [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 = 2 LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `activity_index` = 85.3110061353901, `updated_at` = '2012-09-03 09:00:32', `update_counter` = 1 WHERE `db_packages`.`id` = 2[0m [[0;37mDEBUG[0m|#31889] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#31889] [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` = 2 [[0;37mDEBUG[0m|#31889] [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|#31889] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#31889] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#31894] 2012-09-03 11:00:32 [5134]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#31889] request took 0.018085226 [[0;37mDEBUG[0m|#31889] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x000000068f8cb0> took 1ms [[32mINFO [0m|#31889] Completed 200 OK in 52ms (Views: 1.1ms | ActiveRecord: 4.7ms | Backend: 18.1ms | XML: 0.1ms) [[32mINFO [0m|#31889] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-03 11:00:32 +0200 [[32mINFO [0m|#31889] Processing by SourceController#package_meta as XML [[32mINFO [0m|#31889] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#31889] Validate XML request: #<ActionDispatch::Request:0x00000006c886f0> [[0;37mDEBUG[0m|#31889] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#31889] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#31889] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#31889] USER found: king [[0;37mDEBUG[0m|#31889] User king initialised [[0;37mDEBUG[0m|#31889] get_by_project_and_name {} [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b646562617365' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x00000006c886a0> took 2ms [[32mINFO [0m|#31889] Completed 200 OK in 12ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#31889] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-03 11:00:32 +0200 [[32mINFO [0m|#31889] Processing by SourceController#package_meta as XML [[32mINFO [0m|#31889] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#31889] Validate XML request: #<ActionDispatch::Request:0x00000006d4b9c0> [[0;37mDEBUG[0m|#31889] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#31889] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#31889] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#31889] USER found: king [[0;37mDEBUG[0m|#31889] User king initialised [[0;37mDEBUG[0m|#31889] get_by_project_and_name {} [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x00000006d4b998> took 2ms [[32mINFO [0m|#31889] Completed 200 OK in 12ms (Views: 0.6ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#31889] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-03 11:00:32 +0200 [[32mINFO [0m|#31889] Processing by SourceController#package_meta as XML [[32mINFO [0m|#31889] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>Changed description</description>\n <devel project=\"home:Iggy\" package=\"TestPack\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <person userid=\"Iggy\" role=\"maintainer\"/>\n <person userid=\"Iggy\" role=\"bugowner\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n <group groupid=\"test_group\" role=\"reader\"/>\n <build>\n <enable/>\n </build>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[33mWARN [0m|#31889] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#31889] Validate XML request: #<ActionDispatch::Request:0x00000006e31588> [[0;37mDEBUG[0m|#31889] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#31889] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#31889] USER found: king [[0;37mDEBUG[0m|#31889] User king initialised [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] get_by_project_and_name {} [[0;37mDEBUG[0m|#31889] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mCACHE (0.0ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[35mFlag Load (0.3ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#31889] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#31889] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#31889] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#31889] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbPackage Load (0.3ms)[0m SELECT pack.* FROM db_packages pack LEFT OUTER JOIN db_projects pro ON pack.db_project_id = pro.id WHERE pro.name = 'kde4' AND pack.name = 'kdelibs' [[0;37mDEBUG[0m|#31889] [1m[36mCACHE (0.0ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'686f6d653a49676779' AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 502 AND `db_packages`.`name` = x'546573745061636b' AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbProject Load (0.2ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 502 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 3 AND bs_user_id = 267) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mSQL (0.2ms)[0m INSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 3) [[0;37mDEBUG[0m|#31889] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 4 AND bs_user_id = 267) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 4)[0m [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE (db_package_id = 1 AND role_id = 7 AND bs_group_id = 99) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mSQL (0.2ms)[0m [1mINSERT INTO `package_group_role_relationships` (`bs_group_id`, `db_package_id`, `role_id`) VALUES (99, 1, 7)[0m [[0;37mDEBUG[0m|#31889] [1m[35mFlag Load (7.0ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#31889] [1m[36mDbPackage Load (0.4ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`id` = 1 AND (db_packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35m (0.2ms)[0m SELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1 [[0;37mDEBUG[0m|#31889] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, 1, NULL, 'build', 1, NULL, 'enable')[0m [[0;37mDEBUG[0m|#31889] [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 = 1 LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36m (0.3ms)[0m [1mUPDATE `db_packages` SET `description` = 'Changed description', `develpackage_id` = 10095, `activity_index` = 85.3110061353901, `updated_at` = '2012-09-03 09:00:33', `update_counter` = 1 WHERE `db_packages`.`id` = 1[0m [[0;37mDEBUG[0m|#31889] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#31889] [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|#31889] [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` = 1[0m [[0;37mDEBUG[0m|#31889] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#31889] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#31894] 2012-09-03 11:00:33 [5135]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#31889] request took 0.016817855 [[0;37mDEBUG[0m|#31889] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x00000006e31560> took 1ms [[32mINFO [0m|#31889] Completed 200 OK in 221ms (Views: 1.1ms | ActiveRecord: 16.4ms | Backend: 16.8ms | XML: 0.4ms) [[32mINFO [0m|#31889] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-03 11:00:33 +0200 [[32mINFO [0m|#31889] Processing by SourceController#package_meta as XML [[32mINFO [0m|#31889] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#31889] Validate XML request: #<ActionDispatch::Request:0x000000047aaf18> [[0;37mDEBUG[0m|#31889] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#31889] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#31889] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#31889] USER found: king [[0;37mDEBUG[0m|#31889] User king initialised [[0;37mDEBUG[0m|#31889] get_by_project_and_name {} [[0;37mDEBUG[0m|#31889] [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|#31889] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'6b646534' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] [1m[35mDbPackage Load (0.3ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND `db_packages`.`name` = x'6b64656c696273' AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#31889] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#31889] Validate XML response: #<ActionDispatch::Response:0x000000047aacc0> took 2ms [[32mINFO [0m|#31889] Completed 200 OK in 14ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#31889] [1m[35m (231.0ms)[0m ROLLBACK [[0;37mDEBUG[0m|#31889] kill 31894 + 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/1015/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