April 2013 - Open Build Service Tests - openSUSE Mailing Lists

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1481
by admin＠opensuse.org 30 Apr '13

30 Apr '13

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: {"<package name"=>"\"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: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n <devel project=\"home:coolo:test\" package=\"kdelibs_DEVEL_package\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1472
by admin＠opensuse.org 29 Apr '13

29 Apr '13

See <http://ci.opensuse.org/job/obs_master_testsuite_api/1472/> ------------------------------------------ Started by upstream project "obs_master_check_deps" build number 563 originally caused by: Started by upstream project "obs_master_update_deps" build number 222 originally caused by: Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Started by an SCM change Building remotely on obs_master_deps_chroot in workspace <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> Checkout:obs_master_testsuite_api / <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> - hudson.remoting.Channel@1af51af5:obs_master_deps_chroot Using strategy: Default Last Built Revision: Revision b9e15d5381b0ed0b21501d88901e88e773431cf7 (origin/master) Fetching changes from 1 remote Git repository Fetching upstream changes from origin ERROR: Problem fetching from origin / origin - could be unavailable. Continuing anyway hudson.plugins.git.GitException: Command "git fetch -t origin +refs/heads/*:refs/remotes/origin/*" returned status code 128: stdout: stderr: fatal: Unable to look up github.com (port 9418) (Name or service not known) at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:773) at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommand(CliGitAPIImpl.java:739) at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.fetch(CliGitAPIImpl.java:160) at hudson.plugins.git.GitAPI.fetch(GitAPI.java:230) at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:793) at hudson.plugins.git.GitSCM.access$000(GitSCM.java:57) at hudson.plugins.git.GitSCM$2.invoke(GitSCM.java:976) at hudson.plugins.git.GitSCM$2.invoke(GitSCM.java:942) at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2348) at hudson.remoting.UserRequest.perform(UserRequest.java:118) at hudson.remoting.UserRequest.perform(UserRequest.java:48) at hudson.remoting.Request$2.run(Request.java:326) at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72) at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) at java.util.concurrent.FutureTask.run(FutureTask.java:166) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603) at java.lang.Thread.run(Thread.java:722) ERROR: Could not fetch from any repository FATAL: Could not fetch from any repository hudson.plugins.git.GitException: Could not fetch from any repository at hudson.plugins.git.GitSCM$2.invoke(GitSCM.java:981) at hudson.plugins.git.GitSCM$2.invoke(GitSCM.java:942) at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2348) at hudson.remoting.UserRequest.perform(UserRequest.java:118) at hudson.remoting.UserRequest.perform(UserRequest.java:48) at hudson.remoting.Request$2.run(Request.java:326) at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72) at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) at java.util.concurrent.FutureTask.run(FutureTask.java:166) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603) at java.lang.Thread.run(Thread.java:722) -- To unsubscribe, e-mail: obs-tests+unsubscribe(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #894
by admin＠opensuse.org 22 Apr '13

22 Apr '13

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/894/changes> Changes: [mls] [backend] put remote_getrev results in the cache, use the cache for project sourceinfo as well [mls] [backend] also put old revisions in the cache ------------------------------------------ [...truncated 651839 lines...] [[0;37mDEBUG[0m|#17433] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#17433] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#17433] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/person/tom {"view"=>0.644017, "db"=>1.7832959999999998, "backend"=>0, "xml"=>0, :runtime=>14.436, :all=>18.393546999999998} [[0;37mDEBUG[0m|#17433] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|#17433] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|#17433] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|#17433] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|#17433] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.9863419999999998, "backend"=>0, "xml"=>0, :runtime=>26.329, :all=>67.46529} [[32mINFO [0m|#17433] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|#17433] Completed 200 OK in 89ms (Views: 0.6ms | ActiveRecord: 0.0ms | API: 85.9ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 2.8ms , HTTP: 45.1ms) | XML: 0.3ms) [[32mINFO [0m|#17433] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-19 11:32:47 +0000 [[32mINFO [0m|#17433] Processing by ProjectController#show as HTML [[32mINFO [0m|#17433] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#17433] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#17433] Authenticating with iChain mode: off [[32mINFO [0m|#17433] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#17433] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#17433] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#17433] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#17433] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/person/tom {"view"=>0.481249, "db"=>1.5332540000000001, "backend"=>0, "xml"=>0, :runtime=>13.025, :all=>53.051126} [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.260263, "db"=>4.553209000000001, "backend"=>0, "xml"=>0, :runtime=>36.528999999999996, :all=>78.690543} [[0;37mDEBUG[0m|#17433] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.418372, "db"=>3.7620019999999994, "backend"=>0, "xml"=>0, :runtime=>35.594, :all=>75.45690300000001} [[0;37mDEBUG[0m|#17433] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#17433] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#17433] Rendered project/_tabs.html.erb (2.9ms) [[32mINFO [0m|#17433] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#17433] Rendered layouts/_watch_and_search.html.erb (1.2ms) [[32mINFO [0m|#17433] Rendered layouts/_header.html.erb (2.1ms) [[32mINFO [0m|#17433] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#17433] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#17433] Completed 200 OK in 227ms (Views: 14.5ms | ActiveRecord: 0.0ms | API: 207.2ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 9.8ms , HTTP: 122.1ms) | XML: 0.6ms) [[32mINFO [0m|#17433] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-19 11:32:47 +0000 [[32mINFO [0m|#17433] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|#17433] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#17433] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|#17433] Authenticating with iChain mode: off [[32mINFO [0m|#17433] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#17433] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#17433] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#17433] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#17433] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/person/tom {"view"=>0.488513, "db"=>1.5731149999999998, "backend"=>0, "xml"=>0, :runtime=>13.697000000000001, :all=>17.095330999999998} [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.38398000000000004, "db"=>3.9053130000000005, "backend"=>0, "xml"=>0, :runtime=>30.411, :all=>69.489229} [[0;37mDEBUG[0m|#17433] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#17433] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|#17433] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|#17433] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|#17433] saving object Person ({:is_current=>"true", :login=>"tom"}) to api: <person> <login>tom</login> <email>tschmidt(a)suse.de</email> <realname>Thor</realname> <state>confirmed</state> <watchlist> </watchlist> </person> [[0;37mDEBUG[0m|#17433] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/person/tom {"view"=>1.023857, "db"=>2.24026, "backend"=>0, "xml"=>0, :runtime=>17.46, :all=>23.43833} [[0;37mDEBUG[0m|#17433] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#17433] params {:login=>"tom"} [[0;37mDEBUG[0m|#17433] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/person/tom/group {"view"=>0.359362, "db"=>0.7213529999999999, "backend"=>0, "xml"=>0, :runtime=>6.5360000000000005, :all=>10.292343} [[0;37mDEBUG[0m|#17433] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|#17433] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|#17433] Redirected to http://127.0.0.1:55188/project/show?project=My%3AMaintenance [[32mINFO [0m|#17433] Completed 302 Found in 125ms (ActiveRecord: 0.0ms | API: 120.3ms (XML: 0.0ms , View: 2.3ms , Backend: 0.0ms , DB: 8.4ms , HTTP: 52.2ms) | XML: 0.5ms) [[32mINFO [0m|#17433] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-19 11:32:48 +0000 [[32mINFO [0m|#17433] Processing by ProjectController#show as HTML [[32mINFO [0m|#17433] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|#17433] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|#17433] Authenticating with iChain mode: off [[32mINFO [0m|#17433] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|#17433] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|#17433] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#17433] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#17433] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/person/tom {"view"=>0.436849, "db"=>0.9248500000000001, "backend"=>0, "xml"=>0, :runtime=>7.965, :all=>47.622605} [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.303773, "db"=>5.555675, "backend"=>0, "xml"=>0, :runtime=>37.083999999999996, :all=>79.032746} [[0;37mDEBUG[0m|#17433] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.425343, "db"=>3.854682, "backend"=>0, "xml"=>0, :runtime=>34.61, :all=>76.163461} [[0;37mDEBUG[0m|#17433] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|#17433] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|#17433] Rendered project/_tabs.html.erb (2.2ms) [[32mINFO [0m|#17433] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|#17433] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|#17433] Rendered layouts/_header.html.erb (1.5ms) [[32mINFO [0m|#17433] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#17433] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#17433] Completed 200 OK in 219ms (Views: 11.8ms | ActiveRecord: 0.0ms | API: 202.8ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 10.3ms , HTTP: 123.2ms) | XML: 0.5ms) [[32mINFO [0m|#17433] Started POST "/user/logout" for 127.0.0.1 at 2013-04-19 11:32:48 +0000 [[32mINFO [0m|#17433] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#17433] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#17433] Authenticating with iChain mode: off [[32mINFO [0m|#17433] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#17433] Logging out: tom [[32mINFO [0m|#17433] Redirected to http://127.0.0.1:55188/ [[0;37mDEBUG[0m|#17433] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#17433] Completed 302 Found in 12ms (ActiveRecord: 9.9ms | XML: 0.0ms) [[32mINFO [0m|#17433] Started GET "/" for 127.0.0.1 at 2013-04-19 11:32:48 +0000 [[32mINFO [0m|#17433] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#17433] Setting return_to: "/" [[0;37mDEBUG[0m|#17433] Authenticating with iChain mode: off [[32mINFO [0m|#17433] Anonymous request to / [[0;37mDEBUG[0m|#17433] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] Statusmessage_2fe508b303b3ed792c174b7580cb295c [[0;37mDEBUG[0m|#17433] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] ) [[0;37mDEBUG[0m|#17433] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"} [[0;37mDEBUG[0m|#17433] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=4 [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/status/messages/?limit=4 {"view"=>0.8659129999999999, "db"=>0.572638, "backend"=>0, "xml"=>0, :runtime=>6.35, :all=>9.637397} [[0;37mDEBUG[0m|#17433] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|#17433] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|#17433] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|#17433] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|#17433] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.506103, "db"=>2.5853820000000005, "backend"=>0, "xml"=>0, :runtime=>19.609, :all=>60.299946} [[32mINFO [0m|#17433] Rendered shared/_sign_up.html.erb (0.9ms) [[32mINFO [0m|#17433] Rendered main/_sponsors.html.erb (0.1ms) [[32mINFO [0m|#17433] Rendered main/_news.html.erb (0.2ms) [[32mINFO [0m|#17433] Rendered main/_latest_updates.erb (4.4ms) [[32mINFO [0m|#17433] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|#17433] Rendered layouts/_header.html.erb (1.1ms) [[32mINFO [0m|#17433] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#17433] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#17433] Completed 200 OK in 89ms (Views: 15.2ms | ActiveRecord: 0.0ms | API: 69.9ms (XML: 0.0ms , View: 2.4ms , Backend: 0.0ms , DB: 3.2ms , HTTP: 44.0ms) | XML: 1.0ms) [[32mINFO [0m|#17433] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-04-19 11:32:48 +0000 [[32mINFO [0m|#17433] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|#17433] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|#17433] Authenticating with iChain mode: off [[32mINFO [0m|#17433] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|#17433] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|#17433] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|#17433] Rendered main/_systemstatus.html.erb (1.7ms) [[32mINFO [0m|#17433] Completed 200 OK in 4ms (Views: 2.4ms | ActiveRecord: 0.0ms | XML: 0.5ms) [[0;37mDEBUG[0m|#17433] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|#17433] RT http://localhost:3203/test/test_end {"view"=>1.6567070000000002, "db"=>14.19258, "backend"=>0, "xml"=>0, :runtime=>21.117, :all=>26.055877000000002} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/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/test.log src/webui/tmp/cache src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets + exit 0 [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Looks like the node went offline during the build. Check the slave log for the details.FATAL: null java.lang.NullPointerException at hudson.plugins.timestamper.annotator.TimestampAnnotatorFactory.getOffset(TimestampAnnotatorFactory.java:65) at hudson.plugins.timestamper.annotator.TimestampAnnotatorFactory.newInstance(TimestampAnnotatorFactory.java:52) at hudson.console.ConsoleAnnotator._for(ConsoleAnnotator.java:143) at hudson.console.ConsoleAnnotator.initial(ConsoleAnnotator.java:133) at hudson.console.AnnotatedLargeText.createAnnotator(AnnotatedLargeText.java:140) at hudson.console.AnnotatedLargeText.writeHtmlTo(AnnotatedLargeText.java:157) at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:593) at hudson.model.Run.execute(Run.java:1575) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46) at hudson.model.ResourceController.execute(ResourceController.java:88) at hudson.model.Executor.run(Executor.java:237) -- To unsubscribe, e-mail: obs-tests+unsubscribe(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Jenkins build is back to normal : obs_master_testsuite_api #1459
by admin＠opensuse.org 22 Apr '13

22 Apr '13

See <http://ci.opensuse.org/job/obs_master_testsuite_api/1459/changes> -- To unsubscribe, e-mail: obs-tests+unsubscribe(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 0

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1445
by admin＠opensuse.org 16 Apr '13

16 Apr '13

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: {"<package name"=>"\"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: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n <devel project=\"home:coolo:test\" package=\"kdelibs_DEVEL_package\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 1

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #880
by admin＠opensuse.org 15 Apr '13

15 Apr '13

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/880/changes> Changes: [adrian] [api] make it possible to set the api version in environment.rb file in packages [Stephan Kulow] [activexml] throw a ConnectionError on EOFError [Stephan Kulow] [api] provide a default XML render for actions [Stephan Kulow] [webui] catch even more invalid utf-8 (hopefully ruby 2.0 is easier) [Stephan Kulow] [webui] rework the statistics route to not crash on old/invalid data ------------------------------------------ [...truncated 651940 lines...] [[32mINFO [0m|# 3221] Rendered layouts/_header.html.erb (2.9ms) [[32mINFO [0m|# 3221] Rendered layouts/_personal_navigation.html.erb (1.7ms) [[32mINFO [0m|# 3221] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 3221] Completed 200 OK in 199ms (Views: 20.7ms | ActiveRecord: 0.0ms | API: 172.7ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 8.8ms , HTTP: 85.4ms) | XML: 0.8ms) [[32mINFO [0m|# 3221] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-04-15 16:10:19 +0000 [[32mINFO [0m|# 3221] Processing by ProjectController#buildresult as */* [[32mINFO [0m|# 3221] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|# 3221] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|# 3221] Authenticating with iChain mode: off [[32mINFO [0m|# 3221] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|# 3221] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 3221] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 3221] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 3221] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/person/tom {"view"=>0.47142100000000003, "db"=>9.263435000000001, "backend"=>0, "xml"=>0, :runtime=>23.518, :all=>26.872358} [[0;37mDEBUG[0m|# 3221] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|# 3221] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|# 3221] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|# 3221] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|# 3221] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>7.874493, "backend"=>0, "xml"=>0, :runtime=>49.199, :all=>88.98885700000001} [[32mINFO [0m|# 3221] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|# 3221] Completed 200 OK in 119ms (Views: 0.9ms | ActiveRecord: 0.0ms | API: 115.9ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 17.1ms , HTTP: 43.1ms) | XML: 0.2ms) [[32mINFO [0m|# 3221] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-15 16:10:19 +0000 [[32mINFO [0m|# 3221] Processing by ProjectController#show as HTML [[32mINFO [0m|# 3221] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 3221] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 3221] Authenticating with iChain mode: off [[32mINFO [0m|# 3221] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 3221] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 3221] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 3221] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 3221] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/person/tom {"view"=>0.462966, "db"=>1.441404, "backend"=>0, "xml"=>0, :runtime=>11.889999999999999, :all=>54.678245} [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.236167, "db"=>3.6192209999999996, "backend"=>0, "xml"=>0, :runtime=>26.785, :all=>66.246876} [[0;37mDEBUG[0m|# 3221] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.481815, "db"=>3.150528, "backend"=>0, "xml"=>0, :runtime=>36.525, :all=>75.581405} [[0;37mDEBUG[0m|# 3221] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|# 3221] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 3221] Rendered project/_tabs.html.erb (2.3ms) [[32mINFO [0m|# 3221] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|# 3221] Rendered layouts/_watch_and_search.html.erb (1.1ms) [[32mINFO [0m|# 3221] Rendered layouts/_header.html.erb (1.9ms) [[32mINFO [0m|# 3221] Rendered layouts/_personal_navigation.html.erb (65.9ms) [[32mINFO [0m|# 3221] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 3221] Completed 200 OK in 282ms (Views: 80.7ms | ActiveRecord: 0.0ms | API: 196.5ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 8.2ms , HTTP: 121.3ms) | XML: 0.5ms) [[32mINFO [0m|# 3221] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-15 16:10:19 +0000 [[32mINFO [0m|# 3221] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|# 3221] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 3221] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 3221] Authenticating with iChain mode: off [[32mINFO [0m|# 3221] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 3221] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 3221] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 3221] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 3221] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/person/tom {"view"=>0.432875, "db"=>1.280201, "backend"=>0, "xml"=>0, :runtime=>11.860000000000001, :all=>15.351871} [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.228044, "db"=>3.4057679999999992, "backend"=>0, "xml"=>0, :runtime=>25.796, :all=>64.594078} [[0;37mDEBUG[0m|# 3221] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 3221] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|# 3221] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|# 3221] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|# 3221] saving object Person ({:is_current=>"true", :login=>"tom"}) to api: <person> <login>tom</login> <email>tschmidt(a)suse.de</email> <realname>Thor</realname> <state>confirmed</state> <watchlist> </watchlist> </person> [[0;37mDEBUG[0m|# 3221] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/person/tom {"view"=>1.016102, "db"=>2.189876, "backend"=>0, "xml"=>0, :runtime=>17.726, :all=>21.679752999999998} [[0;37mDEBUG[0m|# 3221] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|# 3221] params {:login=>"tom"} [[0;37mDEBUG[0m|# 3221] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/person/tom/group {"view"=>0.37041199999999996, "db"=>0.6972419999999999, "backend"=>0, "xml"=>0, :runtime=>6.164000000000001, :all=>9.662359} [[0;37mDEBUG[0m|# 3221] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|# 3221] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|# 3221] Redirected to http://127.0.0.1:55226/project/show?project=My%3AMaintenance [[32mINFO [0m|# 3221] Completed 302 Found in 116ms (ActiveRecord: 0.0ms | API: 111.3ms (XML: 0.0ms , View: 2.0ms , Backend: 0.0ms , DB: 7.6ms , HTTP: 49.7ms) | XML: 0.3ms) [[32mINFO [0m|# 3221] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-04-15 16:10:19 +0000 [[32mINFO [0m|# 3221] Processing by ProjectController#show as HTML [[32mINFO [0m|# 3221] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 3221] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 3221] Authenticating with iChain mode: off [[32mINFO [0m|# 3221] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 3221] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 3221] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 3221] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 3221] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/person/tom {"view"=>0.435664, "db"=>0.8818879999999999, "backend"=>0, "xml"=>0, :runtime=>7.691, :all=>47.703047999999995} [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.243316, "db"=>4.043585, "backend"=>0, "xml"=>0, :runtime=>32.114, :all=>73.98173600000001} [[0;37mDEBUG[0m|# 3221] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.406671, "db"=>3.5033479999999995, "backend"=>0, "xml"=>0, :runtime=>29.506999999999998, :all=>143.451324} [[0;37mDEBUG[0m|# 3221] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|# 3221] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 3221] Rendered project/_tabs.html.erb (2.2ms) [[32mINFO [0m|# 3221] Rendered shared/_open_requests.html.erb (0.0ms) [[32mINFO [0m|# 3221] Rendered layouts/_watch_and_search.html.erb (0.8ms) [[32mINFO [0m|# 3221] Rendered layouts/_header.html.erb (1.6ms) [[32mINFO [0m|# 3221] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|# 3221] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|# 3221] Completed 200 OK in 282ms (Views: 12.2ms | ActiveRecord: 0.0ms | API: 265.1ms (XML: 0.0ms , View: 1.1ms , Backend: 0.0ms , DB: 8.4ms , HTTP: 195.8ms) | XML: 0.4ms) [[32mINFO [0m|# 3221] Started POST "/user/logout" for 127.0.0.1 at 2013-04-15 16:10:20 +0000 [[32mINFO [0m|# 3221] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|# 3221] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|# 3221] Authenticating with iChain mode: off [[32mINFO [0m|# 3221] Authenticated request to "/user/logout" from tom [[32mINFO [0m|# 3221] Logging out: tom [[32mINFO [0m|# 3221] Redirected to http://127.0.0.1:55226/ [[0;37mDEBUG[0m|# 3221] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|# 3221] Completed 302 Found in 1164ms (ActiveRecord: 1161.7ms | XML: 0.0ms) [[32mINFO [0m|# 3221] Started GET "/" for 127.0.0.1 at 2013-04-15 16:10:21 +0000 [[32mINFO [0m|# 3221] Processing by MainController#index as HTML [[0;37mDEBUG[0m|# 3221] Setting return_to: "/" [[0;37mDEBUG[0m|# 3221] Authenticating with iChain mode: off [[32mINFO [0m|# 3221] Anonymous request to / [[0;37mDEBUG[0m|# 3221] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] Statusmessage_2fe508b303b3ed792c174b7580cb295c [[0;37mDEBUG[0m|# 3221] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"}] ) [[0;37mDEBUG[0m|# 3221] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"4"} [[0;37mDEBUG[0m|# 3221] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=4 [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/status/messages/?limit=4 {"view"=>0.677616, "db"=>0.44765900000000003, "backend"=>0, "xml"=>0, :runtime=>5.599, :all=>10.610111} [[0;37mDEBUG[0m|# 3221] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|# 3221] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|# 3221] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|# 3221] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|# 3221] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.142351, "db"=>2.0741430000000003, "backend"=>0, "xml"=>0, :runtime=>17.005, :all=>56.085629} [[32mINFO [0m|# 3221] Rendered shared/_sign_up.html.erb (0.8ms) [[32mINFO [0m|# 3221] Rendered main/_sponsors.html.erb (0.1ms) [[32mINFO [0m|# 3221] Rendered main/_news.html.erb (0.1ms) [[32mINFO [0m|# 3221] Rendered main/_latest_updates.erb (4.0ms) [[32mINFO [0m|# 3221] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|# 3221] Rendered layouts/_header.html.erb (1.0ms) [[32mINFO [0m|# 3221] Rendered layouts/_personal_navigation.html.erb (1.1ms) [[32mINFO [0m|# 3221] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|# 3221] Completed 200 OK in 83ms (Views: 13.1ms | ActiveRecord: 0.0ms | API: 66.7ms (XML: 0.0ms , View: 1.8ms , Backend: 0.0ms , DB: 2.5ms , HTTP: 44.1ms) | XML: 1.0ms) [[32mINFO [0m|# 3221] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-04-15 16:10:21 +0000 [[32mINFO [0m|# 3221] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|# 3221] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|# 3221] Authenticating with iChain mode: off [[32mINFO [0m|# 3221] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|# 3221] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|# 3221] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|# 3221] Rendered main/_systemstatus.html.erb (1.1ms) [[32mINFO [0m|# 3221] Completed 200 OK in 3ms (Views: 1.6ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|# 3221] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|# 3221] RT http://localhost:3203/test/test_end {"view"=>0.775657, "db"=>11.822775, "backend"=>0, "xml"=>0, :runtime=>15.938, :all=>19.513329} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/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/test.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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 2

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #868
by admin＠opensuse.org 11 Apr '13

11 Apr '13

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/868/changes> Changes: [Stephan Kulow] [webui] fix the spider test - so it actually finds problems [ro] [backend] use nosource to limit amount of download for aggregated packages [ro] [backend] pass on nosource option in getbinarylist also in bs_srcserver [mls] [backend] stage metacache changes in metacache.merge [mls] [backend] fix error in addrev_meta_multiple use [mls] [backend] fix typo in nosource commit ------------------------------------------ [...truncated 571322 lines...] [[32mINFO [0m|# 7282] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 7282] Completed 200 OK in 257ms (Views: 90.1ms | ActiveRecord: 0.0ms | API: 161.2ms (XML: 0.0ms , View: 1.7ms , Backend: 0.0ms , DB: 8.1ms , HTTP: 84.9ms) | XML: 0.7ms) [[32mINFO [0m|# 7282] Started GET "/project/buildresult?project=BaseDistro&index=" for 127.0.0.1 at 2013-03-21 14:53:41 +0000 [[32mINFO [0m|# 7282] Processing by ProjectController#buildresult as */* [[32mINFO [0m|# 7282] Parameters: {"project"=>"BaseDistro", "index"=>""} [[0;37mDEBUG[0m|# 7282] Setting return_to: "/project/buildresult?project=BaseDistro&index=" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom [[0;37mDEBUG[0m|# 7282] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 7282] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>0.526182, "db"=>1.8090789999999999, "backend"=>0, "xml"=>0, :runtime=>13.499, :all=>17.014729} [[0;37mDEBUG[0m|# 7282] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e [[0;37mDEBUG[0m|# 7282] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935 [[0;37mDEBUG[0m|# 7282] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] ) [[0;37mDEBUG[0m|# 7282] params {:project=>"BaseDistro", :view=>"summary"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuil… [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.7893340000000001, "backend"=>0, "xml"=>0, :runtime=>19.373, :all=>59.264576} [[32mINFO [0m|# 7282] Rendered project/_buildstatus.html.erb (0.1ms) [[32mINFO [0m|# 7282] Completed 200 OK in 80ms (Views: 0.9ms | ActiveRecord: 0.0ms | API: 76.3ms (XML: 0.0ms , View: 0.5ms , Backend: 0.0ms , DB: 2.6ms , HTTP: 43.4ms) | XML: 0.3ms) [[32mINFO [0m|# 7282] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 14:53:41 +0000 [[32mINFO [0m|# 7282] Processing by ProjectController#show as HTML [[32mINFO [0m|# 7282] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 7282] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 7282] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 7282] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>0.509317, "db"=>1.558147, "backend"=>0, "xml"=>0, :runtime=>14.506, :all=>54.640774} [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.24296199999999998, "db"=>3.9446710000000005, "backend"=>0, "xml"=>0, :runtime=>29.45, :all=>70.911661} [[0;37mDEBUG[0m|# 7282] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.466058, "db"=>3.6690599999999995, "backend"=>0, "xml"=>0, :runtime=>36.507, :all=>75.457097} [[0;37mDEBUG[0m|# 7282] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|# 7282] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 7282] Rendered project/_tabs.html.erb (3.1ms) [[32mINFO [0m|# 7282] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|# 7282] Rendered layouts/_watch_and_search.html.erb (1.6ms) [[32mINFO [0m|# 7282] Rendered layouts/_header.html.erb (2.7ms) [[32mINFO [0m|# 7282] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|# 7282] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 7282] Completed 200 OK in 223ms (Views: 15.9ms | ActiveRecord: 0.0ms | API: 201.0ms (XML: 0.0ms , View: 1.2ms , Backend: 0.0ms , DB: 9.2ms , HTTP: 120.5ms) | XML: 0.7ms) [[32mINFO [0m|# 7282] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 14:53:41 +0000 [[32mINFO [0m|# 7282] Processing by ProjectController#toggle_watch as HTML [[32mINFO [0m|# 7282] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 7282] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 7282] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 7282] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>0.602097, "db"=>1.821777, "backend"=>0, "xml"=>0, :runtime=>14.199, :all=>17.660036} [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.32462, "db"=>4.5410889999999995, "backend"=>0, "xml"=>0, :runtime=>142.705, :all=>183.159501} [[0;37mDEBUG[0m|# 7282] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 7282] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb [[0;37mDEBUG[0m|# 7282] Remove My:Maintenance from watchlist for tom [[0;37mDEBUG[0m|# 7282] user 'tom' removes project 'My:Maintenance' from watchlist [[0;37mDEBUG[0m|# 7282] saving object Person ({:is_current=>"true", :login=>"tom"}) to api: <person> <login>tom</login> <email>tschmidt(a)suse.de</email> <realname>Thor</realname> <state>confirmed</state> <watchlist> </watchlist> </person> [[0;37mDEBUG[0m|# 7282] http_do #1: method: put url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>1.103113, "db"=>2.131732, "backend"=>0, "xml"=>0, :runtime=>17.848, :all=>23.226153999999998} [[0;37mDEBUG[0m|# 7282] [REST] find( PersonGroup, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login/group [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom/group [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom/group {"view"=>0.36086, "db"=>0.647575, "backend"=>0, "xml"=>0, :runtime=>6.675000000000001, :all=>9.944028000000001} [[0;37mDEBUG[0m|# 7282] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08 [[0;37mDEBUG[0m|# 7282] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54 [[32mINFO [0m|# 7282] Redirected to http://127.0.0.1:44015/project/show?project=My%3AMaintenance [[32mINFO [0m|# 7282] Completed 302 Found in 239ms (ActiveRecord: 0.0ms | API: 234.0ms (XML: 0.0ms , View: 2.4ms , Backend: 0.0ms , DB: 9.1ms , HTTP: 52.6ms) | XML: 0.4ms) [[32mINFO [0m|# 7282] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2013-03-21 14:53:41 +0000 [[32mINFO [0m|# 7282] Processing by ProjectController#show as HTML [[32mINFO [0m|# 7282] Parameters: {"project"=>"My:Maintenance"} [[0;37mDEBUG[0m|# 7282] Setting return_to: "/project/show?project=My%3AMaintenance" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/project/show?project=My%3AMaintenance" from tom [[0;37mDEBUG[0m|# 7282] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83 [[0;37mDEBUG[0m|# 7282] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 7282] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/person/tom {"view"=>0.46093399999999995, "db"=>0.883327, "backend"=>0, "xml"=>0, :runtime=>8.106, :all=>47.822797} [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.270922, "db"=>3.962192, "backend"=>0, "xml"=>0, :runtime=>30.964, :all=>74.47841299999999} [[0;37mDEBUG[0m|# 7282] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.5360739999999999, "db"=>3.510239, "backend"=>0, "xml"=>0, :runtime=>41.09, :all=>83.278065} [[0;37mDEBUG[0m|# 7282] data { "name": "My:Maintenance", "packages": [ ], "xml": "<project name=\"My:Maintenance\" kind=\"maintenance\">\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n <person userid=\"maintenance_coord\" role=\"maintainer\"/>\n <maintenance>\n <maintains project=\"BaseDistro\"/>\n <maintains project=\"BaseDistro2.0:LinkedUpdateProject\"/>\n <maintains project=\"BaseDistro3\"/>\n </maintenance>\n</project>\n", "incidents": [ ], "maintained_projects": [ "BaseDistro", "BaseDistro2.0:LinkedUpdateProject", "BaseDistro3" ], "linking_projects": [ ], "requests": [ ], "nr_of_problem_packages": 0 } [[0;37mDEBUG[0m|# 7282] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02 [[32mINFO [0m|# 7282] Rendered project/_tabs.html.erb (2.2ms) [[32mINFO [0m|# 7282] Rendered shared/_open_requests.html.erb (0.1ms) [[32mINFO [0m|# 7282] Rendered layouts/_watch_and_search.html.erb (1.0ms) [[32mINFO [0m|# 7282] Rendered layouts/_header.html.erb (2.1ms) [[32mINFO [0m|# 7282] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|# 7282] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|# 7282] Completed 200 OK in 225ms (Views: 14.0ms | ActiveRecord: 0.0ms | API: 205.6ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 8.4ms , HTTP: 125.4ms) | XML: 0.7ms) [[32mINFO [0m|# 7282] Started POST "/user/logout" for 127.0.0.1 at 2013-03-21 14:53:42 +0000 [[32mINFO [0m|# 7282] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|# 7282] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Authenticated request to "/user/logout" from tom [[32mINFO [0m|# 7282] Logging out: tom [[32mINFO [0m|# 7282] Redirected to http://127.0.0.1:44015/ [[0;37mDEBUG[0m|# 7282] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|# 7282] Completed 302 Found in 11ms (ActiveRecord: 9.0ms | XML: 0.0ms) [[32mINFO [0m|# 7282] Started GET "/" for 127.0.0.1 at 2013-03-21 14:53:42 +0000 [[32mINFO [0m|# 7282] Processing by MainController#index as HTML [[0;37mDEBUG[0m|# 7282] Setting return_to: "/" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Anonymous request to / [[0;37mDEBUG[0m|# 7282] free_cache [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] Statusmessage_753097322d9cc873836d791589547e90 [[0;37mDEBUG[0m|# 7282] [REST] find( Statusmessage, [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] ) [[0;37mDEBUG[0m|# 7282] params {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/status/messages/:id/?:limit [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/status/messages/?limit=5 [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/status/messages/?limit=5 {"view"=>0.812403, "db"=>0.591463, "backend"=>0, "xml"=>0, :runtime=>6.44, :all=>9.687883} [[0;37mDEBUG[0m|# 7282] free_cache [{:limit=>"6", :shared=>"true"}] LatestUpdated_ee34770dc62e51dca62baed2d5258b33 [[0;37mDEBUG[0m|# 7282] [REST] find( LatestUpdated, [{:limit=>"6", :shared=>"true"}] ) [[0;37mDEBUG[0m|# 7282] params {:limit=>"6", :shared=>"true"} [[0;37mDEBUG[0m|# 7282] uri is: http://localhost:3203/statistics/latest_updated?:limit [[0;37mDEBUG[0m|# 7282] http_do #1: method: get url: http://localhost:3203/statistics/latest_updated?limit=6 [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/statistics/latest_updated?limit=6 {"view"=>1.17608, "db"=>2.078695, "backend"=>0, "xml"=>0, :runtime=>17.068, :all=>59.391612} [[32mINFO [0m|# 7282] Rendered shared/_sign_up.html.erb (1.3ms) [[32mINFO [0m|# 7282] Rendered main/_news.html.erb (0.7ms) [[32mINFO [0m|# 7282] Rendered main/_latest_updates.erb (4.8ms) [[32mINFO [0m|# 7282] Rendered main/_countdown.html.erb (0.0ms) [[32mINFO [0m|# 7282] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|# 7282] Rendered main/_feeds.html.erb (0.0ms) [[32mINFO [0m|# 7282] Rendered layouts/_watch_and_search.html.erb (0.5ms) [[32mINFO [0m|# 7282] Rendered layouts/_header.html.erb (1.1ms) [[32mINFO [0m|# 7282] Rendered layouts/_personal_navigation.html.erb (1.3ms) [[32mINFO [0m|# 7282] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|# 7282] Completed 200 OK in 91ms (Views: 17.4ms | ActiveRecord: 0.0ms | API: 69.1ms (XML: 0.0ms , View: 2.0ms , Backend: 0.0ms , DB: 2.7ms , HTTP: 45.6ms) | XML: 1.1ms) [[32mINFO [0m|# 7282] Started GET "/main/systemstatus" for 127.0.0.1 at 2013-03-21 14:53:42 +0000 [[32mINFO [0m|# 7282] Processing by MainController#systemstatus as */* [[0;37mDEBUG[0m|# 7282] Setting return_to: "/main/systemstatus" [[0;37mDEBUG[0m|# 7282] Authenticating with iChain mode: off [[32mINFO [0m|# 7282] Anonymous request to /main/systemstatus [[0;37mDEBUG[0m|# 7282] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a [[0;37mDEBUG[0m|# 7282] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4 [[32mINFO [0m|# 7282] Rendered main/_systemstatus.html.erb (1.2ms) [[32mINFO [0m|# 7282] Completed 200 OK in 3ms (Views: 1.8ms | ActiveRecord: 0.0ms | XML: 0.3ms) [[0;37mDEBUG[0m|# 7282] http_do #1: method: post url: http://localhost:3203/test/test_end [[0;37mDEBUG[0m|# 7282] RT http://localhost:3203/test/test_end {"view"=>1.046054, "db"=>24.348969000000004, "backend"=>0, "xml"=>0, :runtime=>29.276, :all=>35.565289} + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + 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/test.log src/webui/tmp/cache src/webui/tmp/capybara 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(a)opensuse.org To contact the owner, e-mail: obs-tests+owner(a)opensuse.org

1 6