See http://ci.opensuse.org/job/obs_master_testsuite_api/1481/changes
Changes:
[mls] [backend] support project partitioning
[mls] [backend] implement badhost and idleworker forwarding for masterdispatch mode
------------------------------------------
[...truncated 141127 lines...]
[[32mINFO [0m|#20580] Parameters: {"project"=>"kde4"}
[[0;37mDEBUG[0m|#20580] Validate XML request: #ActionDispatch::Request:0x000000082ce4c8
[[0;37mDEBUG[0m|#20580] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#20580] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'king' LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] USER found: king
[[0;37mDEBUG[0m|#20580] User king initialised
[[0;37mDEBUG[0m|#20580] [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|#20580] [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|#20580] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] Validate XML response: #ActionDispatch::Response:0x000000082ce478 took 2ms
[[32mINFO [0m|#20580] Completed 200 OK in 9ms (Views: 0.3ms | ActiveRecord: 1.3ms | Backend: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#20580] Started GET "/source/kde4" for 127.0.0.1 at 2013-04-30 15:11:27 +0000
[[32mINFO [0m|#20580] Processing by SourceController#index_project as XML
[[32mINFO [0m|#20580] Parameters: {"project"=>"kde4"}
[[0;37mDEBUG[0m|#20580] Validate XML request: #ActionDispatch::Request:0x000000083bfaf8
[[0;37mDEBUG[0m|#20580] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#20580] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'king' LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] USER found: king
[[0;37mDEBUG[0m|#20580] User king initialised
[[0;37mDEBUG[0m|#20580] [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|#20580] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND (packages.db_project_id not in (0))
[[0;37mDEBUG[0m|#20580] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"}
[[0;37mDEBUG[0m|#20580] Validate XML response: #ActionDispatch::Response:0x000000083bfa80 took 0ms
[[32mINFO [0m|#20580] Completed 200 OK in 7ms (Views: 0.3ms | ActiveRecord: 1.2ms | Backend: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#20580] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-04-30 15:11:27 +0000
[[32mINFO [0m|#20580] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#20580] Parameters: {"project"=>"kde4", "package"=>"kdebase"}
[[0;37mDEBUG[0m|#20580] Validate XML request: #ActionDispatch::Request:0x000000084e3768
[[0;37mDEBUG[0m|#20580] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#20580] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'king' LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] USER found: king
[[0;37mDEBUG[0m|#20580] User king initialised
[[0;37mDEBUG[0m|#20580] get_by_project_and_name {}
[[0;37mDEBUG[0m|#20580] [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|#20580] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mPackage Load (0.3ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] ----------------- rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#20580] [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|#20580] [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|#20580] [1m[35mFlag Load (0.3ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position
[[0;37mDEBUG[0m|#20580] ----------------- end rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#20580] Validate XML response: #ActionDispatch::Response:0x000000084e3740 took 2ms
[[32mINFO [0m|#20580] Completed 200 OK in 16ms (Views: 0.4ms | ActiveRecord: 2.2ms | Backend: 0.0ms | XML: 0.3ms)
[[32mINFO [0m|#20580] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-04-30 15:11:27 +0000
[[32mINFO [0m|#20580] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#20580] Parameters: {""\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"}
[[0;37mDEBUG[0m|#20580] Validate XML request: #ActionDispatch::Request:0x00000008996198
[[0;37mDEBUG[0m|#20580] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'king' LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] USER found: king
[[0;37mDEBUG[0m|#20580] User king initialised
[[0;37mDEBUG[0m|#20580] [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|#20580] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] get_by_project_and_name {}
[[0;37mDEBUG[0m|#20580] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mCACHE (0.0ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mFlag Load (0.5ms)[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|#20580] [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|#20580] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m
[[0;37mDEBUG[0m|#20580] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#20580] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2
[[0;37mDEBUG[0m|#20580] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#20580] xml_disabled? X({"name"=>"kdebase", "project"=>"kde4", "title"=>"blub", "description"=>"blub"})
[[0;37mDEBUG[0m|#20580] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
[[0;37mDEBUG[0m|#20580] [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|#20580] [1m[36mPackage Load (0.3ms)[0m [1mSELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1367334687)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `activity_index` = 10.000000000009665 WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#20580] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `updated_at` = '2013-04-30 15:11:27' WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#20580] [1m[35m (0.2ms)[0m UPDATE `packages` SET `update_counter` = 1, `updated_at` = '2013-04-30 15:11:27' WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#20580] ----------------- rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#20580] [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|#20580] [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|#20580] ----------------- end rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#20580] [backend] PUT: /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#20585] 2013-04-30 15:11:27 [27103]: PUT /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#20580] request took 0.013819664
[[0;37mDEBUG[0m|#20580] [1m[36mPackageGroupRoleRelationship Load (0.4ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m
[[0;37mDEBUG[0m|#20580] [1m[35mPackage Load (0.3ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1367334687)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000002503809002 WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#20580] [1m[35mSQL (0.1ms)[0m UPDATE `packages` SET `updated_at` = '2013-04-30 15:11:27' WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#20580] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 2, `updated_at` = '2013-04-30 15:11:27' WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#20580] ----------------- rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#20580] [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|#20580] [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|#20580] ----------------- end rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#20580] [backend] PUT: /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#20585] 2013-04-30 15:11:27 [27104]: PUT /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#20580] request took 0.009840884
[[0;37mDEBUG[0m|#20580] [1m[35mPackage Load (0.7ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1367334688)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000003849579771 WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#20580] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-04-30 15:11:28' WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#20580] [1m[36m (0.1ms)[0m [1mUPDATE `packages` SET `update_counter` = 3, `updated_at` = '2013-04-30 15:11:28' WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#20580] ----------------- rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#20580] [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|#20580] [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|#20580] ----------------- end rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#20580] [backend] PUT: /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#20585] 2013-04-30 15:11:28 [27105]: PUT /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#20580] request took 0.01185857
[[0;37mDEBUG[0m|#20580] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1
[[0;37mDEBUG[0m|#20580] Validate XML response: #ActionDispatch::Response:0x00000008996080 took 0ms
[[32mINFO [0m|#20580] Completed 200 OK in 88ms (Views: 1.0ms | ActiveRecord: 7.7ms | Backend: 35.5ms | XML: 0.0ms)
[[32mINFO [0m|#20580] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-04-30 15:11:28 +0000
[[32mINFO [0m|#20580] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#20580] Parameters: {"project"=>"kde4", "package"=>"kdebase"}
[[0;37mDEBUG[0m|#20580] Validate XML request: #ActionDispatch::Request:0x00000008d9f9b0
[[0;37mDEBUG[0m|#20580] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#20580] [1m[36mUser Load (0.4ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'king' LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] USER found: king
[[0;37mDEBUG[0m|#20580] User king initialised
[[0;37mDEBUG[0m|#20580] get_by_project_and_name {}
[[0;37mDEBUG[0m|#20580] [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|#20580] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdebase' AND (packages.db_project_id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] Validate XML response: #ActionDispatch::Response:0x00000008d9f988 took 1ms
[[32mINFO [0m|#20580] Completed 200 OK in 12ms (Views: 0.6ms | ActiveRecord: 1.4ms | Backend: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#20580] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-04-30 15:11:28 +0000
[[32mINFO [0m|#20580] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#20580] Parameters: {"project"=>"kde4", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#20580] Validate XML request: #ActionDispatch::Request:0x00000009189a30
[[0;37mDEBUG[0m|#20580] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#20580] [1m[35mUser Load (0.4ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'king' LIMIT 1
[[0;37mDEBUG[0m|#20580] USER found: king
[[0;37mDEBUG[0m|#20580] User king initialised
[[0;37mDEBUG[0m|#20580] get_by_project_and_name {}
[[0;37mDEBUG[0m|#20580] [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|#20580] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] ----------------- rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#20580] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`id` = 1234 AND (packages.db_project_id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 601 AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [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|#20580] [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` = 1
[[0;37mDEBUG[0m|#20580] [1m[36mFlag Load (0.3ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m
[[0;37mDEBUG[0m|#20580] ----------------- end rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#20580] Validate XML response: #ActionDispatch::Response:0x00000009189a08 took 2ms
[[32mINFO [0m|#20580] Completed 200 OK in 20ms (Views: 0.5ms | ActiveRecord: 2.6ms | Backend: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#20580] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-04-30 15:11:28 +0000
[[32mINFO [0m|#20580] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#20580] Parameters: {""\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n \n \n \n \n</package>\n", "project"=>"kde4", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#20580] Validate XML request: #ActionDispatch::Request:0x00000008fef058
[[0;37mDEBUG[0m|#20580] [1m[35mUser Load (0.5ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'king' LIMIT 1
[[0;37mDEBUG[0m|#20580] USER found: king
[[0;37mDEBUG[0m|#20580] User king initialised
[[0;37mDEBUG[0m|#20580] [1m[36mRole Load (0.6ms)[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|#20580] [1m[35mProject Load (0.3ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mPackage Load (0.5ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] get_by_project_and_name {}
[[0;37mDEBUG[0m|#20580] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mCACHE (0.0ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mFlag Load (0.5ms)[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|#20580] [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|#20580] [1m[35mFlag Load (3.8ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position
[[0;37mDEBUG[0m|#20580] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#20580] [1m[36mFlag Load (0.3ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m
[[0;37mDEBUG[0m|#20580] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#20580] xml_disabled? X({"name"=>"kdelibs", "project"=>"kde4", "title"=>"blub", "description"=>"blub", "devel"=>X({"project"=>"home:coolo:test", "package"=>"kdelibs_DEVEL_package"}), "person"=>[X({"userid"=>"fredlibs", "role"=>"maintainer"}), X({"userid"=>"adrian", "role"=>"reviewer"})], "group"=>X({"groupid"=>"test_group", "role"=>"maintainer"})})
[[0;37mDEBUG[0m|#20580] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
[[0;37mDEBUG[0m|#20580] [1m[36mProject Load (2.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'home:coolo:test' AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mPackage Load (0.4ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 601 AND `packages`.`name` = 'kdelibs_DEVEL_package' AND (packages.db_project_id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 601 AND (projects.id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [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|#20580] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mRole Load (0.1ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mRole Load (0.1ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mPackage Load (0.2ms)[0m [1mSELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1367334688)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `activity_index` = 10.000000000009665 WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#20580] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `updated_at` = '2013-04-30 15:11:28' WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35m (0.1ms)[0m UPDATE `packages` SET `update_counter` = 1, `updated_at` = '2013-04-30 15:11:28' WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#20580] ----------------- rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#20580] [1m[36mPackageUserRoleRelationship Load (0.4ms)[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|#20580] [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` = 1
[[0;37mDEBUG[0m|#20580] ----------------- end rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#20580] [backend] PUT: /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#20585] 2013-04-30 15:11:28 [27106]: PUT /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#20580] request took 0.01272745
[[0;37mDEBUG[0m|#20580] [1m[36mUser Load (0.5ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'fredlibs' LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'adrian' LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mPackageGroupRoleRelationship Load (0.3ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mGroup Load (0.2ms)[0m SELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mRole Load (0.2ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mGroup Load (0.3ms)[0m SELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mPackage Load (0.3ms)[0m [1mSELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1367334688)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `activity_index` = 10.000003364764982 WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#20580] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `updated_at` = '2013-04-30 15:11:28' WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35m (0.2ms)[0m UPDATE `packages` SET `update_counter` = 2, `updated_at` = '2013-04-30 15:11:28' WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#20580] ----------------- rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#20580] [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|#20580] [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` = 1
[[0;37mDEBUG[0m|#20580] ----------------- end rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#20580] [backend] PUT: /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#20585] 2013-04-30 15:11:28 [27107]: PUT /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#20580] request took 0.011245536
[[0;37mDEBUG[0m|#20580] [1m[36mPackage Load (0.3ms)[0m [1mSELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1367334688)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `activity_index` = 10.000005883530335 WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#20580] [1m[36mSQL (0.1ms)[0m [1mUPDATE `packages` SET `updated_at` = '2013-04-30 15:11:28' WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35m (0.2ms)[0m UPDATE `packages` SET `update_counter` = 3, `updated_at` = '2013-04-30 15:11:28' WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#20580] ----------------- rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#20580] [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|#20580] [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|#20580] ----------------- end rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#20580] [backend] PUT: /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#20585] 2013-04-30 15:11:28 [27108]: PUT /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#20580] request took 0.009177819
[[0;37mDEBUG[0m|#20580] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
[[0;37mDEBUG[0m|#20580] Validate XML response: #ActionDispatch::Response:0x00000008fef030 took 0ms
[[32mINFO [0m|#20580] Completed 200 OK in 269ms (Views: 0.8ms | ActiveRecord: 16.3ms | Backend: 33.2ms | XML: 0.0ms)
[[32mINFO [0m|#20580] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-04-30 15:11:28 +0000
[[32mINFO [0m|#20580] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#20580] Parameters: {"project"=>"kde4", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#20580] Validate XML request: #ActionDispatch::Request:0x00000007a79e80
[[0;37mDEBUG[0m|#20580] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#20580] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'king' LIMIT 1
[[0;37mDEBUG[0m|#20580] USER found: king
[[0;37mDEBUG[0m|#20580] User king initialised
[[0;37mDEBUG[0m|#20580] get_by_project_and_name {}
[[0;37mDEBUG[0m|#20580] [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|#20580] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = 'kdelibs' AND (packages.db_project_id not in (0)) LIMIT 1[0m
[[0;37mDEBUG[0m|#20580] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#20580] Validate XML response: #ActionDispatch::Response:0x00000007a79e58 took 2ms
[[32mINFO [0m|#20580] Completed 200 OK in 11ms (Views: 0.4ms | ActiveRecord: 1.1ms | Backend: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|#20580] [1m[36m (5.5ms)[0m [1mROLLBACK[0m
[[0;37mDEBUG[0m|#20580] kill 20585
+ echo
+ cleanup
+ echo 'Killing backend processes'
Killing backend processes
+ fuser -v http://ci.opensuse.org/job/obs_master_testsuite_api/ws/
+ egrep 'perl|ruby'
+ 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/scheduler.done 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