[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1046
See <http://ci.opensuse.org/job/obs_master_testsuite_api/1046/changes> Changes: [adrian] [api] document current misrendering of requests in search collections. Just one review element gets rendered. ------------------------------------------ [...truncated 132157 lines...] [[0;37mDEBUG[0m|#10678] Validate XML response: #<ActionDispatch::Response:0x00000006418b78> took 1ms [[32mINFO [0m|#10678] Completed 200 OK in 79ms (Views: 1.2ms | ActiveRecord: 9.7ms | Backend: 18.4ms | XML: 0.4ms) [[32mINFO [0m|#10678] Started GET "/source/kde4/_meta" for 127.0.0.1 at 2012-09-13 18:52:54 +0200 [[32mINFO [0m|#10678] Processing by SourceController#project_meta as XML [[32mINFO [0m|#10678] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#10678] Validate XML request: #<ActionDispatch::Request:0x00000006cd1b70> [[0;37mDEBUG[0m|#10678] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10678] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10678] [1m[35mUser Load (0.5ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#10678] USER found: king [[0;37mDEBUG[0m|#10678] User king initialised [[0;37mDEBUG[0m|#10678] [1m[36mProjectUserRoleRelationship Load (0.4ms)[0m [1mSELECT ur.db_project_id, ur.bs_user_id from flags f, project_user_role_relationships ur where f.flag = 'access' and ur.db_project_id = f.db_project_id[0m [[0;37mDEBUG[0m|#10678] [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|#10678] [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|#10678] Validate XML response: #<ActionDispatch::Response:0x00000006cd1b48> took 2ms [[32mINFO [0m|#10678] Completed 200 OK in 11ms (Views: 0.6ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#10678] Started GET "/source/kde4" for 127.0.0.1 at 2012-09-13 18:52:54 +0200 [[32mINFO [0m|#10678] Processing by SourceController#index_project as XML [[32mINFO [0m|#10678] Parameters: {"project"=>"kde4"} [[0;37mDEBUG[0m|#10678] Validate XML request: #<ActionDispatch::Request:0x00000006d17760> [[0;37mDEBUG[0m|#10678] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10678] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10678] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#10678] USER found: king [[0;37mDEBUG[0m|#10678] User king initialised [[0;37mDEBUG[0m|#10678] [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|#10678] [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|#10678] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 2 AND (db_packages.db_project_id not in (0))[0m [[0;37mDEBUG[0m|#10678] [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|#10678] [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|#10678] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"} [[0;37mDEBUG[0m|#10678] Validate XML response: #<ActionDispatch::Response:0x00000006d17738> took 0ms [[32mINFO [0m|#10678] Completed 200 OK in 11ms (Views: 0.5ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#10678] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-13 18:52:54 +0200 [[32mINFO [0m|#10678] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10678] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#10678] Validate XML request: #<ActionDispatch::Request:0x00000006dd3f28> [[0;37mDEBUG[0m|#10678] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10678] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10678] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#10678] USER found: king [[0;37mDEBUG[0m|#10678] User king initialised [[0;37mDEBUG[0m|#10678] get_by_project_and_name {} [[0;37mDEBUG[0m|#10678] [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|#10678] [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|#10678] [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|#10678] [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|#10678] Validate XML response: #<ActionDispatch::Response:0x00000006dd3ed8> took 2ms [[32mINFO [0m|#10678] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.5ms | Backend: 0.0ms | XML: 0.3ms) [[32mINFO [0m|#10678] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-13 18:52:54 +0200 [[32mINFO [0m|#10678] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10678] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[33mWARN [0m|#10678] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#10678] Validate XML request: #<ActionDispatch::Request:0x00000006ea7a08> [[0;37mDEBUG[0m|#10678] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10678] [1m[36mUser Load (0.5ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#10678] USER found: king [[0;37mDEBUG[0m|#10678] User king initialised [[0;37mDEBUG[0m|#10678] [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|#10678] [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|#10678] [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|#10678] [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|#10678] get_by_project_and_name {} [[0;37mDEBUG[0m|#10678] [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|#10678] [1m[36mCACHE (0.0ms)[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|#10678] [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|#10678] [1m[36mFlag Load (0.4ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1[0m [[0;37mDEBUG[0m|#10678] [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|#10678] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#10678] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#10678] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#10678] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#10678] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#10678] [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 = 'kdebase' [[0;37mDEBUG[0m|#10678] [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|#10678] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#10678] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#10678] [1m[35mCACHE (0.0ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position [[0;37mDEBUG[0m|#10678] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT 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[0m [[0;37mDEBUG[0m|#10678] [1m[35m (0.3ms)[0m UPDATE `db_packages` SET `activity_index` = 85.3110061353901, `updated_at` = '2012-09-13 16:52:54', `update_counter` = 1 WHERE `db_packages`.`id` = 2 [[0;37mDEBUG[0m|#10678] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#10678] [1m[36mPackageUserRoleRelationship Load (0.3ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#10678] [1m[35mPackageGroupRoleRelationship Load (0.2ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 2 [[0;37mDEBUG[0m|#10678] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#10678] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#10683] 2012-09-13 18:52:54 [16070]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#10678] request took 0.01561658 [[0;37mDEBUG[0m|#10678] [1m[36m (0.2ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#10678] Validate XML response: #<ActionDispatch::Response:0x00000006ea79b8> took 1ms [[32mINFO [0m|#10678] Completed 200 OK in 50ms (Views: 1.3ms | ActiveRecord: 4.8ms | Backend: 15.6ms | XML: 0.1ms) [[32mINFO [0m|#10678] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-09-13 18:52:54 +0200 [[32mINFO [0m|#10678] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10678] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#10678] Validate XML request: #<ActionDispatch::Request:0x000000071b6410> [[0;37mDEBUG[0m|#10678] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10678] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10678] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#10678] USER found: king [[0;37mDEBUG[0m|#10678] User king initialised [[0;37mDEBUG[0m|#10678] get_by_project_and_name {} [[0;37mDEBUG[0m|#10678] [1m[36mRole Load (0.5ms)[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|#10678] [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|#10678] [1m[36mDbPackage Load (4.0ms)[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|#10678] [1m[35mDbProject Load (0.3ms)[0m SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 2 AND (db_projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10678] Validate XML response: #<ActionDispatch::Response:0x000000071b63e8> took 3ms [[32mINFO [0m|#10678] Completed 200 OK in 175ms (Views: 0.7ms | ActiveRecord: 5.5ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#10678] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-13 18:52:55 +0200 [[32mINFO [0m|#10678] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10678] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#10678] Validate XML request: #<ActionDispatch::Request:0x0000000516fd28> [[0;37mDEBUG[0m|#10678] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10678] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10678] [1m[36mUser Load (0.3ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#10678] USER found: king [[0;37mDEBUG[0m|#10678] User king initialised [[0;37mDEBUG[0m|#10678] get_by_project_and_name {} [[0;37mDEBUG[0m|#10678] [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|#10678] [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|#10678] [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|#10678] [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|#10678] Validate XML response: #<ActionDispatch::Response:0x00000005165878> took 2ms [[32mINFO [0m|#10678] Completed 200 OK in 12ms (Views: 0.5ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#10678] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-13 18:52:55 +0200 [[32mINFO [0m|#10678] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10678] 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|#10678] WARNING: Can't verify CSRF token authenticity [[0;37mDEBUG[0m|#10678] Validate XML request: #<ActionDispatch::Request:0x00000004e1e480> [[0;37mDEBUG[0m|#10678] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10678] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#10678] USER found: king [[0;37mDEBUG[0m|#10678] User king initialised [[0;37mDEBUG[0m|#10678] [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|#10678] [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|#10678] [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|#10678] [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|#10678] get_by_project_and_name {} [[0;37mDEBUG[0m|#10678] [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|#10678] [1m[35mCACHE (0.0ms)[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|#10678] [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|#10678] [1m[35mFlag Load (0.3ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 AND `flags`.`flag` = 'lock' AND `flags`.`status` = 'enable' ORDER BY position LIMIT 1 [[0;37mDEBUG[0m|#10678] [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|#10678] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#10678] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#10678] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#10678] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#10678] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#10678] [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 = 'kdelibs' [0m [[0;37mDEBUG[0m|#10678] [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|#10678] [1m[36mDbProject Load (0.3ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`name` = x'686f6d653a49676779' AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mDbPackage Load (0.2ms)[0m SELECT `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 [[0;37mDEBUG[0m|#10678] [1m[36mDbProject Load (0.2ms)[0m [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 502 AND (db_projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE `package_user_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#10678] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#10678] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mRole Load (0.2ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1 [[0;37mDEBUG[0m|#10678] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `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 [[0;37mDEBUG[0m|#10678] [1m[36mSQL (0.3ms)[0m [1mINSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 3)[0m [[0;37mDEBUG[0m|#10678] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1 [[0;37mDEBUG[0m|#10678] [1m[36mPackageUserRoleRelationship Load (0.2ms)[0m [1mSELECT `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[0m [[0;37mDEBUG[0m|#10678] [1m[35mSQL (0.2ms)[0m INSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 4) [[0;37mDEBUG[0m|#10678] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mGroup Load (0.2ms)[0m SELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1 [[0;37mDEBUG[0m|#10678] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mGroup Load (0.2ms)[0m SELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1 [[0;37mDEBUG[0m|#10678] [1m[36mPackageGroupRoleRelationship Load (0.2ms)[0m [1mSELECT `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[0m [[0;37mDEBUG[0m|#10678] [1m[35mSQL (0.2ms)[0m INSERT INTO `package_group_role_relationships` (`bs_group_id`, `db_package_id`, `role_id`) VALUES (99, 1, 7) [[0;37mDEBUG[0m|#10678] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m [[0;37mDEBUG[0m|#10678] [1m[35mDbPackage Load (0.2ms)[0m SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`id` = 1 AND (db_packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#10678] [1m[36m (0.2ms)[0m [1mSELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mSQL (0.2ms)[0m INSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, 1, NULL, 'build', 1, NULL, 'enable') [[0;37mDEBUG[0m|#10678] [1m[36mDbPackage Load (0.3ms)[0m [1mSELECT 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[0m [[0;37mDEBUG[0m|#10678] [1m[35m (0.3ms)[0m UPDATE `db_packages` SET `description` = 'Changed description', `develpackage_id` = 10095, `activity_index` = 85.3110061353901, `updated_at` = '2012-09-13 16:52:55', `update_counter` = 1 WHERE `db_packages`.`id` = 1 [[0;37mDEBUG[0m|#10678] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#10678] [1m[36mPackageUserRoleRelationship Load (0.3ms)[0m [1mSELECT users.login as login, roles.title AS role_name FROM `package_user_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_user_role_relationships`.`role_id` INNER JOIN `users` ON `users`.`id` = `package_user_role_relationships`.`bs_user_id` WHERE `package_user_role_relationships`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#10678] [1m[35mPackageGroupRoleRelationship Load (0.3ms)[0m SELECT groups.title as title, roles.title as role_name FROM `package_group_role_relationships` INNER JOIN `roles` ON `roles`.`id` = `package_group_role_relationships`.`role_id` INNER JOIN `groups` ON `groups`.`id` = `package_group_role_relationships`.`bs_group_id` WHERE `package_group_role_relationships`.`db_package_id` = 1 [[0;37mDEBUG[0m|#10678] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#10678] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#10683] 2012-09-13 18:52:55 [16071]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#10678] request took 0.02192959 [[0;37mDEBUG[0m|#10678] [1m[36m (0.3ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#10678] Validate XML response: #<ActionDispatch::Response:0x00000004e1e408> took 1ms [[32mINFO [0m|#10678] Completed 200 OK in 86ms (Views: 1.2ms | ActiveRecord: 9.4ms | Backend: 21.9ms | XML: 0.3ms) [[32mINFO [0m|#10678] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-09-13 18:52:55 +0200 [[32mINFO [0m|#10678] Processing by SourceController#package_meta as XML [[32mINFO [0m|#10678] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#10678] Validate XML request: #<ActionDispatch::Request:0x00000006701df8> [[0;37mDEBUG[0m|#10678] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#10678] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#10678] [1m[35mUser Load (0.5ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#10678] USER found: king [[0;37mDEBUG[0m|#10678] User king initialised [[0;37mDEBUG[0m|#10678] get_by_project_and_name {} [[0;37mDEBUG[0m|#10678] [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|#10678] [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|#10678] [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|#10678] [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|#10678] Validate XML response: #<ActionDispatch::Response:0x00000006701d58> took 2ms [[32mINFO [0m|#10678] Completed 200 OK in 13ms (Views: 0.6ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#10678] [1m[36m (111.1ms)[0m [1mROLLBACK[0m [[0;37mDEBUG[0m|#10678] kill 10683 + 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/1047/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