[obs-tests] Build failed in Jenkins: obs_testsuite_api_master #300

See <http://ci.opensuse.org/job/obs_testsuite_api_master/300/changes> Changes: [mls] [backend] do not hold job lock when the built result is uploaded ------------------------------------------ [...truncated 115930 lines...] [DEBUG|#16198] Validate XML response: #<ActionController::Response:0x7fddef0d29e0> [DEBUG|#16198] no schema found, skipping validation for methodgetactionpackage_wizardprojectkde4typeresponsepackagekdelibscontrollerwizard [INFO |#16198] Completed in 90ms (View: 4, DB: 4) | 200 OK [http://www.example.com/source/kde4/kdelibs/_wizard] [INFO |#16198] Processing WizardController#package_wizard (for 127.0.0.1 at 2011-12-12 15:48:42) [GET] [INFO |#16198] Parameters: {"project"=>"HiddenProject", "package"=>"pack"} [DEBUG|#16198] Validate XML request: #<ActionController::Request:0x7fddeee97a68> [DEBUG|#16198] no schema found, skipping validation for methodgetactionpackage_wizardprojectHiddenProjecttyperequestpackagepackcontrollerwizard [DEBUG|#16198] AUTH: ["Basic", "ZnJlZGxpYnM6Z2Vyw7ZsbGhlaW1lcg=="] [DEBUG|#16198] User Load (0.4ms) SELECT * FROM `users` WHERE (login = 'fredlibs') LIMIT 1 [DEBUG|#16198] USER found: fredlibs [DEBUG|#16198] User fredlibs initialised [DEBUG|#16198] DbProject Load (15.3ms) SELECT * FROM `db_projects` WHERE (name = BINARY 'home:fredlibs') LIMIT 1 [DEBUG|#16198] Role Load (0.3ms) SELECT * FROM `roles` WHERE (`roles`.`title` = 'Admin') LIMIT 1 [DEBUG|#16198] Role Load (0.2ms) SELECT `roles`.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`id` = 1) AND (`roles_users`.user_id = 4 ) LIMIT 1 [DEBUG|#16198] DbProject Load (0.2ms) SELECT * FROM `db_projects` WHERE (name = BINARY 'HiddenProject') LIMIT 1 [DEBUG|#16198] SQL (0.3ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] SQL (0.2ms) SELECT count(*) AS count_all FROM `project_group_role_relationships` WHERE (db_project_id = 3000) AND (`project_group_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] ProjectGroupRoleRelationship Load (0.2ms) SELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000))  [DEBUG|#16198] User Load (0.2ms) SELECT * FROM `users` WHERE (`users`.`id` = 4)  [DEBUG|#16198] Group Load (0.2ms) SELECT * FROM `groups` WHERE (`groups`.`id` = 99)  [DEBUG|#16198] Group Load (0.2ms) SELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 4 AND (id = 99))  [DEBUG|#16198] SQL (0.3ms) SELECT count(DISTINCT `project_user_role_relationships`.id) AS count_first FROM `project_user_role_relationships` LEFT OUTER JOIN `roles` ON `roles`.id = `project_user_role_relationships`.role_id WHERE (db_project_id = 3000 and bs_user_id = 4) AND (`project_user_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] DbProject::UnknownObjectError (HiddenProject): app/models/db_project.rb:232:in `get_by_name' app/models/db_package.rb:149:in `get_by_project_and_name' app/controllers/wizard_controller.rb:9:in `package_wizard' test/test_helper.rb:21:in `get' /test/functional/wizard_controller_test.rb:25:in `test_wizard' /usr/lib64/ruby/1.8/test/unit/testsuite.rb:34:in `run' /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `each' /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `run' /usr/lib64/ruby/1.8/test/unit/testsuite.rb:34:in `run' /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `each' /usr/lib64/ruby/1.8/test/unit/testsuite.rb:33:in `run' /usr/lib64/ruby/1.8/test/unit/ui/testrunnermediator.rb:46:in `run_suite' /usr/lib64/ruby/1.8/test/unit/ui/console/testrunner.rb:67:in `start_mediator' /usr/lib64/ruby/1.8/test/unit/ui/console/testrunner.rb:41:in `start' /usr/lib64/ruby/1.8/test/unit/ui/testrunnerutilities.rb:29:in `run' /usr/lib64/ruby/1.8/test/unit/autorunner.rb:216:in `run' /usr/lib64/ruby/1.8/test/unit/autorunner.rb:12:in `run' /usr/lib64/ruby/1.8/test/unit.rb:278 /usr/bin/rcov:19 [ERROR|#16198] ReadAccessError: HiddenProject [INFO |#16198] Rendering status [INFO |#16198] errorcode 'unknown_project' - HiddenProject [INFO |#16198] Rendering status (404) [INFO |#16198] Processing WizardController#package_wizard (for 127.0.0.1 at 2011-12-12 15:48:42) [GET] [INFO |#16198] Parameters: {"project"=>"HiddenProject", "package"=>"pack"} [DEBUG|#16198] Validate XML request: #<ActionController::Request:0x7fddeed74f00> [DEBUG|#16198] no schema found, skipping validation for methodgetactionpackage_wizardprojectHiddenProjecttyperequestpackagepackcontrollerwizard [DEBUG|#16198] AUTH: ["Basic", "aGlkZGVuX2hvbWVyOmhvbWVy"] [DEBUG|#16198] User Load (0.5ms) SELECT * FROM `users` WHERE (login = 'hidden_homer') LIMIT 1 [DEBUG|#16198] USER found: hidden_homer [DEBUG|#16198] User hidden_homer initialised [DEBUG|#16198] DbProject Load (0.2ms) SELECT * FROM `db_projects` WHERE (name = BINARY 'home:hidden_homer') LIMIT 1 [DEBUG|#16198] Role Load (0.2ms) SELECT * FROM `roles` WHERE (title = BINARY 'maintainer') LIMIT 1 [DEBUG|#16198] adding user: hidden_homer, maintainer [DEBUG|#16198] SQL (0.1ms) SAVEPOINT active_record_1 [DEBUG|#16198] ProjectUserRoleRelationship Load (0.2ms) SELECT * FROM `project_user_role_relationships` WHERE (db_project_id = NULL AND role_id = 3 AND bs_user_id = 46) LIMIT 1 [DEBUG|#16198] DbProject Create (0.5ms) INSERT INTO `db_projects` (`name`, `created_at`, `title`, `maintenance_project_id`, `updated_at`, `remoteurl`, `type_id`, `description`, `develproject_id`, `remoteproject`) VALUES(x'686f6d653a68696464656e5f686f6d6572', '2011-12-12 15:48:42', 'hidden_homer\'s Home Project', NULL, '2011-12-12 15:48:42', NULL, NULL, 'Please add a suitable description and don\'t forget to add some repositories you want to build your packages against (just click on \'Repositories\' above). Have fun!', NULL, NULL) [DEBUG|#16198] ProjectUserRoleRelationship Create (1.0ms) INSERT INTO `project_user_role_relationships` (`db_project_id`, `role_id`, `bs_user_id`) VALUES(5258, 3, 46) [DEBUG|#16198] SQL (0.1ms) RELEASE SAVEPOINT active_record_1 [DEBUG|#16198] SQL (0.1ms) SAVEPOINT active_record_1 [DEBUG|#16198] SQL (0.1ms) RELEASE SAVEPOINT active_record_1 [DEBUG|#16198] ----------------- rendering project home:hidden_homer ------------------------ [DEBUG|#16198] LinkedProject Load (0.3ms) SELECT * FROM `linked_projects` WHERE (`linked_projects`.db_project_id = 5258) ORDER BY position [DEBUG|#16198] User Load (0.3ms) SELECT bu.*, r.title AS role_name FROM `users` bu, project_user_role_relationships purr, roles r WHERE (bu.id = purr.bs_user_id AND purr.db_project_id = 5258 AND r.id = purr.role_id)  [DEBUG|#16198] Group Load (0.2ms) SELECT bg.*, r.title AS role_name FROM `groups` bg, project_group_role_relationships pgrr, roles r WHERE (bg.id = pgrr.bs_group_id AND pgrr.db_project_id = 5258 AND r.id = pgrr.role_id)  [DEBUG|#16198] Download Load (0.2ms) SELECT * FROM `downloads` WHERE (`downloads`.db_project_id = 5258)  [DEBUG|#16198] Flag Load (0.2ms) SELECT * FROM `flags` WHERE (`flags`.db_project_id = 5258)  [DEBUG|#16198] Repository Load (0.2ms) SELECT * FROM `repositories` WHERE (`repositories`.db_project_id = 5258 AND (ISNULL(remote_project_name)))  [DEBUG|#16198] DbProject Load (0.4ms) SELECT `db_projects`.* FROM `db_projects` LEFT JOIN flags f ON f.db_project_id = db_projects.id AND (ISNULL(f.flag) OR flag = 'access') LEFT OUTER JOIN project_user_role_relationships ur ON ur.db_project_id = db_projects.id LEFT OUTER JOIN users u ON ur.bs_user_id = u.id WHERE (`db_projects`.maintenance_project_id = 5258) GROUP BY db_projects.id [DEBUG|#16198] ----------------- end rendering project home:hidden_homer ------------------------ [DEBUG|#16198] [backend] PUT: /source/home:hidden_homer/_meta?user=hidden_homer [DEBUG|#16200] 2011-12-12 15:48:42 [20245]: PUT /source/home:hidden_homer/_meta?user=hidden_homer [DEBUG|#16198] Role Load (0.3ms) SELECT * FROM `roles` WHERE (`roles`.`title` = 'Admin') LIMIT 1 [DEBUG|#16198] Role Load (0.2ms) SELECT `roles`.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`id` = 1) AND (`roles_users`.user_id = 46 ) LIMIT 1 [DEBUG|#16198] DbProject Load (0.2ms) SELECT * FROM `db_projects` WHERE (name = BINARY 'HiddenProject') LIMIT 1 [DEBUG|#16198] SQL (0.3ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] SQL (0.2ms) SELECT count(*) AS count_all FROM `project_group_role_relationships` WHERE (db_project_id = 3000) AND (`project_group_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] ProjectGroupRoleRelationship Load (0.2ms) SELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000))  [DEBUG|#16198] User Load (0.2ms) SELECT * FROM `users` WHERE (`users`.`id` = 46)  [DEBUG|#16198] Group Load (0.2ms) SELECT * FROM `groups` WHERE (`groups`.`id` = 99)  [DEBUG|#16198] Group Load (0.2ms) SELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99))  [DEBUG|#16198] SQL (0.3ms) SELECT count(DISTINCT `project_user_role_relationships`.id) AS count_first FROM `project_user_role_relationships` LEFT OUTER JOIN `roles` ON `roles`.id = `project_user_role_relationships`.role_id WHERE (db_project_id = 3000 and bs_user_id = 46) AND (`project_user_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `project_group_role_relationships` WHERE (db_project_id = 3000) AND (`project_group_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000))  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `users` WHERE (`users`.`id` = 46)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` WHERE (`groups`.`id` = 99)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99))  [DEBUG|#16198] CACHE (0.0ms) SELECT count(DISTINCT `project_user_role_relationships`.id) AS count_first FROM `project_user_role_relationships` LEFT OUTER JOIN `roles` ON `roles`.id = `project_user_role_relationships`.role_id WHERE (db_project_id = 3000 and bs_user_id = 46) AND (`project_user_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] DbPackage Load (0.2ms) SELECT * FROM `db_packages` WHERE (name = BINARY 'pack') AND (`db_packages`.db_project_id = 3000) LIMIT 1 [DEBUG|#16198] DbProject Load (7.6ms) SELECT * FROM `db_projects` WHERE (`db_projects`.`id` = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `project_group_role_relationships` WHERE (db_project_id = 3000) AND (`project_group_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000))  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `users` WHERE (`users`.`id` = 46)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` WHERE (`groups`.`id` = 99)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99))  [DEBUG|#16198] CACHE (0.0ms) SELECT count(DISTINCT `project_user_role_relationships`.id) AS count_first FROM `project_user_role_relationships` LEFT OUTER JOIN `roles` ON `roles`.id = `project_user_role_relationships`.role_id WHERE (db_project_id = 3000 and bs_user_id = 46) AND (`project_user_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `project_group_role_relationships` WHERE (db_project_id = 3000) AND (`project_group_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000))  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `users` WHERE (`users`.`id` = 46)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` WHERE (`groups`.`id` = 99)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99))  [DEBUG|#16198] CACHE (0.0ms) SELECT count(DISTINCT `project_user_role_relationships`.id) AS count_first FROM `project_user_role_relationships` LEFT OUTER JOIN `roles` ON `roles`.id = `project_user_role_relationships`.role_id WHERE (db_project_id = 3000 and bs_user_id = 46) AND (`project_user_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `project_group_role_relationships` WHERE (db_project_id = 3000) AND (`project_group_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000))  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `users` WHERE (`users`.`id` = 46)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` WHERE (`groups`.`id` = 99)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99))  [DEBUG|#16198] CACHE (0.0ms) SELECT count(DISTINCT `project_user_role_relationships`.id) AS count_first FROM `project_user_role_relationships` LEFT OUTER JOIN `roles` ON `roles`.id = `project_user_role_relationships`.role_id WHERE (db_project_id = 3000 and bs_user_id = 46) AND (`project_user_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `project_group_role_relationships` WHERE (db_project_id = 3000) AND (`project_group_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `project_group_role_relationships` WHERE (`project_group_role_relationships`.db_project_id = 3000 AND (db_project_id = 3000))  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `users` WHERE (`users`.`id` = 46)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` WHERE (`groups`.`id` = 99)  [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 AND (id = 99))  [DEBUG|#16198] CACHE (0.0ms) SELECT count(DISTINCT `project_user_role_relationships`.id) AS count_first FROM `project_user_role_relationships` LEFT OUTER JOIN `roles` ON `roles`.id = `project_user_role_relationships`.role_id WHERE (db_project_id = 3000 and bs_user_id = 46) AND (`project_user_role_relationships`.db_project_id = 3000)  [DEBUG|#16198] Flag Load (0.4ms) SELECT * FROM `flags` WHERE (`flags`.db_package_id = 11000) ORDER BY position [DEBUG|#16198] flagcheck: package has default state, checking project [DEBUG|#16198] Flag Load (0.2ms) SELECT * FROM `flags` WHERE (`flags`.db_project_id = 3000)  [DEBUG|#16198] disabled_for sourceaccess repo: arch: state:enable [DEBUG|#16198] disabled_for sourceaccess repo: arch: state:enable [DEBUG|#16198] Flag Load (0.3ms) SELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_package_id = 11000) ORDER BY position LIMIT 1 [DEBUG|#16198] Flag Load (0.2ms) SELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_project_id = 3000) LIMIT 1 [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `roles` WHERE (`roles`.`title` = 'Admin') LIMIT 1 [DEBUG|#16198] CACHE (0.0ms) SELECT `roles`.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`id` = 1) AND (`roles_users`.user_id = 46 ) LIMIT 1 [DEBUG|#16198] Role Load (0.2ms) SELECT * FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles_users`.user_id = 46 )  [DEBUG|#16198] Group Load (0.2ms) SELECT * FROM `groups` INNER JOIN `groups_users` ON `groups`.id = `groups_users`.group_id WHERE (`groups_users`.user_id = 46 )  [DEBUG|#16198] running local permission check: user hidden_homer, package pack, permission 'change_package' [DEBUG|#16198] PackageUserRoleRelationship Load (0.3ms) SELECT * FROM `package_user_role_relationships` WHERE (`package_user_role_relationships`.bs_user_id = 46 AND (db_package_id = 11000))  [DEBUG|#16198] PackageGroupRoleRelationship Load (0.2ms) SELECT `package_group_role_relationships`.* FROM `package_group_role_relationships` LEFT OUTER JOIN groups_users ug ON ug.group_id = bs_group_id WHERE (ug.user_id = 46 and db_package_id = 11000)  [DEBUG|#16198] permission not found, trying parent project 'HiddenProject' [DEBUG|#16198] running local permission check: user hidden_homer, project HiddenProject, permission 'change_package' [DEBUG|#16198] ProjectUserRoleRelationship Load (0.2ms) SELECT * FROM `project_user_role_relationships` WHERE (`project_user_role_relationships`.bs_user_id = 46 AND (db_project_id = 3000 ))  [DEBUG|#16198] Role Load (0.2ms) SELECT * FROM `roles` WHERE (`roles`.`id` = 3)  [DEBUG|#16198] ProjectGroupRoleRelationship Load (0.2ms) SELECT `project_group_role_relationships`.* FROM `project_group_role_relationships` LEFT OUTER JOIN groups_users ug ON ug.group_id = bs_group_id WHERE (ug.user_id = 46 and db_project_id = 3000)  [DEBUG|#16198] StaticPermission Load (0.2ms) SELECT * FROM `static_permissions` INNER JOIN `roles_static_permissions` ON `static_permissions`.id = `roles_static_permissions`.static_permission_id WHERE (`roles_static_permissions`.role_id = 3 AND (title = 'change_package')) LIMIT 1 [DEBUG|#16198] permission granted [DEBUG|#16198] package_wizard, {"method"=>"get", "action"=>"package_wizard", "project"=>"HiddenProject", "type"=>"request", "package"=>"pack", "controller"=>"wizard"} [DEBUG|#16198] --> direct_http url: #<URI::Generic:0x7fddeeb9e3e8 URL:http://localhost:3200/source/HiddenProject/pack/wizard.xml> [DEBUG|#16198] http_do #1: method: GET url: http://localhost:3200/source/HiddenProject/pack/wizard.xml [DEBUG|#16200] 2011-12-12 15:48:42 [20246]: GET /source/HiddenProject/pack/wizard.xml? [DEBUG|#16198] Request took 0.011241 seconds [DEBUG|#16198] questions: [{"sourcefile"=>{"label"=>"Source file to download", "type"=>"url"}}, {"generator"=>{"label"=>"Generate build description", "type"=>"select", "options"=>[{"-"=>{"label"=>"skip"}}, {"qmake"=>{"label"=>"qmake based code generator"}}]}}] [DEBUG|#16198] --> direct_http url: #<URI::Generic:0x7fddeeb96b48 URL:http://localhost:3200/source/HiddenProject/pack/wizard.xml> [DEBUG|#16198] http_do #1: method: PUT url: http://localhost:3200/source/HiddenProject/pack/wizard.xml [DEBUG|#16200] 127.0.0.1: 404 wizard.xml: no such file [DEBUG|#16200] 2011-12-12 15:48:42 [20247]: PUT /source/HiddenProject/pack/wizard.xml? [DEBUG|#16200] 2011-12-12 15:48:42 [20248]: POST /event?type=package&project=HiddenProject&package=pack [DEBUG|#16198] Request took 0.038897 seconds [INFO |#16198] Rendering wizard (200) [DEBUG|#16198] Validate XML response: #<ActionController::Response:0x7fddeed74a50> [DEBUG|#16198] no schema found, skipping validation for methodgetactionpackage_wizardprojectHiddenProjecttyperesponsepackagepackcontrollerwizard [INFO |#16198] Completed in 172ms (View: 3, DB: 18) | 200 OK [http://www.example.com/source/HiddenProject/pack/_wizard] [INFO |#16198] Processing WizardController#package_wizard (for 127.0.0.1 at 2011-12-12 15:48:42) [GET] [INFO |#16198] Parameters: {"project"=>"HiddenProject", "package"=>"pack"} [DEBUG|#16198] Validate XML request: #<ActionController::Request:0x7fddeeb60b10> [DEBUG|#16198] no schema found, skipping validation for methodgetactionpackage_wizardprojectHiddenProjecttyperequestpackagepackcontrollerwizard [DEBUG|#16198] AUTH: ["Basic", "a2luZzpzdW5mbG93ZXI="] [DEBUG|#16198] User Load (0.3ms) SELECT * FROM `users` WHERE (login = 'king') LIMIT 1 [DEBUG|#16198] USER found: king [DEBUG|#16198] User king initialised [DEBUG|#16198] DbProject Load (0.2ms) SELECT * FROM `db_projects` WHERE (name = BINARY 'home:king') LIMIT 1 [DEBUG|#16198] Role Load (0.2ms) SELECT * FROM `roles` WHERE (title = BINARY 'maintainer') LIMIT 1 [DEBUG|#16198] adding user: king, maintainer [DEBUG|#16198] SQL (0.1ms) SAVEPOINT active_record_1 [DEBUG|#16198] ProjectUserRoleRelationship Load (0.2ms) SELECT * FROM `project_user_role_relationships` WHERE (db_project_id = NULL AND role_id = 3 AND bs_user_id = 2) LIMIT 1 [DEBUG|#16198] DbProject Create (23.4ms) INSERT INTO `db_projects` (`name`, `created_at`, `title`, `maintenance_project_id`, `updated_at`, `remoteurl`, `type_id`, `description`, `develproject_id`, `remoteproject`) VALUES(x'686f6d653a6b696e67', '2011-12-12 15:48:42', 'king\'s Home Project', NULL, '2011-12-12 15:48:42', NULL, NULL, 'Please add a suitable description and don\'t forget to add some repositories you want to build your packages against (just click on \'Repositories\' above). Have fun!', NULL, NULL) [DEBUG|#16198] ProjectUserRoleRelationship Create (0.3ms) INSERT INTO `project_user_role_relationships` (`db_project_id`, `role_id`, `bs_user_id`) VALUES(5259, 3, 2) [DEBUG|#16198] SQL (0.1ms) RELEASE SAVEPOINT active_record_1 [DEBUG|#16198] SQL (0.1ms) SAVEPOINT active_record_1 [DEBUG|#16198] SQL (0.1ms) RELEASE SAVEPOINT active_record_1 [DEBUG|#16198] ----------------- rendering project home:king ------------------------ [DEBUG|#16198] LinkedProject Load (0.3ms) SELECT * FROM `linked_projects` WHERE (`linked_projects`.db_project_id = 5259) ORDER BY position [DEBUG|#16198] User Load (0.3ms) SELECT bu.*, r.title AS role_name FROM `users` bu, project_user_role_relationships purr, roles r WHERE (bu.id = purr.bs_user_id AND purr.db_project_id = 5259 AND r.id = purr.role_id)  [DEBUG|#16198] Group Load (0.2ms) SELECT bg.*, r.title AS role_name FROM `groups` bg, project_group_role_relationships pgrr, roles r WHERE (bg.id = pgrr.bs_group_id AND pgrr.db_project_id = 5259 AND r.id = pgrr.role_id)  [DEBUG|#16198] Download Load (0.2ms) SELECT * FROM `downloads` WHERE (`downloads`.db_project_id = 5259)  [DEBUG|#16198] Flag Load (0.2ms) SELECT * FROM `flags` WHERE (`flags`.db_project_id = 5259)  [DEBUG|#16198] Repository Load (0.2ms) SELECT * FROM `repositories` WHERE (`repositories`.db_project_id = 5259 AND (ISNULL(remote_project_name)))  [DEBUG|#16198] DbProject Load (0.3ms) SELECT `db_projects`.* FROM `db_projects` LEFT JOIN flags f ON f.db_project_id = db_projects.id AND (ISNULL(f.flag) OR flag = 'access') LEFT OUTER JOIN project_user_role_relationships ur ON ur.db_project_id = db_projects.id LEFT OUTER JOIN users u ON ur.bs_user_id = u.id WHERE (`db_projects`.maintenance_project_id = 5259) GROUP BY db_projects.id [DEBUG|#16198] ----------------- end rendering project home:king ------------------------ [DEBUG|#16198] [backend] PUT: /source/home:king/_meta?user=king [DEBUG|#16200] 2011-12-12 15:48:43 [20249]: PUT /source/home:king/_meta?user=king [DEBUG|#16198] Role Load (0.3ms) SELECT * FROM `roles` WHERE (`roles`.`title` = 'Admin') LIMIT 1 [DEBUG|#16198] Role Load (0.2ms) SELECT `roles`.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`id` = 1) AND (`roles_users`.user_id = 2 ) LIMIT 1 [DEBUG|#16198] DbProject Load (0.3ms) SELECT * FROM `db_projects` WHERE (name = BINARY 'HiddenProject') LIMIT 1 [DEBUG|#16198] SQL (0.4ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] DbPackage Load (0.3ms) SELECT * FROM `db_packages` WHERE (name = BINARY 'pack') AND (`db_packages`.db_project_id = 3000) LIMIT 1 [DEBUG|#16198] DbProject Load (0.2ms) SELECT * FROM `db_projects` WHERE (`db_projects`.`id` = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] CACHE (0.0ms) SELECT count(*) AS count_all FROM `flags` WHERE (db_project_id = 3000 and flag = 'access' and status = 'disable') AND (`flags`.db_project_id = 3000)  [DEBUG|#16198] Flag Load (0.3ms) SELECT * FROM `flags` WHERE (`flags`.db_package_id = 11000) ORDER BY position [DEBUG|#16198] flagcheck: package has default state, checking project [DEBUG|#16198] Flag Load (0.2ms) SELECT * FROM `flags` WHERE (`flags`.db_project_id = 3000)  [DEBUG|#16198] disabled_for sourceaccess repo: arch: state:enable [DEBUG|#16198] disabled_for sourceaccess repo: arch: state:enable [DEBUG|#16198] Flag Load (0.3ms) SELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_package_id = 11000) ORDER BY position LIMIT 1 [DEBUG|#16198] Flag Load (0.2ms) SELECT * FROM `flags` WHERE (`flags`.`status` = 'enable' AND `flags`.`flag` = 'lock') AND (`flags`.db_project_id = 3000) LIMIT 1 [DEBUG|#16198] CACHE (0.0ms) SELECT * FROM `roles` WHERE (`roles`.`title` = 'Admin') LIMIT 1 [DEBUG|#16198] CACHE (0.0ms) SELECT `roles`.id FROM `roles` INNER JOIN `roles_users` ON `roles`.id = `roles_users`.role_id WHERE (`roles`.`id` = 1) AND (`roles_users`.user_id = 2 ) LIMIT 1 [DEBUG|#16198] package_wizard, {"method"=>"get", "action"=>"package_wizard", "project"=>"HiddenProject", "type"=>"request", "package"=>"pack", "controller"=>"wizard"} [DEBUG|#16198] --> direct_http url: #<URI::Generic:0x7fddeefcbbc8 URL:http://localhost:3200/source/HiddenProject/pack/wizard.xml> [DEBUG|#16198] http_do #1: method: GET url: http://localhost:3200/source/HiddenProject/pack/wizard.xml [DEBUG|#16200] 2011-12-12 15:48:43 [20250]: GET /source/HiddenProject/pack/wizard.xml? [DEBUG|#16198] Request took 0.011998 seconds [DEBUG|#16198] questions: [{"sourcefile"=>{"label"=>"Source file to download", "type"=>"url"}}, {"generator"=>{"label"=>"Generate build description", "type"=>"select", "options"=>[{"-"=>{"label"=>"skip"}}, {"qmake"=>{"label"=>"qmake based code generator"}}]}}] [DEBUG|#16198] --> direct_http url: #<URI::Generic:0x7fddeef9cc60 URL:http://localhost:3200/source/HiddenProject/pack/wizard.xml> [DEBUG|#16198] http_do #1: method: PUT url: http://localhost:3200/source/HiddenProject/pack/wizard.xml [DEBUG|#16200] 2011-12-12 15:48:43 [20251]: PUT /source/HiddenProject/pack/wizard.xml? [DEBUG|#16200] 2011-12-12 15:48:43 [20252]: POST /event?type=package&project=HiddenProject&package=pack [DEBUG|#16198] Request took 0.058642 seconds [INFO |#16198] Rendering wizard (200) [DEBUG|#16198] Validate XML response: #<ActionController::Response:0x7fddeeb60840> [DEBUG|#16198] no schema found, skipping validation for methodgetactionpackage_wizardprojectHiddenProjecttyperesponsepackagepackcontrollerwizard [INFO |#16198] Completed in 356ms (View: 3, DB: 30) | 200 OK [http://www.example.com/source/HiddenProject/pack/_wizard] [DEBUG|#16198] SQL (122.2ms) ROLLBACK [DEBUG|#16198] kill 16200 Remove log/tmp files to save disc space rm: cannot remove `src/api/tmp/cache/.gitignore': Permission denied rm: cannot remove `src/api/tmp/pids/.gitignore': Permission denied rm: cannot remove `src/api/tmp/sessions/.gitignore': Permission denied rm: cannot remove `src/api/tmp/sockets/.gitignore': Permission denied Build step 'Execute shell' marked build as failure [locks-and-latches] Releasing all the locks [locks-and-latches] All the locks released Archiving artifacts Recording test results Publishing rails notes report... Publishing rails stats report... Build failed, skipping rcov coverage report Build step 'Publish Rcov report' marked build as failure -- To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org