November 2012 - Open Build Service Tests

[obs-tests] Build failed in Jenkins: obs_master_testsuite_api #1142
by admin＠opensuse.org 08 Nov '12

08 Nov '12

See <http://ci.opensuse.org/job/obs_master_testsuite_api/1142/changes> Changes: [Stephan Kulow] [dist] do not update repos on travis [Stephan Kulow] [api] increase the test coverage of request model ------------------------------------------ [...truncated 132642 lines...] [[0;37mDEBUG[0m|#15945] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#15945] USER found: king [[0;37mDEBUG[0m|#15945] User king initialised [[0;37mDEBUG[0m|#15945] get_by_project_and_name {} [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'6b646534' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = x'6b646562617365' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [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|#15945] Validate XML response: #<ActionDispatch::Response:0x00000006201650> took 3ms [[32mINFO [0m|#15945] Completed 200 OK in 13ms (Views: 0.3ms | ActiveRecord: 0.9ms | Backend: 0.0ms | XML: 0.2ms) [[32mINFO [0m|#15945] Started PUT "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-11-07 23:10:37 +0100 [[32mINFO [0m|#15945] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15945] Parameters: {"<package name"=>"\"kdebase\" project=\"kde4\">\n <title>blub</title>\n <description>blub</description>\n</package>\n", "project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#15945] Validate XML request: #<ActionDispatch::Request:0x0000000660ed60> [[0;37mDEBUG[0m|#15945] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#15945] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#15945] USER found: king [[0;37mDEBUG[0m|#15945] User king initialised [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'6b646534' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = x'6b646562617365' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mProject Load (0.1ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] get_by_project_and_name {} [[0;37mDEBUG[0m|#15945] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'6b646534' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mCACHE (0.0ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = x'6b646562617365' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mCACHE (0.0ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mFlag Load (0.2ms)[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|#15945] [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|#15945] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 2 ORDER BY position[0m [[0;37mDEBUG[0m|#15945] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#15945] [1m[35mFlag Load (0.1ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2 [[0;37mDEBUG[0m|#15945] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#15945] xml_disabled? X({"name"=>"kdebase", "project"=>"kde4", "title"=>"blub", "description"=>"blub"}) [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15945] [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|#15945] [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|#15945] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15945] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15950] 2012-11-07 23:10:37 [21531]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15945] request took 0.010767171 [[0;37mDEBUG[0m|#15945] [1m[36mPackage Load (0.8ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36mPackageGroupRoleRelationship Load (0.3ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE `package_group_role_relationships`.`db_package_id` = 2[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15945] [1m[36mCACHE (0.0ms)[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|#15945] [1m[35mCACHE (0.0ms)[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|#15945] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15945] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15950] 2012-11-07 23:10:37 [21532]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15945] request took 0.009033756 [[0;37mDEBUG[0m|#15945] [1m[36mCACHE (0.0ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.5ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] ----------------- rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15945] [1m[35mCACHE (0.0ms)[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|#15945] [1m[36mCACHE (0.0ms)[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|#15945] ----------------- end rendering package kdebase ------------------------ [[0;37mDEBUG[0m|#15945] [backend] PUT: /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15950] 2012-11-07 23:10:37 [21533]: PUT /source/kde4/kdebase/_meta?user=king [[0;37mDEBUG[0m|#15945] request took 0.019052747 [[0;37mDEBUG[0m|#15945] [1m[35mCACHE (0.0ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 2 LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] Validate XML response: #<ActionDispatch::Response:0x0000000660ed10> took 0ms [[32mINFO [0m|#15945] Completed 200 OK in 84ms (Views: 0.8ms | ActiveRecord: 4.4ms | Backend: 38.9ms | XML: 0.0ms) [[32mINFO [0m|#15945] Started GET "/source/kde4/kdebase/_meta" for 127.0.0.1 at 2012-11-07 23:10:37 +0100 [[32mINFO [0m|#15945] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15945] Parameters: {"project"=>"kde4", "package"=>"kdebase"} [[0;37mDEBUG[0m|#15945] Validate XML request: #<ActionDispatch::Request:0x00000006bc5330> [[0;37mDEBUG[0m|#15945] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdebase", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15945] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#15945] [1m[35mUser Load (9.9ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#15945] USER found: king [[0;37mDEBUG[0m|#15945] User king initialised [[0;37mDEBUG[0m|#15945] get_by_project_and_name {} [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'6b646534' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = x'6b646562617365' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mProject Load (0.1ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] Validate XML response: #<ActionDispatch::Response:0x00000006bc5308> took 2ms [[32mINFO [0m|#15945] Completed 200 OK in 23ms (Views: 0.4ms | ActiveRecord: 10.7ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#15945] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-11-07 23:10:37 +0100 [[32mINFO [0m|#15945] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15945] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#15945] Validate XML request: #<ActionDispatch::Request:0x00000006cb2220> [[0;37mDEBUG[0m|#15945] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15945] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#15945] [1m[36mUser Load (0.2ms)[0m [1mSELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1[0m [[0;37mDEBUG[0m|#15945] USER found: king [[0;37mDEBUG[0m|#15945] User king initialised [[0;37mDEBUG[0m|#15945] get_by_project_and_name {} [[0;37mDEBUG[0m|#15945] [1m[35mRole Load (5.9ms)[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|#15945] [1m[36mProject Load (0.2ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'6b646534' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mPackage Load (0.2ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = x'6b64656c696273' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mProject Load (0.1ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] Validate XML response: #<ActionDispatch::Response:0x00000006cb21f8> took 2ms [[32mINFO [0m|#15945] Completed 200 OK in 17ms (Views: 0.3ms | ActiveRecord: 6.6ms | Backend: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#15945] Started PUT "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-11-07 23:10:37 +0100 [[32mINFO [0m|#15945] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15945] Parameters: {"<package name"=>"\"kdelibs\" project=\"kde4\">\n <title>blub</title>\n <description>Changed description</description>\n <devel project=\"home:Iggy\" package=\"TestPack\"/>\n <person userid=\"fredlibs\" role=\"maintainer\"/>\n <person userid=\"adrian\" role=\"reviewer\"/>\n <person userid=\"Iggy\" role=\"maintainer\"/>\n <person userid=\"Iggy\" role=\"bugowner\"/>\n <group groupid=\"test_group\" role=\"maintainer\"/>\n <group groupid=\"test_group\" role=\"reader\"/>\n <build>\n <enable/>\n </build>\n</package>\n", "project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#15945] Validate XML request: #<ActionDispatch::Request:0x00000006d873a8> [[0;37mDEBUG[0m|#15945] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#15945] [1m[35mUser Load (0.2ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#15945] USER found: king [[0;37mDEBUG[0m|#15945] User king initialised [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'6b646534' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = x'6b64656c696273' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [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|#15945] get_by_project_and_name {} [[0;37mDEBUG[0m|#15945] [1m[36mCACHE (0.0ms)[0m [1mSELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'6b646534' AND (projects.id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mCACHE (0.0ms)[0m SELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = x'6b64656c696273' AND (packages.db_project_id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[35mFlag Load (0.2ms)[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|#15945] [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|#15945] [1m[35mFlag Load (0.2ms)[0m SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 1 ORDER BY position [[0;37mDEBUG[0m|#15945] flagcheck: package has default state, checking project [[0;37mDEBUG[0m|#15945] [1m[36mFlag Load (0.2ms)[0m [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 2[0m [[0;37mDEBUG[0m|#15945] disabled_for sourceaccess repo: arch: state:enable [[0;37mDEBUG[0m|#15945] xml_disabled? X({"name"=>"kdelibs", "project"=>"kde4", "title"=>"blub", "description"=>"Changed description", "devel"=>X({"project"=>"home:Iggy", "package"=>"TestPack"}), "person"=>[X({"userid"=>"fredlibs", "role"=>"maintainer"}), X({"userid"=>"adrian", "role"=>"reviewer"}), X({"userid"=>"Iggy", "role"=>"maintainer"}), X({"userid"=>"Iggy", "role"=>"bugowner"})], "group"=>[X({"groupid"=>"test_group", "role"=>"maintainer"}), X({"groupid"=>"test_group", "role"=>"reader"})], "build"=>X({"enable"=>X({})})}) [[0;37mDEBUG[0m|#15945] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'686f6d653a49676779' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 502 AND `packages`.`name` = x'546573745061636b' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mProject Load (0.1ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 502 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[35mUser Load (0.1ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 4 LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mRole Load (0.1ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mUser Load (0.1ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`id` = 42 LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mRole Load (0.1ms)[0m [1mSELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 6 LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.4ms)[0m [1mUPDATE `packages` SET `description` = 'Changed description', `develpackage_id` = 10095, `updated_at` = '2012-11-07 22:10:37' WHERE `packages`.`id` = 1[0m [[0;37mDEBUG[0m|#15945] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15945] [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|#15945] [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|#15945] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15945] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15950] 2012-11-07 23:10:37 [21534]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15950] 2012-11-07 23:10:37 [21535]: POST /event?type=package&project=kde4&package=kdelibs [[0;37mDEBUG[0m|#15945] request took 0.033800326 [[0;37mDEBUG[0m|#15945] [1m[35mPackage Load (0.4ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] [1m[35mUser Load (0.3ms)[0m SELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] [1m[35mPackageUserRoleRelationship Load (0.2ms)[0m SELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 3 AND bs_user_id = 267) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mSQL (0.1ms)[0m [1mINSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 3)[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.0ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36mUser Load (0.1ms)[0m [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'49676779' LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36mPackageUserRoleRelationship Load (0.1ms)[0m [1mSELECT `package_user_role_relationships`.* FROM `package_user_role_relationships` WHERE (db_package_id = 1 AND role_id = 4 AND bs_user_id = 267) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mSQL (0.1ms)[0m INSERT INTO `package_user_role_relationships` (`bs_user_id`, `db_package_id`, `role_id`) VALUES (267, 1, 4) [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[36mGroup Load (0.1ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`id` = 99 LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mRole Load (0.1ms)[0m SELECT `roles`.* FROM `roles` WHERE `roles`.`id` = 3 LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mGroup Load (0.2ms)[0m [1mSELECT `groups`.* FROM `groups` WHERE `groups`.`title` = 'test_group' LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36mPackageGroupRoleRelationship Load (0.1ms)[0m [1mSELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` WHERE (db_package_id = 1 AND role_id = 7 AND bs_group_id = 99) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mSQL (0.2ms)[0m INSERT INTO `package_group_role_relationships` (`bs_group_id`, `db_package_id`, `role_id`) VALUES (99, 1, 7) [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.1ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`id` = 1 AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.2ms)[0m SELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1 [[0;37mDEBUG[0m|#15945] [1m[36mCACHE (0.0ms)[0m [1mSELECT MAX(`flags`.`position`) AS max_id FROM `flags` WHERE `flags`.`db_package_id` = 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mSQL (0.2ms)[0m INSERT INTO `flags` (`architecture_id`, `db_package_id`, `db_project_id`, `flag`, `position`, `repo`, `status`) VALUES (NULL, 1, NULL, 'build', 1, NULL, 'enable') [[0;37mDEBUG[0m|#15945] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15945] [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` = 1[0m [[0;37mDEBUG[0m|#15945] [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|#15945] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15945] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15950] 2012-11-07 23:10:37 [21536]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15950] 2012-11-07 23:10:37 [21537]: POST /event?type=package&project=kde4&package=kdelibs [[0;37mDEBUG[0m|#15945] request took 0.048629312 [[0;37mDEBUG[0m|#15945] [1m[36mPackage Load (0.6ms)[0m [1mSELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35m (0.1ms)[0m RELEASE SAVEPOINT active_record_1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.0ms)[0m [1mSAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] ----------------- rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15945] [1m[35mCACHE (0.0ms)[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|#15945] [1m[36mCACHE (0.0ms)[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|#15945] ----------------- end rendering package kdelibs ------------------------ [[0;37mDEBUG[0m|#15945] [backend] PUT: /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15950] 2012-11-07 23:10:37 [21538]: PUT /source/kde4/kdelibs/_meta?user=king [[0;37mDEBUG[0m|#15945] request took 0.023911754 [[0;37mDEBUG[0m|#15945] [1m[35mCACHE (0.0ms)[0m SELECT packages.*, ( @activity:=( packages.activity_index - POWER( TIME_TO_SEC( TIMEDIFF( NOW(), packages.updated_at ))/86400, 1.55 ) /10 ) ) AS act_tmp, IF( @activity<0, 0, @activity ) AS activity_value FROM `packages` WHERE id = 1 LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36m (0.2ms)[0m [1mRELEASE SAVEPOINT active_record_1[0m [[0;37mDEBUG[0m|#15945] Validate XML response: #<ActionDispatch::Response:0x00000006d87358> took 1ms [[32mINFO [0m|#15945] Completed 200 OK in 184ms (Views: 0.8ms | ActiveRecord: 8.6ms | Backend: 106.3ms | XML: 0.0ms) [[32mINFO [0m|#15945] Started GET "/source/kde4/kdelibs/_meta" for 127.0.0.1 at 2012-11-07 23:10:37 +0100 [[32mINFO [0m|#15945] Processing by SourceController#package_meta as XML [[32mINFO [0m|#15945] Parameters: {"project"=>"kde4", "package"=>"kdelibs"} [[0;37mDEBUG[0m|#15945] Validate XML request: #<ActionDispatch::Request:0x000000074b20d8> [[0;37mDEBUG[0m|#15945] no schema found, skipping validation for {"format"=>"xml", "controller"=>"source", "action"=>"package_meta", "project"=>"kde4", "package"=>"kdelibs", "method"=>"GET", "type"=>"request"} [[0;37mDEBUG[0m|#15945] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [[0;37mDEBUG[0m|#15945] [1m[35mUser Load (3.1ms)[0m SELECT `users`.* FROM `users` WHERE (login = 'king') LIMIT 1 [[0;37mDEBUG[0m|#15945] USER found: king [[0;37mDEBUG[0m|#15945] User king initialised [[0;37mDEBUG[0m|#15945] get_by_project_and_name {} [[0;37mDEBUG[0m|#15945] [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|#15945] [1m[35mProject Load (0.2ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`name` = x'6b646534' AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] [1m[36mPackage Load (0.2ms)[0m [1mSELECT `packages`.* FROM `packages` WHERE `packages`.`db_project_id` = 2 AND `packages`.`name` = x'6b64656c696273' AND (packages.db_project_id not in (0)) LIMIT 1[0m [[0;37mDEBUG[0m|#15945] [1m[35mProject Load (0.1ms)[0m SELECT `projects`.* FROM `projects` WHERE `projects`.`id` = 2 AND (projects.id not in (0)) LIMIT 1 [[0;37mDEBUG[0m|#15945] Validate XML response: #<ActionDispatch::Response:0x000000074b20b0> took 2ms [[32mINFO [0m|#15945] Completed 200 OK in 14ms (Views: 0.4ms | ActiveRecord: 3.9ms | Backend: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#15945] [1m[36m (6.8ms)[0m [1mROLLBACK[0m [[0;37mDEBUG[0m|#15945] kill 15950 + echo + cleanup + echo 'Killing backend processes' Killing backend processes + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/> + egrep 'perl|ruby' USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_api/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. sh + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/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 3

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #555
by admin＠opensuse.org 07 Nov '12

