rendered paste bodyobs103:/srv/www/obs/frontend/log # tail -f *
==> backend_access.log <==
I, [2008-03-28T22:48:03.816014 #5860] INFO -- : 20080328T224803 PUT localhost:6362/source/home:admin/_meta 200
I, [2008-03-28T22:48:03.816137 #5860] INFO -- : <project name='home:admin'><title>admin's Home Project</title><description/><person role='maintainer' userid='admin'/><person role='maintainer' userid='Admin'/></project>
I, [2008-03-28T22:48:04.856148 #5859] INFO -- : 20080328T224804 GET localhost:6362/build/home:admin/_result?view=summary 200
I, [2008-03-28T22:48:04.856345 #5859] INFO -- : <resultlist state="00000000000000000000000000000000" />
I, [2008-03-28T22:48:44.324873 #5860] INFO -- : 20080328T224844 PUT localhost:6362/source/base_toolchain/_meta 200
I, [2008-03-28T22:48:44.324962 #5860] INFO -- : <project name='base_toolchain'><title>base_toolchain</title><description>base_toolchain</description><person role='maintainer' userid='admin'/><person role='maintainer' userid='Admin'/></project>
I, [2008-03-28T22:48:44.960531 #5861] INFO -- : 20080328T224844 GET localhost:6362/build/base_toolchain/_result?view=summary 200
I, [2008-03-28T22:48:44.960703 #5861] INFO -- : <resultlist state="00000000000000000000000000000000" />
==> development.log <==
/usr/lib/ruby/vendor_ruby/1.8/fcgi.rb:609:in `each_cgi'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:141:in `process_each_request!'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:55:in `process!'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:25:in `process!'
/srv/www/obs/frontend/public/dispatch.fcgi:24
[I|# 5861] Rendering status
[I|# 5861] errorcode 'uncaught_exception' - Mysql::Error: Duplicate entry '2-1-3' for key 2: INSERT INTO package_user_role_relationships (`role_id`, `bs_user_id`, `db_package_id`) VALUES(3, 1, 2)
[I|# 5861] Rendering status (500)
==> fastcgi.crash.log <==
I, [2008-03-28T22:45:35.096937 #5646] INFO -- : [28/Mar/2008:22:45:35 :: 5646] terminated by explicit exit
I, [2008-03-28T22:45:35.320043 #5649] INFO -- : [28/Mar/2008:22:45:35 :: 5649] asked to terminate immediately
I, [2008-03-28T22:45:35.320218 #5649] INFO -- : [28/Mar/2008:22:45:35 :: 5649] terminated by explicit exit
I, [2008-03-28T22:45:35.401178 #5648] INFO -- : [28/Mar/2008:22:45:35 :: 5648] asked to terminate immediately
I, [2008-03-28T22:45:35.401411 #5648] INFO -- : [28/Mar/2008:22:45:35 :: 5648] terminated by explicit exit
I, [2008-03-28T22:45:46.845551 #5857] INFO -- : [28/Mar/2008:22:45:46 :: 5857] starting
I, [2008-03-28T22:45:47.234211 #5861] INFO -- : [28/Mar/2008:22:45:47 :: 5861] starting
I, [2008-03-28T22:45:47.254403 #5858] INFO -- : [28/Mar/2008:22:45:47 :: 5858] starting
I, [2008-03-28T22:45:47.309395 #5859] INFO -- : [28/Mar/2008:22:45:47 :: 5859] starting
I, [2008-03-28T22:45:47.332403 #5860] INFO -- : [28/Mar/2008:22:45:47 :: 5860] starting
==> obs-frontend-access.log <==
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:22:59:31 +0100] "GET /source/base_toolchain/automake/_meta HTTP/1.1" 401 140 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:22:59:31 +0100] "GET /source/base_toolchain/automake/_meta HTTP/1.1" 404 199 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:22:59:31 +0100] "GET /source/base_toolchain/bash/_meta HTTP/1.1" 401 140 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:22:59:31 +0100] "GET /source/base_toolchain/bash/_meta HTTP/1.1" 404 195 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:23:01:00 +0100] "GET /source/base_toolchain/aaa_base/_meta HTTP/1.1" 401 140 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:23:01:00 +0100] "GET /source/base_toolchain/aaa_base/_meta HTTP/1.1" 404 199 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:23:01:09 +0100] "PUT /source/base_toolchain/aaa_base/_meta HTTP/1.1" 401 140 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:23:01:10 +0100] "PUT /source/base_toolchain/aaa_base/_meta HTTP/1.1" 500 7012 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:23:01:49 +0100] "PUT /source/base_toolchain/aaa_base/_meta HTTP/1.1" 401 140 "-" "osc/0.99"
::ffff:192.168.10.241 192.168.10.241 - [28/Mar/2008:23:01:50 +0100] "PUT /source/base_toolchain/aaa_base/_meta HTTP/1.1" 500 7012 "-" "osc/0.99"
==> development.log <==
[D|# 5861] add validation mapping: "source", :index => :directory
[D|# 5861] add validation mapping: "source", :packagelist => :directory
[D|# 5861] add validation mapping: "source", :filelist => :directory
[D|# 5861] add validation mapping: "source", :project_meta => :project
[D|# 5861] add validation mapping: "source", :package_meta => :package
[D|# 5861] add validation mapping: "source", :pattern_meta => :pattern
[I|# 5861]
Processing SourceController#package_meta (for ::ffff:192.168.10.241 at 2008-03-28 23:04:51) [PUT]
[I|# 5861] Session ID: 38d9d180aab89ad7a9f4dc95ff053022
[I|# 5861] Parameters: {"project"=>"base_toolchain", "action"=>"package_meta", "package"=>"aaa_base", "controller"=>"source"}
[D|# 5861] checking schema map for controller 'source', action 'package_meta'
[D|# 5861] schema_file: package
[D|# 5861] schema_path: /srv/www/docs/api/frontend/package.xsd
[D|# 5861] trying to validate against schema '/srv/www/docs/api/frontend/package.xsd'
[D|# 5861] validation tmpfile: /srv/www/obs/frontend/tmp/opensuse_frontend_validator.5861.0
[D|# 5861] validation succeeded
[D|# 5861] AUTH:
[D|# 5861] no authentication string was sent
[I|# 5861] Rendering status
[I|# 5861] errorcode 'unknown' - Authentication required
[I|# 5861] Rendering status (401)
[I|# 5861] Filter chain halted as [#<ActionController::Filters::ClassMethods::SymbolFilter:0xb71cfbd0 @filter=:extract_user>] returned_false.
[I|# 5861] Completed in 0.03427 (29 reqs/sec) | Rendering: 0.00381 (11%) | DB: 0.00000 (0%) | 401 Unauthorized [http://192.168.10.241/source/base_toolchain/aaa_base/_meta]
[D|# 5861] add validation mapping: "source", :index => :directory
[D|# 5861] add validation mapping: "source", :packagelist => :directory
[D|# 5861] add validation mapping: "source", :filelist => :directory
[D|# 5861] add validation mapping: "source", :project_meta => :project
[D|# 5861] add validation mapping: "source", :package_meta => :package
[D|# 5861] add validation mapping: "source", :pattern_meta => :pattern
[I|# 5861]
Processing SourceController#package_meta (for ::ffff:192.168.10.241 at 2008-03-28 23:04:51) [PUT]
[I|# 5861] Session ID: 38d9d180aab89ad7a9f4dc95ff053022
[I|# 5861] Parameters: {"project"=>"base_toolchain", "action"=>"package_meta", "package"=>"aaa_base", "controller"=>"source"}
[D|# 5861] checking schema map for controller 'source', action 'package_meta'
[D|# 5861] schema_file: package
[D|# 5861] schema_path: /srv/www/docs/api/frontend/package.xsd
[D|# 5861] trying to validate against schema '/srv/www/docs/api/frontend/package.xsd'
[D|# 5861] validation tmpfile: /srv/www/obs/frontend/tmp/opensuse_frontend_validator.5861.1
[D|# 5861] validation succeeded
[D|# 5861] AUTH: BasicYWRtaW46b3BlbnN1c2U=
[D|# 5861] User Load (0.002331) SELECT * FROM users WHERE (login = 'admin') LIMIT 1
[D|# 5861] User Columns (0.003291) SHOW FIELDS FROM users
[D|# 5861] USER found: Admin
[D|# 5861] User Admin initialised
[D|# 5861] User's source backend <:>, rpm backend: <:>
[D|# 5861] initializing model Package
[D|# 5861] Package.find( "aaa_base", {:project=>"base_toolchain"} )
[D|# 5861] prepared find args: ["aaa_base", {:name=>"aaa_base", :project=>"base_toolchain"}]
[D|# 5861] [BSSQL] find( Package, ["aaa_base", {:name=>"aaa_base", :project=>"base_toolchain"}] )
[D|# 5861] retrieving target_uri for model ':package'
[D|# 5861] retrieving option hash for model ':package'
[D|# 5861] [BSSQL] query_from_options: {:name=>"aaa_base", :project=>"base_toolchain"}
[D|# 5861] [BSSQL] query_from_options: query is: '@name='aaa_base' and @project='base_toolchain''
[D|# 5861] DbPackage Columns (0.001745) SHOW FIELDS FROM db_packages
[D|# 5861] [BSSQL] join string: ", db_projects"
[D|# 5861] [BSSQL] find conditions: ["db_packages.name LIKE BINARY ? AND db_packages.db_project_id = db_projects.id AND db_projects.name = ?", "aaa\\_base", "base_toolchain"]
[D|# 5861] DbPackage Load (0.001154) SELECT db_packages.* FROM db_packages , db_projects WHERE (db_packages.name LIKE BINARY 'aaa\\_base' AND db_packages.db_project_id = db_projects.id AND db_projects.name = 'base_toolchain')
[D|# 5861] [BSSQL] query @name='aaa_base' and @project='base_toolchain' returned no objects
[D|# 5861] User Admin wants to create a package in base_toolchain
[D|# 5861] Join Table Columns (0.001451) SHOW FIELDS FROM roles_users
[D|# 5861] Role Load (0.000922) SELECT * FROM roles INNER JOIN roles_users ON roles.id = roles_users.role_id WHERE (roles_users.user_id = 1 )
[D|# 5861] Role Columns (0.001113) SHOW FIELDS FROM roles
[D|# 5861] Join Table Columns (0.001575) SHOW FIELDS FROM groups_users
[D|# 5861] Group Load (0.000889) SELECT * FROM groups INNER JOIN groups_users ON groups.id = groups_users.group_id WHERE (groups_users.user_id = 1 )
[D|# 5861] Join Table Columns (0.001603) SHOW FIELDS FROM roles_static_permissions
[D|# 5861] StaticPermission Load (0.000964) 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 = 1 )
[D|# 5861] StaticPermission Columns (0.001190) SHOW FIELDS FROM static_permissions
[D|# 5861] add_person: role: "maintainer"
[D|# 5861] Save Package
[D|# 5861] XML <package name='aaa_base'>
<title>Title of New Package</title>
<description>LONG DESCRIPTION
GOES
HERE
</description>
<person role='maintainer' userid='admin'/>
<person role='bugowner' userid='admin'/>
<!--
use one of the examples below to disable building of this package
on a certain architecture, in a certain repository,
or a combination thereof:
<disable arch="x86_64"/>
<disable repository="SUSE_SLE-10"/>
<disable repository="SUSE_SLE-10" arch="x86_64"/>
-->
<person role='maintainer' userid='Admin'/></package>
[D|# 5861] [BSSQL] saving object
[D|# 5861] SQL (0.000682) BEGIN
[D|# 5861] DbPackage Load (0.000902) SELECT pack.*
FROM db_packages pack
LEFT OUTER JOIN db_projects pro ON pack.db_project_id = pro.id
WHERE pro.name = BINARY 'base_toolchain' AND pack.name = BINARY 'aaa_base'
[D|# 5861] DbProject Load (0.001281) SELECT * FROM db_projects WHERE (name = BINARY 'base_toolchain') LIMIT 1
[D|# 5861] DbProject Columns (0.001234) SHOW FIELDS FROM db_projects
[D|# 5861] DbPackage Load (0.000772) SELECT * FROM db_packages WHERE (db_packages.db_project_id = 5)
[D|# 5861] SQL (0.000778) INSERT INTO db_packages (`name`, `updated_at`, `activity_index`, `db_project_id`, `title`, `url`, `description`, `created_at`, `update_counter`) VALUES('aaa_base', NULL, 100.0, 5, NULL, NULL, NULL, NULL, 0)
[D|# 5861] PackageUserRoleRelationship Load (0.000846) SELECT * FROM package_user_role_relationships WHERE (package_user_role_relationships.db_package_id = 3)
[D|# 5861] User Load (0.000917) SELECT * FROM users WHERE (users.`login` = 'admin') LIMIT 1
[D|# 5861] Role Load (0.000772) SELECT * FROM roles
[D|# 5861] PackageUserRoleRelationship Columns (0.001074) SHOW FIELDS FROM package_user_role_relationships
[D|# 5861] SQL (0.000617) INSERT INTO package_user_role_relationships (`role_id`, `bs_user_id`, `db_package_id`) VALUES(3, 1, 3)
[D|# 5861] User Load (0.000652) SELECT * FROM users WHERE (users.`login` = 'admin') LIMIT 1
[D|# 5861] SQL (0.000502) INSERT INTO package_user_role_relationships (`role_id`, `bs_user_id`, `db_package_id`) VALUES(NULL, 1, 3)
[D|# 5861] User Load (0.000749) SELECT * FROM users WHERE (users.`login` = 'Admin') LIMIT 1
[D|# 5861] SQL (0.000000) Mysql::Error: Duplicate entry '3-1-3' for key 2: INSERT INTO package_user_role_relationships (`role_id`, `bs_user_id`, `db_package_id`) VALUES(3, 1, 3)
[D|# 5861] SQL (0.010840) ROLLBACK
[F|# 5861]
ActiveRecord::StatementInvalid (Mysql::Error: Duplicate entry '3-1-3' for key 2: INSERT INTO package_user_role_relationships (`role_id`, `bs_user_id`, `db_package_id`) VALUES(3, 1, 3)):
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/connection_adapters/abstract_adapter.rb:128:in `log'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/connection_adapters/mysql_adapter.rb:243:in `execute'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/connection_adapters/mysql_adapter.rb:253:in `insert'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/base.rb:1814:in `create_without_callbacks'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/callbacks.rb:254:in `create_without_timestamps'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/timestamp.rb:30:in `create'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/base.rb:1792:in `create_or_update_without_callbacks'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/callbacks.rb:242:in `create_or_update'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/base.rb:1548:in `save_without_validation'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/validations.rb:752:in `save_without_transactions'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/transactions.rb:129:in `save'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/connection_adapters/abstract/database_statements.rb:59:in `transaction'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/transactions.rb:95:in `transaction'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/transactions.rb:121:in `transaction'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/transactions.rb:129:in `save'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/base.rb:451:in `create'
/srv/www/obs/frontend/app/models/db_package.rb:105:in `store_axml'
/srv/www/obs/common/lib/activexml/node.rb:308:in `call'
/srv/www/obs/common/lib/activexml/node.rb:308:in `method_missing'
/usr/lib/ruby/1.8/rexml/element.rb:934:in `each'
/usr/lib/ruby/1.8/rexml/xpath.rb:53:in `each'
/usr/lib/ruby/1.8/rexml/element.rb:934:in `each'
/srv/www/obs/common/lib/activexml/node.rb:306:in `method_missing'
/srv/www/obs/frontend/app/models/db_package.rb:85:in `store_axml'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/connection_adapters/abstract/database_statements.rb:59:in `transaction'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/transactions.rb:95:in `transaction'
/srv/www/obs/frontend/app/models/db_package.rb:67:in `store_axml'
/srv/www/obs/frontend/app/models/db_package.rb:39:in `store_axml'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/connection_adapters/abstract/database_statements.rb:59:in `transaction'
/usr/lib/ruby/gems/1.8/gems/activerecord-1.15.6/lib/active_record/transactions.rb:95:in `transaction'
/srv/www/obs/frontend/app/models/db_package.rb:29:in `store_axml'
/srv/www/obs/common/lib/activexml/transport.rb:230:in `save'
/srv/www/obs/common/lib/activexml/base.rb:89:in `save'
/srv/www/obs/frontend/app/controllers/source_controller.rb:359:in `package_meta'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/base.rb:1101:in `send'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/base.rb:1101:in `perform_action_without_filters'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/filters.rb:696:in `call_filters'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/filters.rb:688:in `perform_action_without_benchmark'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/benchmarking.rb:66:in `perform_action_without_rescue'
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/benchmarking.rb:66:in `perform_action_without_rescue'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/rescue.rb:83:in `perform_action'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/base.rb:435:in `send'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/base.rb:435:in `process_without_filters'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/filters.rb:684:in `process_without_session_management_support'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/session_management.rb:114:in `process'
/usr/lib/ruby/gems/1.8/gems/actionpack-1.13.6/lib/action_controller/base.rb:334:in `process'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/dispatcher.rb:41:in `dispatch'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:168:in `process_request'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:143:in `process_each_request!'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:109:in `with_signal_handler'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:142:in `process_each_request!'
/usr/lib/ruby/vendor_ruby/1.8/fcgi.rb:612:in `each_cgi'
/usr/lib/ruby/vendor_ruby/1.8/fcgi.rb:609:in `each'
/usr/lib/ruby/vendor_ruby/1.8/fcgi.rb:609:in `each_cgi'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:141:in `process_each_request!'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:55:in `process!'
/usr/lib/ruby/gems/1.8/gems/rails-1.2.6/lib/fcgi_handler.rb:25:in `process!'
/srv/www/obs/frontend/public/dispatch.fcgi:24
[I|# 5861] Rendering status
[I|# 5861] errorcode 'uncaught_exception' - Mysql::Error: Duplicate entry '3-1-3' for key 2: INSERT INTO package_user_role_relationships (`role_id`, `bs_user_id`, `db_package_id`) VALUES(3, 1, 3)
[I|# 5861] Rendering status (500)