See http://ci.opensuse.org/job/obs_master_testsuite_api/1445/changes
Changes:
[Stephan Kulow] [api] refactor status controller
------------------------------------------
[...truncated 140851 lines...]
[[32mINFO [0m|#19581] Parameters: {"project"=>"kde4"}
[[0;37mDEBUG[0m|#19581] Validate XML request: #ActionDispatch::Request:0x00000009542c80
[[0;37mDEBUG[0m|#19581] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"project_meta", "project"=>"kde4", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#19581] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1
[[0;37mDEBUG[0m|#19581] USER found: king
[[0;37mDEBUG[0m|#19581] User king initialised
[[0;37mDEBUG[0m|#19581] [1m[36mProjectUserRoleRelationship Load (0.2ms)[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|#19581] [1m[35mRole Load (0.2ms)[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|#19581] [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|#19581] Validate XML response: #ActionDispatch::Response:0x00000009542c58 took 122ms
[[32mINFO [0m|#19581] Completed 200 OK in 128ms (Views: 0.3ms | ActiveRecord: 0.8ms | Backend: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#19581] Started GET "/source/kde4" for 127.0.0.1 at 2013-04-16 11:22:57 +0000
[[32mINFO [0m|#19581] Processing by SourceController#index_project as XML
[[32mINFO [0m|#19581] Parameters: {"project"=>"kde4"}
[[0;37mDEBUG[0m|#19581] Validate XML request: #ActionDispatch::Request:0x0000000900e638
[[0;37mDEBUG[0m|#19581] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#19581] [1m[35mUser Load (1.0ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1
[[0;37mDEBUG[0m|#19581] USER found: king
[[0;37mDEBUG[0m|#19581] User king initialised
[[0;37mDEBUG[0m|#19581] [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|#19581] [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|#19581] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND (packages.db_project_id not in (0))[0m
[[0;37mDEBUG[0m|#19581] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"index_project", "project"=>"kde4", "method"=>"GET", "type"=>"response"}
[[0;37mDEBUG[0m|#19581] Validate XML response: #ActionDispatch::Response:0x0000000900e688 took 0ms
[[32mINFO [0m|#19581] Completed 200 OK in 8ms (Views: 0.3ms | ActiveRecord: 1.7ms | Backend: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#19581] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-04-16 11:22:57 +0000
[[32mINFO [0m|#19581] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#19581] Parameters: {"project"=>"kde4", "package"=>"kdebase"}
[[0;37mDEBUG[0m|#19581] Validate XML request: #ActionDispatch::Request:0x0000000531af38
[[0;37mDEBUG[0m|#19581] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#19581] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1
[[0;37mDEBUG[0m|#19581] USER found: king
[[0;37mDEBUG[0m|#19581] User king initialised
[[0;37mDEBUG[0m|#19581] get_by_project_and_name {}
[[0;37mDEBUG[0m|#19581] [1m[36mRole Load (0.2ms)[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|#19581] [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|#19581] [1m[36mPackage Load (0.2ms)[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|#19581] [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|#19581] ----------------- rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#19581] [1m[36mPackageUserRoleRelationship Load (0.2ms)[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|#19581] [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|#19581] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m
[[0;37mDEBUG[0m|#19581] ----------------- end rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#19581] Validate XML response: #ActionDispatch::Response:0x0000000531ae20 took 2ms
[[32mINFO [0m|#19581] Completed 200 OK in 16ms (Views: 0.3ms | ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.2ms)
[[32mINFO [0m|#19581] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-04-16 11:22:57 +0000
[[32mINFO [0m|#19581] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#19581] Parameters: {""\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"}
[[0;37mDEBUG[0m|#19581] Validate XML request: #ActionDispatch::Request:0x0000000747b498
[[0;37mDEBUG[0m|#19581] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1
[[0;37mDEBUG[0m|#19581] USER found: king
[[0;37mDEBUG[0m|#19581] User king initialised
[[0;37mDEBUG[0m|#19581] [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|#19581] [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|#19581] [1m[36mPackage Load (0.3ms)[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|#19581] [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|#19581] get_by_project_and_name {}
[[0;37mDEBUG[0m|#19581] [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|#19581] [1m[35mCACHE (0.0ms)[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|#19581] [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|#19581] [1m[35mFlag Load (0.3ms)[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|#19581] [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|#19581] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position
[[0;37mDEBUG[0m|#19581] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#19581] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m
[[0;37mDEBUG[0m|#19581] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#19581] xml_disabled? X({"name"=>"kdebase", "project"=>"kde4", "title"=>"blub", "description"=>"blub"})
[[0;37mDEBUG[0m|#19581] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1
[[0;37mDEBUG[0m|#19581] [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|#19581] [1m[35mPackage Load (0.2ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1366111378)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000000000010717 WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#19581] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#19581] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 1, `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#19581] ----------------- rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#19581] [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|#19581] [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|#19581] ----------------- end rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#19581] [backend] PUT: /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#19586] 2013-04-16 11:22:58 [26078]: PUT /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#19581] request took 0.012428417
[[0;37mDEBUG[0m|#19581] [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|#19581] [1m[36mPackage Load (0.3ms)[0m [1mSELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1366111378)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `activity_index` = 10.000002246377644 WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#19581] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#19581] [1m[35m (0.2ms)[0m UPDATE `packages` SET `update_counter` = 2, `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#19581] ----------------- rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#19581] [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|#19581] [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|#19581] ----------------- end rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#19581] [backend] PUT: /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#19586] 2013-04-16 11:22:58 [26079]: PUT /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#19581] request took 0.009737399
[[0;37mDEBUG[0m|#19581] [1m[36mPackage Load (0.3ms)[0m [1mSELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1366111378)/10000000 ) ) as activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `activity_index` = 10.000003679317457 WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#19581] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 2[0m
[[0;37mDEBUG[0m|#19581] [1m[35m (0.2ms)[0m UPDATE `packages` SET `update_counter` = 3, `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 2
[[0;37mDEBUG[0m|#19581] ----------------- rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#19581] [1m[36mPackageUserRoleRelationship Load (0.2ms)[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|#19581] [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|#19581] ----------------- end rendering package kdebase ------------------------
[[0;37mDEBUG[0m|#19581] [backend] PUT: /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#19586] 2013-04-16 11:22:58 [26080]: PUT /source/kde4/kdebase/_meta?user=king
[[0;37mDEBUG[0m|#19581] request took 0.008694558
[[0;37mDEBUG[0m|#19581] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m
[[0;37mDEBUG[0m|#19581] Validate XML response: #ActionDispatch::Response:0x0000000747b420 took 0ms
[[32mINFO [0m|#19581] Completed 200 OK in 84ms (Views: 0.8ms | ActiveRecord: 6.4ms | Backend: 30.9ms | XML: 0.0ms)
[[32mINFO [0m|#19581] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2013-04-16 11:22:58 +0000
[[32mINFO [0m|#19581] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#19581] Parameters: {"project"=>"kde4", "package"=>"kdebase"}
[[0;37mDEBUG[0m|#19581] Validate XML request: #ActionDispatch::Request:0x00000008405df0
[[0;37mDEBUG[0m|#19581] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#19581] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1
[[0;37mDEBUG[0m|#19581] USER found: king
[[0;37mDEBUG[0m|#19581] User king initialised
[[0;37mDEBUG[0m|#19581] get_by_project_and_name {}
[[0;37mDEBUG[0m|#19581] [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|#19581] [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|#19581] [1m[36mPackage Load (0.2ms)[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|#19581] [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|#19581] Validate XML response: #ActionDispatch::Response:0x00000008405da0 took 1ms
[[32mINFO [0m|#19581] Completed 200 OK in 11ms (Views: 0.3ms | ActiveRecord: 1.0ms | Backend: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#19581] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-04-16 11:22:58 +0000
[[32mINFO [0m|#19581] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#19581] Parameters: {"project"=>"kde4", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#19581] Validate XML request: #ActionDispatch::Request:0x000000082cfa58
[[0;37mDEBUG[0m|#19581] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#19581] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] USER found: king
[[0;37mDEBUG[0m|#19581] User king initialised
[[0;37mDEBUG[0m|#19581] get_by_project_and_name {}
[[0;37mDEBUG[0m|#19581] [1m[35mRole Load (0.2ms)[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|#19581] [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|#19581] [1m[35mPackage Load (0.2ms)[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|#19581] [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|#19581] ----------------- rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#19581] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`id` = 1234 AND (packages.db_project_id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#19581] [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|#19581] [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` = 1
[[0;37mDEBUG[0m|#19581] [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` = 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position
[[0;37mDEBUG[0m|#19581] ----------------- end rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#19581] Validate XML response: #ActionDispatch::Response:0x000000082cf9e0 took 1ms
[[32mINFO [0m|#19581] Completed 200 OK in 19ms (Views: 0.3ms | ActiveRecord: 2.0ms | Backend: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#19581] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-04-16 11:22:58 +0000
[[32mINFO [0m|#19581] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#19581] 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|#19581] Validate XML request: #ActionDispatch::Request:0x0000000888b708
[[0;37mDEBUG[0m|#19581] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] USER found: king
[[0;37mDEBUG[0m|#19581] User king initialised
[[0;37mDEBUG[0m|#19581] [1m[35mRole Load (0.2ms)[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|#19581] [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|#19581] [1m[35mPackage Load (0.2ms)[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|#19581] [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|#19581] get_by_project_and_name {}
[[0;37mDEBUG[0m|#19581] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'kde4' AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mCACHE (0.0ms)[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|#19581] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mFlag Load (0.2ms)[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|#19581] [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|#19581] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position[0m
[[0;37mDEBUG[0m|#19581] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#19581] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2
[[0;37mDEBUG[0m|#19581] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#19581] 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|#19581] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = 'home:coolo:test' AND (projects.id not in (0)) LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `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[0m
[[0;37mDEBUG[0m|#19581] [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|#19581] [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|#19581] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mRole Load (0.1ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mRole Load (0.1ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mPackage Load (0.2ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1366111378)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000000000010717 WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#19581] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 1, `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#19581] ----------------- rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#19581] [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` = 1
[[0;37mDEBUG[0m|#19581] [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` = 1[0m
[[0;37mDEBUG[0m|#19581] ----------------- end rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#19581] [backend] PUT: /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#19586] 2013-04-16 11:22:58 [26081]: PUT /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#19581] request took 0.011642069
[[0;37mDEBUG[0m|#19581] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = 'fredlibs' LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = 'adrian' LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] [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|#19581] [1m[36mGroup Load (0.1ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mRole Load (0.1ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mPackage Load (0.2ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1366111378)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.00000276822183 WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#19581] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 2, `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#19581] ----------------- rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#19581] [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` = 1
[[0;37mDEBUG[0m|#19581] [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` = 1[0m
[[0;37mDEBUG[0m|#19581] ----------------- end rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#19581] [backend] PUT: /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#19586] 2013-04-16 11:22:58 [26082]: PUT /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#19581] request took 0.009900943
[[0;37mDEBUG[0m|#19581] [1m[35mPackage Load (0.3ms)[0m SELECT packages.*, ( packages.activity_index * POWER( 2.3276, (UNIX_TIMESTAMP(packages.updated_at) - 1366111378)/10000000 ) ) as activity_value FROM `packages` WHERE id = 1 LIMIT 1
[[0;37mDEBUG[0m|#19581] [1m[36mSQL (0.2ms)[0m [1mUPDATE `packages` SET `activity_index` = 10.000004728304015 WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#19581] [1m[35mSQL (0.2ms)[0m UPDATE `packages` SET `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 1
[[0;37mDEBUG[0m|#19581] [1m[36m (0.2ms)[0m [1mUPDATE `packages` SET `update_counter` = 3, `updated_at` = '2013-04-16 11:22:58' WHERE `packages`.`id` = 1[0m
[[0;37mDEBUG[0m|#19581] ----------------- rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#19581] [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` = 1
[[0;37mDEBUG[0m|#19581] [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` = 1[0m
[[0;37mDEBUG[0m|#19581] ----------------- end rendering package kdelibs ------------------------
[[0;37mDEBUG[0m|#19581] [backend] PUT: /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#19586] 2013-04-16 11:22:58 [26083]: PUT /source/kde4/kdelibs/_meta?user=king
[[0;37mDEBUG[0m|#19581] request took 0.011549383
[[0;37mDEBUG[0m|#19581] [1m[35m (0.2ms)[0m RELEASE SAVEPOINT active_record_1
[[0;37mDEBUG[0m|#19581] Validate XML response: #ActionDispatch::Response:0x0000000888b6b8 took 0ms
[[32mINFO [0m|#19581] Completed 200 OK in 95ms (Views: 0.7ms | ActiveRecord: 8.2ms | Backend: 33.1ms | XML: 0.0ms)
[[32mINFO [0m|#19581] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2013-04-16 11:22:58 +0000
[[32mINFO [0m|#19581] Processing by SourceController#package_meta as XML
[[32mINFO [0m|#19581] Parameters: {"project"=>"kde4", "package"=>"kdelibs"}
[[0;37mDEBUG[0m|#19581] Validate XML request: #ActionDispatch::Request:0x000000091411b8
[[0;37mDEBUG[0m|#19581] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"}
[[0;37mDEBUG[0m|#19581] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m
[[0;37mDEBUG[0m|#19581] USER found: king
[[0;37mDEBUG[0m|#19581] User king initialised
[[0;37mDEBUG[0m|#19581] get_by_project_and_name {}
[[0;37mDEBUG[0m|#19581] [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|#19581] [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|#19581] [1m[35mPackage Load (0.2ms)[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|#19581] [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|#19581] Validate XML response: #ActionDispatch::Response:0x00000009141190 took 1ms
[[32mINFO [0m|#19581] Completed 200 OK in 11ms (Views: 0.4ms | ActiveRecord: 1.0ms | Backend: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|#19581] [1m[35m (5.2ms)[0m ROLLBACK
[[0;37mDEBUG[0m|#19581] kill 19586
+ 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/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
admin＠opensuse.org