07 Nov '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/555/changes> Changes: [Stephan Kulow] [dist] update to current gems (I need xmlhash 1.3.2 fix) ------------------------------------------ Started by an SCM change Started by an SCM change Building in workspace <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> Checkout:workspace / <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> - hudson.remoting.LocalChannel@74e474e4 Using strategy: Default Last Built Revision: Revision 7a8cb4c107a64e84f54c8776dc5cd3dc0f49b0d8 (origin/master) Checkout:workspace / <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> - hudson.remoting.LocalChannel@74e474e4 Fetching changes from 1 remote Git repository Fetching upstream changes from git://github.com/openSUSE/open-build-service.git Commencing build of Revision e7f053b78dcfdca38ae49bd0899d590e920fed4b (origin/master) Checking out Revision e7f053b78dcfdca38ae49bd0899d590e920fed4b (origin/master) [locks-and-latches] Checking to see if we really have the locks [locks-and-latches] Have all the locks, build can start [workspace] $ /bin/sh -xe /tmp/hudson2716832468573483075.sh + sh dist/ci/obs_testsuite_webui.sh ++ dirname dist/ci/obs_testsuite_webui.sh + . dist/ci/obs_testsuite_common.sh + setup_git + echo 'Checking status' Checking status + git status # Not currently on any branch. # Untracked files: # (use "git add <file>..." to include in what will be committed) # # src/api/Gemfile.lock.orig # src/webui/Gemfile.lock.orig # src/webui/db/structure.sql # src/webui/public/themes/ # src/webui/results/ # src/webui/webrat.log nothing added to commit but untracked files present (use "git add" to track) + echo 'Setup git submodules' Setup git submodules + git submodule init + git submodule update + echo 'Setup backend configuration template' Setup backend configuration template + sed -i -e 's|my $hostname = .*$|my $hostname = '\''localhost'\'';|' -e 's|our $bsuser = '\''obsrun'\'';|our $bsuser = '\''jenkins'\'';|' -e 's|our $bsgroup = '\''obsrun'\'';|our $bsgroup = '\''jenkins'\'';|' src/backend/BSConfig.pm.template + cp src/backend/BSConfig.pm.template src/backend/BSConfig.pm + echo 'Set environment variables' Set environment variables + export RAILS_ENV=test + RAILS_ENV=test + ret=0 + setup_api + echo 'Enter API rails root' Enter API rails root + cd src/api + echo 'Setup database configuration' Setup database configuration + cp config/database.yml.example config/database.yml + sed -i 's|database: api|database: ci_api|' config/database.yml + echo 'Setup additional configuration' Setup additional configuration + cp config/options.yml.example config/options.yml + echo 'Install missing gems locally' Install missing gems locally + mv Gemfile.lock Gemfile.lock.orig + bundle list Gems included by the bundle: * actionmailer (3.2.8) * actionpack (3.2.8) * activemodel (3.2.8) * activerecord (3.2.8) * activesupport (3.2.8) * arel (3.0.2) * builder (3.0.0) * bundler (1.2.1) * ci_reporter (1.7.3) * daemons (1.1.9) * delayed_job (3.0.3) * delayed_job_active_record (0.3.3) * erubis (2.7.0) * eventmachine (1.0.0) * exception_notification (3.0.0) * faraday (0.8.4) * faraday_middleware (0.9.0) * fast_xs (0.8.0) * hashie (1.2.0) * hike (1.2.1) * http_parser.rb (0.5.3) * i18n (0.6.1) * journey (1.0.4) * json (1.7.5) * mail (2.4.4) * memcache-client (1.8.5) * mime-types (1.19) * minitest (4.1.0) * multi_json (1.3.6) * multipart-post (1.1.5) * mysql2 (0.3.11) * nokogiri (1.5.5) * pkg-config (1.1.4) * polyglot (0.3.3) * rack (1.4.1) * rack-cache (1.2) * rack-ssl (1.3.2) * rack-test (0.6.2) * rails-api (0.0.2) * railties (3.2.8) * rake (0.9.2.2) * rdoc (3.12) * simple_oauth (0.1.9) * simplecov (0.7.1) * simplecov-html (0.7.1) * simplecov-rcov (0.2.3) * sprockets (2.1.3) * thor (0.16.0) * tilt (1.3.3) * tinder (1.9.1) * treetop (1.4.12) * twitter-stream (0.1.16) * tzinfo (0.3.34) * xmlhash (1.3.1) * yajl-ruby (1.1.0) + diff -u Gemfile.lock.orig Gemfile.lock --- Gemfile.lock.orig 2012-11-06 22:11:05.000000000 +0100 +++ Gemfile.lock 2012-11-06 22:11:06.000000000 +0100 @@ -57,8 +57,8 @@ treetop (~> 1.4.8) memcache-client (1.8.5) mime-types (1.19) - minitest (4.2.0) - multi_json (1.3.7) + minitest (4.1.0) + multi_json (1.3.6) multipart-post (1.1.5) mysql2 (0.3.11) nokogiri (1.5.5) @@ -115,8 +115,8 @@ eventmachine (>= 0.12.8) http_parser.rb (~> 0.5.1) simple_oauth (~> 0.1.4) - tzinfo (0.3.35) - xmlhash (1.3.2) + tzinfo (0.3.34) + xmlhash (1.3.1) pkg-config yajl-ruby (1.1.0) + : + chmod a+x script/start_test_backend + echo 'Initialize test database, run migrations, load seed data' Initialize test database, run migrations, load seed data + rake --trace db:drop db:create db:setup db:migrate ** Invoke db:drop (first_time) ** Invoke db:load_config (first_time) ** Execute db:load_config ** Invoke rails_env (first_time) ** Execute rails_env ** Execute db:drop ** Invoke db:create (first_time) ** Invoke db:load_config ** Invoke rails_env ** Execute db:create ** Invoke db:setup (first_time) ** Execute db:setup ** Invoke db:structure:load (first_time) ** Invoke environment (first_time) ** Execute environment ** Invoke db:load_config ** Execute db:structure:load ** Invoke db:seed (first_time) ** Execute db:seed ** Invoke db:abort_if_pending_migrations (first_time) ** Invoke environment ** Invoke db:load_config ** Execute db:abort_if_pending_migrations ** Invoke db:migrate (first_time) ** Invoke environment ** Invoke db:load_config ** Execute db:migrate ** Invoke db:_dump (first_time) ** Execute db:_dump ** Invoke db:structure:dump (first_time) ** Invoke environment ** Invoke db:load_config ** Execute db:structure:dump Seeding architectures table... Seeding roles table... Seeding users table... Seeding roles_users table... Seeding static_permissions table... Seeding static permissions for admin role in roles_static_permissions table... Seeding static permissions for maintainer role in roles_static_permissions table... Seeding static permissions for reader role in roles_static_permissions table... Seeding static permissions for downloader role in roles_static_permissions table... Seeding attrib_namespaces table... Seeding attrib_types table... Seeding db_project_type table by loading test fixtures Seeding issue trackers ... + cd ../.. + setup_webui + echo 'Enter Webui rails root' Enter Webui rails root + cd src/webui + echo 'Setup database configuration' Setup database configuration + cp config/database.yml.example config/database.yml + echo 'Setup additional configuration' Setup additional configuration + cp config/options.yml.example config/options.yml + echo 'Install missing gems locally' Install missing gems locally + mv Gemfile.lock Gemfile.lock.orig + bundle list [31mCould not find gem 'xmlhash (>= 1.3.2) ruby' in the gems available on this machine.[0m 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-testsuite #414
by admin＠opensuse.org 07 Nov '12

