[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui-testsuite #45

1 Apr 2012

      See <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/45/changes>

Changes:

[Stephan Kulow] [webui] remove delayed job stuff. it was only in use for delayed

[Stephan Kulow] [webui] fix regression caused by "selected tab depends on controller too"

------------------------------------------
[...truncated 127283 lines...]
[[0;37mDEBUG[0m|#18207] http_do #1: method: POST url: http://localhost:3203/source/BinaryprotectedProject/bdpack?cmd=diff&view=xml...
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mGroup Load (0.3ms)[0m  [1mSELECT DISTINCT `groups`.* FROM `groups` INNER JOIN `groups_users` ON `groups`.`id` = `groups_users`.`group_id` WHERE `groups_users`.`user_id` = 5[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] running local permission check: user _nobody_, project BinaryprotectedProject, permission 'download_binaries'
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mProjectUserRoleRelationship Load (0.2ms)[0m  SELECT `project_user_role_relationships`.* FROM `project_user_role_relationships` WHERE `project_user_role_relationships`.`bs_user_id` = 5 AND (db_project_id = 3002 )
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mProjectGroupRoleRelationship Load (0.3ms)[0m  [1mSELECT `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 = 5 and db_project_id = 3002)[0m
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] errorcode 'download_binary_no_permission' - No permission to download binaries from package bdpack, project BinaryprotectedProject
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209]   Rendered status.xml.builder (0.5ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Completed 403 Forbidden in 25ms (Views: 1.4ms | ActiveRecord: 3.0ms | Backend: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Started GET "/source/BinaryprotectedProject/bdpack" for 127.0.0.1 at Sun Apr 01 16:34:15 +0200 2012
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Processing by SourceController#index_package as XML
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209]   Parameters: {"package"=>"bdpack", "project"=>"BinaryprotectedProject"}
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] Validate XML request: #<ActionDispatch::Request:0x7f605fa22af8>
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] no schema found, skipping validation for {"type"=>"request", "package"=>"bdpack", "format"=>"xml", "project"=>"BinaryprotectedProject", "controller"=>"source", "method"=>"GET", "action"=>"index_package"}
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] AUTH: nil
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mUser Load (0.8ms)[0m  SELECT `users`.* FROM `users` WHERE `users`.`login` = x'5f6e6f626f64795f' LIMIT 1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] User _nobody_ initialised
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mRole Load (0.4ms)[0m  [1mSELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 5 AND `roles`.`title` = 'Admin' LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mDbProject Load (0.2ms)[0m  SELECT `db_projects`.* FROM `db_projects` WHERE (name = BINARY 'BinaryprotectedProject') LIMIT 1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mDbPackage Load (0.3ms)[0m  [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 3002 AND (name = BINARY 'bdpack') LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mDbProject Load (0.2ms)[0m  SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 3002 LIMIT 1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mFlag Load (0.2ms)[0m  [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 11007 ORDER BY position[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mFlag Load (0.2ms)[0m  SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 3002
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] [backend] VOLLEY: /source/BinaryprotectedProject/bdpack?
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18218] 2012-04-01 16:34:15 [20104]: GET /source/BinaryprotectedProject/bdpack?
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Sent file /tmp/volley20120401-18209-h9egho-0 (0.2ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Completed 200 OK in 24ms (ActiveRecord: 2.4ms | Backend: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Started POST "/source/BinaryprotectedProject/bdpack?cmd=diff&view=xml&withissues=1&linkrev=base&rev=2&expand=1" for 127.0.0.1 at Sun Apr 01 16:34:15 +0200 2012
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Processing by SourceController#index_package as XML
[[0;37mDEBUG[0m|#18207] Request took 0.447652 seconds
[[32mINFO [0m|#18207] Rendering template within layouts/application
[[32mINFO [0m|#18207] Rendering package/rdiff
[[0;37mDEBUG[0m|#18207] Cache hit: parent_projects_BinaryprotectedProject ({:expires_in=>7 days})
[[0;37mDEBUG[0m|#18207] Rendered package/_tabs (3.5ms)
[[0;37mDEBUG[0m|#18207] Rendered shared/_editor (0.7ms)
[[0;37mDEBUG[0m|#18207] Rendered shared/_sourcediff (3.5ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_watch_and_search (0.7ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_header (1.5ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_personal_navigation (1.8ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#18207] Completed in 505ms (View: 16, DB: 0, API: 516, XML: 1) | 200 OK [http://localhost/package/rdiff?linkrev=base&package=bdpack&project=Binarypro...]

[[32mINFO [0m|#18207] Processing PackageController#repositories (for 127.0.0.1 at 2012-04-01 16:34:16) [GET]
[[32mINFO [0m|#18207]   Parameters: {"project"=>"BinaryprotectedProject", "package"=>"bdpack"}
[[0;37mDEBUG[0m|#18207] Setting return_to: "/package/repositories?package=bdpack&project=BinaryprotectedProject"
[[0;37mDEBUG[0m|#18207] Authenticating with iChain mode: off
[[32mINFO [0m|#18207] Anonymous request to /package/repositories?package=bdpack&project=BinaryprotectedProject
[[0;37mDEBUG[0m|#18207] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#18207] Project.find( 300 seconds, BinaryprotectedProject, )
[[0;37mDEBUG[0m|#18207] Cache hit: Project_ceb033cc783987344fb1117f7f7cef83 ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#18207] Package.find( 1800 seconds, bdpack, projectBinaryprotectedProject)
[[0;37mDEBUG[0m|#18207] Cache hit: Package_6835e2f14fbff7760eac4182041a9b3f ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#18207] Cache hit: package_reviews_BinaryprotectedProject_bdpack ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#18207] Package.find( 1800 seconds, bdpack, projectBinaryprotectedProjectviewflagdetails)
[[0;37mDEBUG[0m|#18207] Cache miss: Package_892cb1b7695f8865212e82a9db07e311 ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#18207] [REST] find( Package, [{:project=>"BinaryprotectedProject", :view=>"flagdetails", :name=>"bdpack"}] )
[[0;37mDEBUG[0m|#18207] http_do #1: method: get url: http://localhost:3203/source/BinaryprotectedProject/bdpack/_meta?view=flagde...
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209]   Parameters: {"linkrev"=>"base", "view"=>"xml", "cmd"=>"diff", "package"=>"bdpack", "rev"=>"2", "project"=>"BinaryprotectedProject", "withissues"=>"1", "expand"=>"1"}
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] Validate XML request: #<ActionDispatch::Request:0x7f605f82ed50>
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] no schema found, skipping validation for {"linkrev"=>"base", "view"=>"xml", "cmd"=>"diff", "type"=>"request", "package"=>"bdpack", "rev"=>"2", "format"=>"xml", "project"=>"BinaryprotectedProject", "withissues"=>"1", "controller"=>"source", "method"=>"POST", "expand"=>"1", "action"=>"index_package"}
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] AUTH: nil
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mUser Load (3.3ms)[0m  [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'5f6e6f626f64795f' LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] User _nobody_ initialised
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mRole Load (4.2ms)[0m  SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 5 AND `roles`.`title` = 'Admin' LIMIT 1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mDbProject Load (6.9ms)[0m  [1mSELECT `db_projects`.* FROM `db_projects` WHERE (name = BINARY 'BinaryprotectedProject') LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mDbPackage Load (0.4ms)[0m  SELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 3002 AND (name = BINARY 'bdpack') LIMIT 1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mDbProject Load (0.2ms)[0m  [1mSELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 3002 LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mFlag Load (0.3ms)[0m  SELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 11007 ORDER BY position
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] flagcheck: package has default state, checking project
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mFlag Load (0.2ms)[0m  [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 3002[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] disabled_for sourceaccess repo: arch: state:enable
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] dispatch_command: trying to call method 'index_package_diff'
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] [backend] POST: /source/BinaryprotectedProject/bdpack?cmd=diff&rev=2&expand=1&linkrev=base&view=xml&withissues=1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18218] 2012-04-01 16:34:15 [20117]: POST /source/BinaryprotectedProject/bdpack?cmd=diff&rev=2&expand=1&linkrev=base&view=xml&withissues=1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] request took 0.400151
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209]   Rendered text template (0.0ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Sent data  (1.0ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Completed 200 OK in 431ms (Views: 0.8ms | ActiveRecord: 15.5ms | Backend: 400.2ms | XML: 0.0ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Started GET "/source/BinaryprotectedProject/bdpack/_meta?view=flagdetails" for 127.0.0.1 at Sun Apr 01 16:34:16 +0200 2012
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Processing by SourceController#package_meta as XML
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209]   Parameters: {"view"=>"flagdetails", "package"=>"bdpack", "project"=>"BinaryprotectedProject"}
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] Validate XML request: #<ActionDispatch::Request:0x7f605f770738>
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] no schema found, skipping validation for {"view"=>"flagdetails", "type"=>"request", "package"=>"bdpack", "format"=>"xml", "project"=>"BinaryprotectedProject", "controller"=>"source", "method"=>"GET", "action"=>"package_meta"}
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] AUTH: nil
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mUser Load (0.4ms)[0m  SELECT `users`.* FROM `users` WHERE `users`.`login` = x'5f6e6f626f64795f' LIMIT 1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] User _nobody_ initialised
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [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` = 5 AND `roles`.`title` = 'Admin' LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mDbProject Load (0.2ms)[0m  SELECT `db_projects`.* FROM `db_projects` WHERE (name = BINARY 'BinaryprotectedProject') LIMIT 1
[[0;37mDEBUG[0m|#18207] Request took 0.03373 seconds
[[0;37mDEBUG[0m|#18207] Cache write (will save 34.41ms): Package_892cb1b7695f8865212e82a9db07e311
[[32mINFO [0m|#18207] Rendering template within layouts/application
[[32mINFO [0m|#18207] Rendering package/repositories
[[0;37mDEBUG[0m|#18207] Cache hit: parent_projects_BinaryprotectedProject ({:expires_in=>7 days})
[[0;37mDEBUG[0m|#18207] Rendered package/_tabs (3.0ms)
[[0;37mDEBUG[0m|#18207] Rendered shared/_repositories_flag_table (3.0ms)
[[0;37mDEBUG[0m|#18207] Rendered shared/_repositories_flag_table (2.4ms)
[[0;37mDEBUG[0m|#18207] Rendered shared/_repositories_flag_table (2.4ms)
[[0;37mDEBUG[0m|#18207] Rendered shared/_repositories_flag_table (2.3ms)
[[0;37mDEBUG[0m|#18207] Rendered shared/_repositories (12.9ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_watch_and_search (0.7ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_header (1.4ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_personal_navigation (1.6ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#18207] Completed in 66ms (View: 25, DB: 0, API: 34, XML: 1) | 200 OK [http://localhost/package/repositories?package=bdpack&project=Binaryprotected...]

[[32mINFO [0m|#18207] Processing PackageController#binaries (for 127.0.0.1 at 2012-04-01 16:34:17) [GET]
[[32mINFO [0m|#18207]   Parameters: {"project"=>"BinaryprotectedProject", "repository"=>"nada", "package"=>"bdpack"}
[[0;37mDEBUG[0m|#18207] Setting return_to: "/package/binaries?package=bdpack&project=BinaryprotectedProject&repository=nada"
[[0;37mDEBUG[0m|#18207] Authenticating with iChain mode: off
[[32mINFO [0m|#18207] Anonymous request to /package/binaries?package=bdpack&project=BinaryprotectedProject&repository=nada
[[0;37mDEBUG[0m|#18207] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#18207] Project.find( 300 seconds, BinaryprotectedProject, )
[[0;37mDEBUG[0m|#18207] Cache hit: Project_ceb033cc783987344fb1117f7f7cef83 ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#18207] Package.find( 1800 seconds, bdpack, projectBinaryprotectedProject)
[[0;37mDEBUG[0m|#18207] Cache hit: Package_6835e2f14fbff7760eac4182041a9b3f ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#18207] Cache hit: package_reviews_BinaryprotectedProject_bdpack ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#18207] Buildresult.find( 60 seconds, projectBinaryprotectedProjectviewbinaryliststatusrepositorynadapackagebdpack)
[[0;37mDEBUG[0m|#18207] Cache miss: Buildresult_c277e5899a028bb4a3222177f6120a63 ({:expires_in=>60 seconds})
[[0;37mDEBUG[0m|#18207] [REST] find( Buildresult, [{:project=>"BinaryprotectedProject", :view=>["binarylist", "status"], :repository=>"nada", :package=>"bdpack"}] )
[[0;37mDEBUG[0m|#18207] http_do #1: method: get url: http://localhost:3203/build/BinaryprotectedProject/_result?view=binarylist&v...
[[0;37mDEBUG[0m|#18207] Request took 0.039874 seconds
[[0;37mDEBUG[0m|#18207] Cache write (will save 40.53ms): Buildresult_c277e5899a028bb4a3222177f6120a63
[[0;37mDEBUG[0m|#18207] Package.find( 1800 seconds, bdpack, projectBinaryprotectedProjectviewflagdetails)
[[0;37mDEBUG[0m|#18207] Cache hit: Package_892cb1b7695f8865212e82a9db07e311 ({:expires_in=>1800 seconds})
[[32mINFO [0m|#18207] Rendering template within layouts/application
[[32mINFO [0m|#18207] Rendering package/binaries
[[0;37mDEBUG[0m|#18207] Cache hit: parent_projects_BinaryprotectedProject ({:expires_in=>7 days})
[[0;37mDEBUG[0m|#18207] Rendered package/_tabs (2.9ms)
[[0;37mDEBUG[0m|#18207] Rendered shared/_download_repository_link (8.9ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_watch_and_search (0.7ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_header (1.6ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_personal_navigation (1.7ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_flash (0.2ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#18207] Completed in 168ms (View: 32, DB: 0, API: 40, XML: 0) | 200 OK [http://localhost/package/binaries?package=bdpack&project=BinaryprotectedProj...]

[[32mINFO [0m|#18207] Processing PackageController#binary (for 127.0.0.1 at 2012-04-01 16:34:18) [GET]
[[32mINFO [0m|#18207]   Parameters: {"project"=>"BinaryprotectedProject", "repository"=>"nada", "filename"=>"delete_me-1.0-1.i586.rpm", "arch"=>"i586", "package"=>"bdpack"}
[[0;37mDEBUG[0m|#18207] Setting return_to: "/package/binary?arch=i586&filename=delete_me-1.0-1.i586.rpm&package=bdpack&project=BinaryprotectedProject&repository=nada"
[[0;37mDEBUG[0m|#18207] Authenticating with iChain mode: off
[[32mINFO [0m|#18207] Anonymous request to /package/binary?arch=i586&filename=delete_me-1.0-1.i586.rpm&package=bdpack&project=BinaryprotectedProject&repository=nada
[[0;37mDEBUG[0m|#18207] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#18207] Project.find( 300 seconds, BinaryprotectedProject, )
[[0;37mDEBUG[0m|#18207] Cache hit: Project_ceb033cc783987344fb1117f7f7cef83 ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#18207] Package.find( 1800 seconds, bdpack, projectBinaryprotectedProject)
[[0;37mDEBUG[0m|#18207] Cache hit: Package_6835e2f14fbff7760eac4182041a9b3f ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#18207] Cache hit: package_reviews_BinaryprotectedProject_bdpack ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#18207] Fileinfo.find( 1800 seconds, projectBinaryprotectedProjectviewfileinfo_extrepositorynadafilenamedelete_me-1.0-1.i586.rpmarchi586packagebdpack)
[[0;37mDEBUG[0m|#18207] Cache miss: Fileinfo_e66c04b8c26fa8121d0e73afd5e0d523 ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#18207] [REST] find( Fileinfo, [{:project=>"BinaryprotectedProject", :view=>"fileinfo_ext", :repository=>"nada", :package=>"bdpack", :arch=>"i586", :filename=>"delete_me-1.0-1.i586.rpm"}] )
[[0;37mDEBUG[0m|#18207] http_do #1: method: get url: http://localhost:3203/build/BinaryprotectedProject/nada/i586/bdpack/delete_m...
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mDbPackage Load (0.2ms)[0m  [1mSELECT `db_packages`.* FROM `db_packages` WHERE `db_packages`.`db_project_id` = 3002 AND (name = BINARY 'bdpack') LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mDbProject Load (0.2ms)[0m  SELECT `db_projects`.* FROM `db_projects` WHERE `db_projects`.`id` = 3002 LIMIT 1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] ----------------- rendering package bdpack ------------------------
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mUser Load (0.3ms)[0m  [1mSELECT bu.*, r.title AS role_name FROM `users` bu, package_user_role_relationships purr, roles r WHERE (bu.id = purr.bs_user_id AND purr.db_package_id = 11007 AND r.id = purr.role_id)[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mGroup Load (0.2ms)[0m  SELECT bg.*, r.title AS role_name FROM `groups` bg, package_group_role_relationships pgrr, roles r WHERE (bg.id = pgrr.bs_group_id AND pgrr.db_package_id = 11007 AND r.id = pgrr.role_id)
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mRepository Load (0.3ms)[0m  [1mSELECT `repositories`.* FROM `repositories` WHERE `repositories`.`db_project_id` = 3002 AND (ISNULL(remote_project_name))[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mFlag Load (0.2ms)[0m  SELECT `flags`.* FROM `flags` WHERE `flags`.`db_project_id` = 3002
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mFlag Load (0.2ms)[0m  [1mSELECT `flags`.* FROM `flags` WHERE `flags`.`db_package_id` = 11007 ORDER BY position[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mArchitecture Load (0.3ms)[0m  SELECT `architectures`.* FROM `architectures` INNER JOIN `repository_architectures` ON `architectures`.`id` = `repository_architectures`.`architecture_id` WHERE `repository_architectures`.`repository_id` = 90 ORDER BY position
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] ----------------- end rendering package bdpack ------------------------
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209]   Rendered text template (0.0ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Completed 200 OK in 25ms (Views: 0.8ms | ActiveRecord: 3.0ms | Backend: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Started GET "/build/BinaryprotectedProject/_result?view=binarylist&view=status&package=bdpack&repository=nada" for 127.0.0.1 at Sun Apr 01 16:34:17 +0200 2012
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Processing by BuildController#result as XML
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209]   Parameters: {"view"=>"status", "package"=>"bdpack", "project"=>"BinaryprotectedProject", "repository"=>"nada"}
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] Validate XML request: #<ActionDispatch::Request:0x7f605f6ef480>
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] no schema found, skipping validation for {"view"=>"status", "type"=>"request", "package"=>"bdpack", "format"=>"xml", "project"=>"BinaryprotectedProject", "controller"=>"build", "repository"=>"nada", "method"=>"GET", "action"=>"result"}
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] AUTH: nil
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mUser Load (0.8ms)[0m  [1mSELECT `users`.* FROM `users` WHERE `users`.`login` = x'5f6e6f626f64795f' LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] User _nobody_ initialised
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[35mRole Load (0.5ms)[0m  SELECT DISTINCT roles.id FROM `roles` INNER JOIN `roles_users` ON `roles`.`id` = `roles_users`.`role_id` WHERE `roles_users`.`user_id` = 5 AND `roles`.`title` = 'Admin' LIMIT 1
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209]   [1m[36mDbProject Load (0.2ms)[0m  [1mSELECT `db_projects`.* FROM `db_projects` WHERE (name = BINARY 'BinaryprotectedProject') LIMIT 1[0m
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18209] [backend] VOLLEY: /build/BinaryprotectedProject/_result?view=binarylist&view=status&package=bdpack&repository=nada
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18218] 2012-04-01 16:34:17 [20119]: GET /build/BinaryprotectedProject/_result?view=binarylist&view=status&package=bdpack&repository=nada
[[0;37mDEBUG[0m|#18208] [[0;37mDEBUG[0m|#18218] 2012-04-01 16:34:17 [20120]: GET /_result?prpa=BinaryprotectedProject/nada/i586&package=bdpack&withbinarylist
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Sent file /tmp/volley20120401-18209-1qo79y0-0 (0.2ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Completed 200 OK in 32ms (ActiveRecord: 1.6ms | Backend: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Started GET "/build/BinaryprotectedProject/nada/i586/bdpack/delete_me-1.0-1.i586.rpm?view=fileinfo_ext" for 127.0.0.1 at Sun Apr 01 16:34:18 +0200 2012
[[0;37mDEBUG[0m|#18208] [[32mINFO [0m|#18209] Processing by BuildController#file as XML
[[0;37mDEBUG[0m|#18207] Request took 0.146929 seconds

[[31mFATAL[0m|#18207] ActiveXML::Transport::ForbiddenError (<?xml version="1.0"?>
<status code="download_binary_no_permission">
  <summary>No permission to download binaries from package bdpack, project BinaryprotectedProject</summary>
  <details></details>
</status>
):
  lib/activexml/transport.rb:558:in `handle_response'
  lib/activexml/transport.rb:546:in `http_do'
  lib/activexml/transport.rb:344:in `find'
  lib/activexml/base.rb:103:in `find_priv'
  lib/activexml/base.rb:102:in `find_priv'
  lib/activexml/base.rb:132:in `find_cached'
  app/controllers/application_controller.rb:294:in `find_cached'
  app/controllers/package_controller.rb:64:in `binary'
  /usr/lib64/ruby/1.8/webrick/httpserver.rb:104:in `service'
  /usr/lib64/ruby/1.8/webrick/httpserver.rb:65:in `run'
  /usr/lib64/ruby/1.8/webrick/server.rb:173:in `start_thread'
  /usr/lib64/ruby/1.8/webrick/server.rb:162:in `start'
  /usr/lib64/ruby/1.8/webrick/server.rb:162:in `start_thread'
  /usr/lib64/ruby/1.8/webrick/server.rb:95:in `start'
  /usr/lib64/ruby/1.8/webrick/server.rb:92:in `each'
  /usr/lib64/ruby/1.8/webrick/server.rb:92:in `start'
  /usr/lib64/ruby/1.8/webrick/server.rb:23:in `start'
  /usr/lib64/ruby/1.8/webrick/server.rb:82:in `start'

[[31mERROR[0m|#18207] rescue_action: caught ActiveXML::Transport::ForbiddenError: <?xml version="1.0"?>
<status code="download_binary_no_permission">
  <summary>No permission to download binaries from package bdpack, project BinaryprotectedProject</summary>
  <details></details>
</status>

[[0;37mDEBUG[0m|#18207] ERROR: 401; No permission to download binaries from package bdpack, project BinaryprotectedProject
[[32mINFO [0m|#18207] Rendering template within layouts/application
[[32mINFO [0m|#18207] Rendering error (401)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_watch_and_search (0.8ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_header (1.7ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_personal_navigation (2.0ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#18207] Rendered layouts/_sponsor (0.1ms)
+ echo

+ cleanup
+ echo 'Killing backend processes'
Killing backend processes
+ egrep 'perl|ruby'
+ fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/ws/>
                     USER        PID ACCESS COMMAND
<http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/ws/>:
                     jenkins   ..c.. sh
                     jenkins   ..c.. sh
                     jenkins   ..c.. egrep
+ 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

-- 
To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org
To contact the owner, e-mail: obs-tests+owner@opensuse.org

[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui-testsuite #45

admin＠opensuse.org