07 Nov '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/414/changes> Changes: [Stephan Kulow] [dist] update to current gems (I need xmlhash 1.3.2 fix) ------------------------------------------ Started by an SCM change Started by an SCM change Building in workspace <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/ws/> Checkout:workspace / <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/ws/> - hudson.remoting.LocalChannel@74e474e4 Using strategy: Default Last Built Revision: Revision 7a8cb4c107a64e84f54c8776dc5cd3dc0f49b0d8 (origin/master) Checkout:workspace / <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/ws/> - hudson.remoting.LocalChannel@74e474e4 Fetching changes from 1 remote Git repository Fetching upstream changes from git://github.com/openSUSE/open-build-service.git Commencing build of Revision e7f053b78dcfdca38ae49bd0899d590e920fed4b (origin/master) Checking out Revision e7f053b78dcfdca38ae49bd0899d590e920fed4b (origin/master) Cleaning workspace [locks-and-latches] Checking to see if we really have the locks [locks-and-latches] Have all the locks, build can start [workspace] $ /bin/sh -xe /tmp/hudson2749881315411909900.sh + sh dist/ci/obs_testsuite_webui-testsuite.sh ++ dirname dist/ci/obs_testsuite_webui-testsuite.sh + . dist/ci/obs_testsuite_common.sh + setup_git + echo 'Checking status' Checking status + git status # Not currently on any branch. nothing to commit (working directory clean) + echo 'Setup git submodules' Setup git submodules + git submodule init + git submodule update + echo 'Setup backend configuration template' Setup backend configuration template + sed -i -e 's|my $hostname = .*$|my $hostname = '\''localhost'\'';|' -e 's|our $bsuser = '\''obsrun'\'';|our $bsuser = '\''jenkins'\'';|' -e 's|our $bsgroup = '\''obsrun'\'';|our $bsgroup = '\''jenkins'\'';|' src/backend/BSConfig.pm.template + cp src/backend/BSConfig.pm.template src/backend/BSConfig.pm + echo 'Set environment variables' Set environment variables + export RAILS_ENV=test + RAILS_ENV=test + ret=0 + setup_api + echo 'Enter API rails root' Enter API rails root + cd src/api + echo 'Setup database configuration' Setup database configuration + cp config/database.yml.example config/database.yml + sed -i 's|database: api|database: ci_api|' config/database.yml + echo 'Setup additional configuration' Setup additional configuration + cp config/options.yml.example config/options.yml + echo 'Install missing gems locally' Install missing gems locally + mv Gemfile.lock Gemfile.lock.orig + bundle list Gems included by the bundle: * actionmailer (3.2.8) * actionpack (3.2.8) * activemodel (3.2.8) * activerecord (3.2.8) * activesupport (3.2.8) * arel (3.0.2) * builder (3.0.0) * bundler (1.2.1) * ci_reporter (1.7.3) * daemons (1.1.9) * delayed_job (3.0.3) * delayed_job_active_record (0.3.3) * erubis (2.7.0) * eventmachine (1.0.0) * exception_notification (3.0.0) * faraday (0.8.4) * faraday_middleware (0.9.0) * fast_xs (0.8.0) * hashie (1.2.0) * hike (1.2.1) * http_parser.rb (0.5.3) * i18n (0.6.1) * journey (1.0.4) * json (1.7.5) * mail (2.4.4) * memcache-client (1.8.5) * mime-types (1.19) * minitest (4.1.0) * multi_json (1.3.6) * multipart-post (1.1.5) * mysql2 (0.3.11) * nokogiri (1.5.5) * pkg-config (1.1.4) * polyglot (0.3.3) * rack (1.4.1) * rack-cache (1.2) * rack-ssl (1.3.2) * rack-test (0.6.2) * rails-api (0.0.2) * railties (3.2.8) * rake (0.9.2.2) * rdoc (3.12) * simple_oauth (0.1.9) * simplecov (0.7.1) * simplecov-html (0.7.1) * simplecov-rcov (0.2.3) * sprockets (2.1.3) * thor (0.16.0) * tilt (1.3.3) * tinder (1.9.1) * treetop (1.4.12) * twitter-stream (0.1.16) * tzinfo (0.3.34) * xmlhash (1.3.1) * yajl-ruby (1.1.0) + diff -u Gemfile.lock.orig Gemfile.lock --- Gemfile.lock.orig 2012-11-06 22:11:14.000000000 +0100 +++ Gemfile.lock 2012-11-06 22:11:16.000000000 +0100 @@ -57,8 +57,8 @@ treetop (~> 1.4.8) memcache-client (1.8.5) mime-types (1.19) - minitest (4.2.0) - multi_json (1.3.7) + minitest (4.1.0) + multi_json (1.3.6) multipart-post (1.1.5) mysql2 (0.3.11) nokogiri (1.5.5) @@ -115,8 +115,8 @@ eventmachine (>= 0.12.8) http_parser.rb (~> 0.5.1) simple_oauth (~> 0.1.4) - tzinfo (0.3.35) - xmlhash (1.3.2) + tzinfo (0.3.34) + xmlhash (1.3.1) pkg-config yajl-ruby (1.1.0) + : + chmod a+x script/start_test_backend + echo 'Initialize test database, run migrations, load seed data' Initialize test database, run migrations, load seed data + rake --trace db:drop db:create db:setup db:migrate ** Invoke db:drop (first_time) ** Invoke db:load_config (first_time) ** Execute db:load_config ** Invoke rails_env (first_time) ** Execute rails_env ** Execute db:drop ** Invoke db:create (first_time) ** Invoke db:load_config ** Invoke rails_env ** Execute db:create ** Invoke db:setup (first_time) ** Execute db:setup ** Invoke db:structure:load (first_time) ** Invoke environment (first_time) ** Execute environment ** Invoke db:load_config ** Execute db:structure:load ** Invoke db:seed (first_time) ** Execute db:seed ** Invoke db:abort_if_pending_migrations (first_time) ** Invoke environment ** Invoke db:load_config ** Execute db:abort_if_pending_migrations ** Invoke db:migrate (first_time) ** Invoke environment ** Invoke db:load_config ** Execute db:migrate ** Invoke db:_dump (first_time) ** Execute db:_dump ** Invoke db:structure:dump (first_time) ** Invoke environment ** Invoke db:load_config ** Execute db:structure:dump Seeding architectures table... Seeding roles table... Seeding users table... Seeding roles_users table... Seeding static_permissions table... Seeding static permissions for admin role in roles_static_permissions table... Seeding static permissions for maintainer role in roles_static_permissions table... Seeding static permissions for reader role in roles_static_permissions table... Seeding static permissions for downloader role in roles_static_permissions table... Seeding attrib_namespaces table... Seeding attrib_types table... Seeding db_project_type table by loading test fixtures Seeding issue trackers ... + cd ../.. + setup_webui + echo 'Enter Webui rails root' Enter Webui rails root + cd src/webui + echo 'Setup database configuration' Setup database configuration + cp config/database.yml.example config/database.yml + echo 'Setup additional configuration' Setup additional configuration + cp config/options.yml.example config/options.yml + echo 'Install missing gems locally' Install missing gems locally + mv Gemfile.lock Gemfile.lock.orig + bundle list [31mCould not find gem 'xmlhash (>= 1.3.2) ruby' in the gems available on this machine.[0m 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 #547
by admin＠opensuse.org 02 Nov '12

02 Nov '12

See <http://ci.opensuse.org/job/obs_master_testsuite_webui/547/changes> Changes: [Stephan Kulow] [webui-testsuite] add a work around for long standing selenium bug [Stephan Kulow] [webui] sort packages in the project overview [Stephan Kulow] [webui] Fixed testsuite class [Stephan Kulow] [webui] Moving computed data to a constant Hash [Stephan Kulow] [api] Cleanup in User.states ------------------------------------------ [...truncated 48362 lines...] [[0;37mDEBUG[0m|#32024] http_do #1: method: get url: http://localhost:3203/person/unknown [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/person/unknown {"view"=>0.0, "db"=>8.010057, "backend"=>0, "xml"=>0, :runtime=>16.014, :all=>55.982548} [[0;37mDEBUG[0m|#32024] Person.find( {:login=>"unknown"} ) did not find anything, return nil [[32mINFO [0m|#32024] Rendered package/_commit_item.html.erb (130.6ms) [[32mINFO [0m|#32024] Rendered package/_files_view.html.erb (136.0ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (4.0ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 779ms (Views: 290.5ms | ActiveRecord: 0.0ms | API: 644.3ms (XML: 0.0ms , View: 0.8ms , Backend: 0.0ms , DB: 79.6ms , HTTP: 294.2ms) | XML: 0.7ms) [[32mINFO [0m|#32024] Started GET "/package/view_file?expand=0&file=_link&package=pack2_linked&project=BaseDistro2.0%3ALinkedUpdateProject" for 127.0.0.1 at 2012-11-01 22:04:47 +0100 [[32mINFO [0m|#32024] Processing by PackageController#view_file as HTML [[32mINFO [0m|#32024] Parameters: {"expand"=>"0", "file"=>"_link", "package"=>"pack2_linked", "project"=>"BaseDistro2.0:LinkedUpdateProject"} [[0;37mDEBUG[0m|#32024] Setting return_to: "/package/view_file?expand=0&file=_link&package=pack2_linked&project=BaseDistro2.0%3ALinkedUpdateProject" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to /package/view_file?expand=0&file=_link&package=pack2_linked&project=BaseDistro2.0%3ALinkedUpdateProject [[0;37mDEBUG[0m|#32024] --> get_source: {:project=>"BaseDistro2.0:LinkedUpdateProject", :package=>"pack2_linked", :filename=>"_link", :rev=>nil, :expand=>"0"} [[0;37mDEBUG[0m|#32024] --> get_source path: /source/BaseDistro2.0:LinkedUpdateProject/pack2_linked/_link?expand=0 [[0;37mDEBUG[0m|#32024] --> direct_http url: #<URI::Generic:0x000000015664a8 URL:http://localhost:3203/source/BaseDistro2.0:LinkedUpdateProject/pack2_linked/_link?expand=0> [[0;37mDEBUG[0m|#32024] http_do #1: method: GET url: http://localhost:3203/source/BaseDistro2.0:LinkedUpdateProject/pack2_linked… [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/source/BaseDistro2.0:LinkedUpdateProject/pack2_linked… {"view"=>nil, "db"=>16.189807, "backend"=>0, "xml"=>0, :runtime=>56.067, :all=>57.816995000000006} [[32mINFO [0m|#32024] Rendered package/_tabs.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered shared/_editor.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (3.0ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (0.8ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 88ms (Views: 26.3ms | ActiveRecord: 0.0ms | API: 57.8ms (XML: 0.0ms , Backend: 0.0ms , DB: 16.2ms , HTTP: 1.7ms) | XML: 0.6ms) [[32mINFO [0m|#32024] Started GET "/package/view_file?file=my_file&package=bdpack&project=BinaryprotectedProject" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by PackageController#view_file as HTML [[32mINFO [0m|#32024] Parameters: {"file"=>"my_file", "package"=>"bdpack", "project"=>"BinaryprotectedProject"} [[0;37mDEBUG[0m|#32024] Setting return_to: "/package/view_file?file=my_file&package=bdpack&project=BinaryprotectedProject" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to /package/view_file?file=my_file&package=bdpack&project=BinaryprotectedProject [[0;37mDEBUG[0m|#32024] --> get_source: {:project=>"BinaryprotectedProject", :package=>"bdpack", :filename=>"my_file", :rev=>nil, :expand=>nil} [[0;37mDEBUG[0m|#32024] --> get_source path: /source/BinaryprotectedProject/bdpack/my_file? [[0;37mDEBUG[0m|#32024] --> direct_http url: #<URI::Generic:0x0000000673ea28 URL:http://localhost:3203/source/BinaryprotectedProject/bdpack/my_file?> [[0;37mDEBUG[0m|#32024] http_do #1: method: GET url: http://localhost:3203/source/BinaryprotectedProject/bdpack/my_file? [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/source/BinaryprotectedProject/bdpack/my_file? {"view"=>nil, "db"=>1.727693, "backend"=>0, "xml"=>0, :runtime=>28.139, :all=>31.424078} [[32mINFO [0m|#32024] Rendered package/_tabs.html.erb (0.2ms) [[32mINFO [0m|#32024] Rendered shared/_editor.html.erb (3.4ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 74ms (Views: 24.0ms | ActiveRecord: 0.0ms | API: 31.4ms (XML: 0.0ms , Backend: 0.0ms , DB: 1.7ms , HTTP: 3.3ms) | XML: 0.0ms) [[32mINFO [0m|#32024] Started GET "/package/binaries?arch=i586&package=pack&project=SourceprotectedProject&repository=repo" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by PackageController#binaries as HTML [[32mINFO [0m|#32024] Parameters: {"arch"=>"i586", "package"=>"pack", "project"=>"SourceprotectedProject", "repository"=>"repo"} [[0;37mDEBUG[0m|#32024] Setting return_to: "/package/binaries?arch=i586&package=pack&project=SourceprotectedProject&repository=repo" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to /package/binaries?arch=i586&package=pack&project=SourceprotectedProject&repository=repo [[32mINFO [0m|#32024] Rendered package/_tabs.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered shared/_download_repository_link.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (16.0ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (16.5ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 32ms (Views: 30.2ms | ActiveRecord: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#32024] Started GET "/package/binary?arch=i586&filename=delete_me-1.0-1.i586.rpm&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by PackageController#binary as HTML [[32mINFO [0m|#32024] Parameters: {"arch"=>"i586", "filename"=>"delete_me-1.0-1.i586.rpm", "package"=>"aggregate", "project"=>"home:adrian:ProtectionTest", "repository"=>"repo"} [[0;37mDEBUG[0m|#32024] Setting return_to: "/package/binary?arch=i586&filename=delete_me-1.0-1.i586.rpm&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to /package/binary?arch=i586&filename=delete_me-1.0-1.i586.rpm&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo [[0;37mDEBUG[0m|#32024] [REST] find( Fileinfo, [{:project=>"home:adrian:ProtectionTest", :package=>"aggregate", :repository=>"repo", :arch=>"i586", :filename=>"delete_me-1.0-1.i586.rpm", :view=>"fileinfo_ext"}] ) [[0;37mDEBUG[0m|#32024] params {:project=>"home:adrian:ProtectionTest", :package=>"aggregate", :repository=>"repo", :arch=>"i586", :filename=>"delete_me-1.0-1.i586.rpm", :view=>"fileinfo_ext"} [[0;37mDEBUG[0m|#32024] uri is: http://localhost:3203/build/:project/:repository/:arch/:package/:filename?:… [[0;37mDEBUG[0m|#32024] http_do #1: method: get url: http://localhost:3203/build/home:adrian:ProtectionTest/repo/i586/aggregate/… [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/build/home:adrian:ProtectionTest/repo/i586/aggregate/… {"view"=>nil, "db"=>11.348728999999999, "backend"=>0, "xml"=>0, :runtime=>91.99000000000001, :all=>92.417087} [[0;37mDEBUG[0m|#32024] Checking url: http://download.opensuse.org/repositories/home:/adrian:/ProtectionTest/repo… [[0;37mDEBUG[0m|#32024] accepting format:text/html [[32mINFO [0m|#32024] Rendered package/_tabs.html.erb (12.0ms) [[32mINFO [0m|#32024] Rendered package/_deps.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (1.4ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 138ms (Views: 23.2ms | ActiveRecord: 0.0ms | API: 92.4ms (XML: 0.0ms , Backend: 0.0ms , DB: 11.3ms , HTTP: 0.4ms) | XML: 0.0ms) [[32mINFO [0m|#32024] Started GET "/package/binary?arch=i586&filename=package-1.0-1.i586.rpm&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by PackageController#binary as HTML [[32mINFO [0m|#32024] Parameters: {"arch"=>"i586", "filename"=>"package-1.0-1.i586.rpm", "package"=>"aggregate", "project"=>"home:adrian:ProtectionTest", "repository"=>"repo"} [[0;37mDEBUG[0m|#32024] Setting return_to: "/package/binary?arch=i586&filename=package-1.0-1.i586.rpm&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to /package/binary?arch=i586&filename=package-1.0-1.i586.rpm&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo [[0;37mDEBUG[0m|#32024] [REST] find( Fileinfo, [{:project=>"home:adrian:ProtectionTest", :package=>"aggregate", :repository=>"repo", :arch=>"i586", :filename=>"package-1.0-1.i586.rpm", :view=>"fileinfo_ext"}] ) [[0;37mDEBUG[0m|#32024] params {:project=>"home:adrian:ProtectionTest", :package=>"aggregate", :repository=>"repo", :arch=>"i586", :filename=>"package-1.0-1.i586.rpm", :view=>"fileinfo_ext"} [[0;37mDEBUG[0m|#32024] uri is: http://localhost:3203/build/:project/:repository/:arch/:package/:filename?:… [[0;37mDEBUG[0m|#32024] http_do #1: method: get url: http://localhost:3203/build/home:adrian:ProtectionTest/repo/i586/aggregate/… [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/build/home:adrian:ProtectionTest/repo/i586/aggregate/… {"view"=>nil, "db"=>12.024134, "backend"=>0, "xml"=>0, :runtime=>120.632, :all=>124.141975} [[0;37mDEBUG[0m|#32024] Checking url: http://download.opensuse.org/repositories/home:/adrian:/ProtectionTest/repo… [[0;37mDEBUG[0m|#32024] accepting format:text/html [[32mINFO [0m|#32024] Rendered package/_tabs.html.erb (8.0ms) [[32mINFO [0m|#32024] Rendered package/_deps.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (4.0ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 176ms (Views: 31.0ms | ActiveRecord: 0.0ms | API: 124.1ms (XML: 0.0ms , Backend: 0.0ms , DB: 12.0ms , HTTP: 3.5ms) | XML: 0.7ms) [[32mINFO [0m|#32024] Started GET "/package/view_file?file=_aggregate&package=aggregate&project=home%3Aadrian%3AProtectionTest" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by PackageController#view_file as HTML [[32mINFO [0m|#32024] Parameters: {"file"=>"_aggregate", "package"=>"aggregate", "project"=>"home:adrian:ProtectionTest"} [[0;37mDEBUG[0m|#32024] Setting return_to: "/package/view_file?file=_aggregate&package=aggregate&project=home%3Aadrian%3AProtectionTest" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to /package/view_file?file=_aggregate&package=aggregate&project=home%3Aadrian%3AProtectionTest [[0;37mDEBUG[0m|#32024] --> get_source: {:project=>"home:adrian:ProtectionTest", :package=>"aggregate", :filename=>"_aggregate", :rev=>nil, :expand=>nil} [[0;37mDEBUG[0m|#32024] --> get_source path: /source/home:adrian:ProtectionTest/aggregate/_aggregate? [[0;37mDEBUG[0m|#32024] --> direct_http url: #<URI::Generic:0x000000074d7a18 URL:http://localhost:3203/source/home:adrian:ProtectionTest/aggregate/_aggregate?> [[0;37mDEBUG[0m|#32024] http_do #1: method: GET url: http://localhost:3203/source/home:adrian:ProtectionTest/aggregate/_aggregat… [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/source/home:adrian:ProtectionTest/aggregate/_aggregat… {"view"=>nil, "db"=>14.865103, "backend"=>0, "xml"=>0, :runtime=>28.001, :all=>29.506457} [[32mINFO [0m|#32024] Rendered package/_tabs.html.erb (2.5ms) [[32mINFO [0m|#32024] Rendered shared/_editor.html.erb (0.5ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (2.6ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (1.2ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 54ms (Views: 22.0ms | ActiveRecord: 0.0ms | API: 29.5ms (XML: 0.0ms , Backend: 0.0ms , DB: 14.9ms , HTTP: 1.5ms) | XML: 0.0ms) [[32mINFO [0m|#32024] Started GET "/package/binaries?arch=i586&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by PackageController#binaries as HTML [[32mINFO [0m|#32024] Parameters: {"arch"=>"i586", "package"=>"aggregate", "project"=>"home:adrian:ProtectionTest", "repository"=>"repo"} [[0;37mDEBUG[0m|#32024] Setting return_to: "/package/binaries?arch=i586&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to /package/binaries?arch=i586&package=aggregate&project=home%3Aadrian%3AProtectionTest&repository=repo [[32mINFO [0m|#32024] Rendered package/_tabs.html.erb (4.0ms) [[32mINFO [0m|#32024] Rendered shared/_download_repository_link.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (2.9ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 29ms (Views: 27.4ms | ActiveRecord: 0.0ms | XML: 0.0ms) [[32mINFO [0m|#32024] Started POST "/user/logout" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#32024] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to /user/logout [[32mINFO [0m|#32024] Logging out: [[32mINFO [0m|#32024] Redirected to http://example.org/ [[32mINFO [0m|#32024] Completed 302 Found in 2ms (ActiveRecord: 0.0ms | XML: 0.0ms) [[0;37mDEBUG[0m|#32024] [1m[35m (1.8ms)[0m rollback transaction [[0;37mDEBUG[0m|#32024] [1m[36m (0.0ms)[0m [1mbegin transaction[0m [[32mINFO [0m|#32024] Started POST "/user/do_login" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by UserController#do_login as HTML [[32mINFO [0m|#32024] Parameters: {"username"=>"tom", "password"=>"[FILTERED]", "return_to_path"=>"/"} [[0;37mDEBUG[0m|#32024] Setting return_to: "/" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Anonymous request to / [[0;37mDEBUG[0m|#32024] Doing form authorization to login user tom [[0;37mDEBUG[0m|#32024] [REST] find( Person, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#32024] params {:login=>"tom"} [[0;37mDEBUG[0m|#32024] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32024] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/person/tom {"view"=>0.66173, "db"=>4.169167, "backend"=>0, "xml"=>0, :runtime=>10.315, :all=>13.659975} [[32mINFO [0m|#32024] Redirected to http://example.org/ [[32mINFO [0m|#32024] Completed 302 Found in 14ms (ActiveRecord: 0.0ms | API: 13.7ms (XML: 0.0ms , View: 0.7ms , Backend: 0.0ms , DB: 4.2ms , HTTP: 3.3ms) | XML: 0.0ms) [[32mINFO [0m|#32024] Started GET "/" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by MainController#index as HTML [[0;37mDEBUG[0m|#32024] Setting return_to: "/" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Authenticated request to "/" from tom [[0;37mDEBUG[0m|#32024] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#32024] params {:is_current=>"true", :login=>"tom"} [[0;37mDEBUG[0m|#32024] uri is: http://localhost:3203/person/:login [[0;37mDEBUG[0m|#32024] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/person/tom {"view"=>0.625744, "db"=>0.09346600000000001, "backend"=>0, "xml"=>0, :runtime=>9.176, :all=>50.530778} [[0;37mDEBUG[0m|#32024] --> direct_http url: #<URI::Generic:0x00000005c084b0 URL:http://localhost:3203/webui/person_requests_that_need_work?login=tom> [[0;37mDEBUG[0m|#32024] http_do #1: method: GET url: http://localhost:3203/webui/person_requests_that_need_work?login=tom [[0;37mDEBUG[0m|#32024] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.0, "db"=>9.897514, "backend"=>0, "xml"=>0, :runtime=>58.62, :all=>100.0026} [[0;37mDEBUG[0m|#32024] data { "declined": [ ], "new": [ ], "reviews": [ 1000 ] } [[32mINFO [0m|#32024] Rendered main/_news.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered main/_contact.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered main/_latest_updates.erb (19.5ms) [[32mINFO [0m|#32024] Rendered main/_countdown.html.erb (0.1ms) [[32mINFO [0m|#32024] Rendered main/_sponsors.html.erb (0.0ms) [[32mINFO [0m|#32024] Rendered main/_feeds.html.erb (0.1ms) [[32mINFO [0m|#32024] Rendered layouts/_watch_and_search.html.erb (0.7ms) [[32mINFO [0m|#32024] Rendered layouts/_header.html.erb (1.5ms) [[32mINFO [0m|#32024] Rendered layouts/_personal_navigation.html.erb (1.0ms) [[32mINFO [0m|#32024] Rendered layouts/_flash.html.erb (0.1ms) [[32mINFO [0m|#32024] Rendered layouts/_sponsor.html.erb (0.0ms) [[32mINFO [0m|#32024] Completed 200 OK in 196ms (Views: 41.6ms | ActiveRecord: 0.0ms | API: 150.5ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 10.0ms , HTTP: 82.7ms) | XML: 4.4ms) [[32mINFO [0m|#32024] Started POST "/user/logout" for 127.0.0.1 at 2012-11-01 22:04:48 +0100 [[32mINFO [0m|#32024] Processing by UserController#logout as HTML [[0;37mDEBUG[0m|#32024] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#32024] Authenticating with iChain mode: off [[32mINFO [0m|#32024] Authenticated request to "/user/logout" from tom [[32mINFO [0m|#32024] Logging out: tom [[32mINFO [0m|#32024] Redirected to http://example.org/ [[32mINFO [0m|#32024] Completed 302 Found in 5ms (ActiveRecord: 2.9ms | XML: 0.0ms) [[0;37mDEBUG[0m|#32024] [1m[35m (0.2ms)[0m rollback transaction + echo + cleanup + echo 'Killing backend processes' Killing backend processes + egrep 'perl|ruby' + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> USER PID ACCESS COMMAND <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>: jenkins ..c.. sh jenkins ..c.. sh jenkins ..c.. sh + echo 'Remove log/tmp files to save disc space' Remove log/tmp files to save disc space + rm -rf src/api/log/backend_access.log src/api/log/test.log src/api/tmp/backend_config src/api/tmp/backend_data src/api/tmp/cache src/api/tmp/pids src/api/tmp/sessions src/api/tmp/sockets src/webui/log/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 1