[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #243
See http://ci.opensuse.org/job/obs_master_testsuite_webui/243/changes
Changes:
[adrian] [backend] make the error message of stopped patchinfos more obvious
[Sascha Peilicke] [webui] Use the first action as the request type in request#show too.
[Sascha Peilicke] [webui] Provide a max-height for rpmlint result logs.
------------------------------------------
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@202e202e
Using strategy: Default
Last Built Revision: Revision 77c8681ee8f784fb884750b9c9fae4f4317b1ba7 (origin/master)
Checkout:workspace / http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/ - hudson.remoting.LocalChannel@202e202e
Fetching changes from 1 remote Git repository
Fetching upstream changes from git://github.com/openSUSE/open-build-service.git
Commencing build of Revision 46af354fa3e7a77b0806adebe4de1cbbdd097396 (origin/master)
Checking out Revision 46af354fa3e7a77b0806adebe4de1cbbdd097396 (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/hudson3387230065293075420.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/tmp/backend_config/
# src/api/tmp/backend_data/
# src/api/tmp/pids/server.pid
# src/webui/results/
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
+ rm Gemfile.lock
+ bundle list
Gems included by the bundle:
* actionmailer (3.2.1)
* actionpack (3.2.1)
* activemodel (3.2.1)
* activerecord (3.2.1)
* activeresource (3.2.1)
* activesupport (3.2.1)
* arel (3.0.0)
* builder (3.0.0)
* bundler (1.0.21)
* ci_reporter (1.7.0)
* delayed_job (3.0.1)
* delayed_job_active_record (0.3.2)
* erubis (2.7.0)
* exception_notification (2.5.2)
* fast_xs (0.8.0)
* hike (1.2.1)
* i18n (0.6.0)
* journey (1.0.1)
* json (1.6.5)
* mail (2.4.1)
* mime-types (1.17.2)
* multi_json (1.0.4)
* mysql2 (0.3.11)
* nokogiri (1.5.0)
* polyglot (0.3.2)
* rack (1.4.1)
* rack-cache (1.1)
* rack-ssl (1.3.2)
* rack-test (0.6.1)
* rails (3.2.1)
* railties (3.2.1)
* rake (0.9.2.2)
* rdoc (3.11)
* sprockets (2.1.2)
* thor (0.14.6)
* tilt (1.1)
* treetop (1.4.9)
* tzinfo (0.3.30)
* xmlhash (1.2.1)
* yajl-ruby (0.7.6)
+ git diff Gemfile.lock
diff --git a/src/api/Gemfile.lock b/src/api/Gemfile.lock
index fc21cfa..07064d5 100644
--- a/src/api/Gemfile.lock
+++ b/src/api/Gemfile.lock
@@ -84,7 +84,7 @@ GEM
rack (~> 1.0)
tilt (~> 1.1, != 1.3.0)
thor (0.14.6)
- tilt (1.3.3)
+ tilt (1.1)
treetop (1.4.9)
polyglot (>= 0.3.1)
tzinfo (0.3.30)
+ 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)
** Invoke rails_env (first_time)
** Execute rails_env
** Execute db:load_config
** Execute db:drop
** Invoke db:create (first_time)
** Invoke db:load_config
** 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
** 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
** 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
+ chmod +x script/start_test_api
+ echo 'Initialize test database, run migrations, load seed data'
Initialize test database, run migrations, load seed data
+ rake --trace db:drop db:create db:migrate
** Invoke db:drop (first_time)
** Invoke db:load_config (first_time)
** Invoke rails_env (first_time)
** Execute rails_env
** Execute db:load_config
** Execute db:drop
** Invoke db:create (first_time)
** Invoke db:load_config
** Execute db:create
rake aborted!
cannot load such file -- sqlite3
/usr/lib64/ruby/1.9.1/rubygems/custom_require.rb:36:in `require'
/usr/lib64/ruby/1.9.1/rubygems/custom_require.rb:36:in `require'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/dependencies.rb:182:in `block in require'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/dependencies.rb:547:in `new_constants_in'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/dependencies.rb:182:in `require'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/core_ext/kernel/requires.rb:7:in `block in require_library_or_gem'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/core_ext/kernel/reporting.rb:11:in `silence_warnings'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/core_ext/kernel/requires.rb:5:in `require_library_or_gem'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/sqlite3_adapter.rb:10:in `sqlite3_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:223:in `new_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:245:in `checkout_new_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:188:in `block (2 levels) in checkout'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:184:in `loop'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:184:in `block in checkout'
/usr/lib64/ruby/1.9.1/monitor.rb:211:in `mon_synchronize'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:183:in `checkout'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:98:in `connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:326:in `retrieve_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_specification.rb:123:in `retrieve_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_specification.rb:115:in `connection'
/usr/lib64/ruby/gems/1.9.1/gems/rails-2.3.14/lib/tasks/databases.rake:43:in `create_database'
/usr/lib64/ruby/gems/1.9.1/gems/rails-2.3.14/lib/tasks/databases.rake:31:in `block (2 levels) in
See http://ci.opensuse.org/job/obs_master_testsuite_webui/244/changes
Changes:
[adrian] - some more warnings about current WIP state
------------------------------------------
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@202e202e
Using strategy: Default
Last Built Revision: Revision 46af354fa3e7a77b0806adebe4de1cbbdd097396 (origin/master)
Checkout:workspace / http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/ - hudson.remoting.LocalChannel@202e202e
Fetching changes from 1 remote Git repository
Fetching upstream changes from git://github.com/openSUSE/open-build-service.git
Commencing build of Revision 9544b18a2937e42e3048aa5d8ffe8ad96fa57bdc (origin/master)
Checking out Revision 9544b18a2937e42e3048aa5d8ffe8ad96fa57bdc (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/hudson5434549148378981226.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/tmp/backend_config/
# src/api/tmp/backend_data/
# src/api/tmp/pids/server.pid
# src/webui/results/
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
+ rm Gemfile.lock
+ bundle list
Gems included by the bundle:
* actionmailer (3.2.1)
* actionpack (3.2.1)
* activemodel (3.2.1)
* activerecord (3.2.1)
* activeresource (3.2.1)
* activesupport (3.2.1)
* arel (3.0.0)
* builder (3.0.0)
* bundler (1.0.21)
* ci_reporter (1.7.0)
* delayed_job (3.0.1)
* delayed_job_active_record (0.3.2)
* erubis (2.7.0)
* exception_notification (2.5.2)
* fast_xs (0.8.0)
* hike (1.2.1)
* i18n (0.6.0)
* journey (1.0.1)
* json (1.6.5)
* mail (2.4.1)
* mime-types (1.17.2)
* multi_json (1.0.4)
* mysql2 (0.3.11)
* nokogiri (1.5.0)
* polyglot (0.3.2)
* rack (1.4.1)
* rack-cache (1.1)
* rack-ssl (1.3.2)
* rack-test (0.6.1)
* rails (3.2.1)
* railties (3.2.1)
* rake (0.9.2.2)
* rdoc (3.11)
* sprockets (2.1.2)
* thor (0.14.6)
* tilt (1.1)
* treetop (1.4.9)
* tzinfo (0.3.30)
* xmlhash (1.2.1)
* yajl-ruby (0.7.6)
+ git diff Gemfile.lock
diff --git a/src/api/Gemfile.lock b/src/api/Gemfile.lock
index fc21cfa..07064d5 100644
--- a/src/api/Gemfile.lock
+++ b/src/api/Gemfile.lock
@@ -84,7 +84,7 @@ GEM
rack (~> 1.0)
tilt (~> 1.1, != 1.3.0)
thor (0.14.6)
- tilt (1.3.3)
+ tilt (1.1)
treetop (1.4.9)
polyglot (>= 0.3.1)
tzinfo (0.3.30)
+ 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)
** Invoke rails_env (first_time)
** Execute rails_env
** Execute db:load_config
** Execute db:drop
** Invoke db:create (first_time)
** Invoke db:load_config
** 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
** 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
** 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
+ chmod +x script/start_test_api
+ echo 'Initialize test database, run migrations, load seed data'
Initialize test database, run migrations, load seed data
+ rake --trace db:drop db:create db:migrate
** Invoke db:drop (first_time)
** Invoke db:load_config (first_time)
** Invoke rails_env (first_time)
** Execute rails_env
** Execute db:load_config
** Execute db:drop
** Invoke db:create (first_time)
** Invoke db:load_config
** Execute db:create
rake aborted!
cannot load such file -- sqlite3
/usr/lib64/ruby/1.9.1/rubygems/custom_require.rb:36:in `require'
/usr/lib64/ruby/1.9.1/rubygems/custom_require.rb:36:in `require'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/dependencies.rb:182:in `block in require'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/dependencies.rb:547:in `new_constants_in'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/dependencies.rb:182:in `require'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/core_ext/kernel/requires.rb:7:in `block in require_library_or_gem'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/core_ext/kernel/reporting.rb:11:in `silence_warnings'
/usr/lib64/ruby/gems/1.9.1/gems/activesupport-2.3.14/lib/active_support/core_ext/kernel/requires.rb:5:in `require_library_or_gem'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/sqlite3_adapter.rb:10:in `sqlite3_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:223:in `new_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:245:in `checkout_new_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:188:in `block (2 levels) in checkout'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:184:in `loop'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:184:in `block in checkout'
/usr/lib64/ruby/1.9.1/monitor.rb:211:in `mon_synchronize'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:183:in `checkout'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:98:in `connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_pool.rb:326:in `retrieve_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_specification.rb:123:in `retrieve_connection'
/usr/lib64/ruby/gems/1.9.1/gems/activerecord-2.3.14/lib/active_record/connection_adapters/abstract/connection_specification.rb:115:in `connection'
/usr/lib64/ruby/gems/1.9.1/gems/rails-2.3.14/lib/tasks/databases.rake:43:in `create_database'
/usr/lib64/ruby/gems/1.9.1/gems/rails-2.3.14/lib/tasks/databases.rake:31:in `block (2 levels) in
See http://ci.opensuse.org/job/obs_master_testsuite_webui/245/changes
Changes:
[adrian] - add not about user management rework
------------------------------------------
[...truncated 46865 lines...]
[[0;37mDEBUG[0m|#26624] [4;36;1mSQL (0.1ms)[0m [0;1mINSERT INTO schema_migrations (version) VALUES ('20120401122058')[0m
[[0;37mDEBUG[0m|#26624] [4;35;1mSQL (0.2ms)[0m [0m SELECT name
FROM sqlite_master
WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
[[0;37mDEBUG[0m|#26624] [4;36;1mSQL (0.2ms)[0m [0;1mSELECT version FROM schema_migrations[0m
[[0;37mDEBUG[0m|#26624] [4;35;1mSQL (0.2ms)[0m [0m SELECT name
FROM sqlite_master
WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
[[0;37mDEBUG[0m|#26624] [4;36;1mSQL (0.1ms)[0m [0;1mPRAGMA index_list("sessions")[0m
[[0;37mDEBUG[0m|#26624] [4;35;1mSQL (0.1ms)[0m [0mPRAGMA index_info('index_sessions_on_updated_at')[0m
[[0;37mDEBUG[0m|#26624] [4;36;1mSQL (0.1ms)[0m [0;1mPRAGMA index_info('index_sessions_on_session_id')[0m
** Erubis 2.7.0
[[32mINFO [0m|#26626] Using theme view path: http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views...
[[0;37mDEBUG[0m|#26626] default_server for :rest models: http://localhost:3203
[[0;37mDEBUG[0m|#26626] [REST] initialize( "rest", {:all=>#
See http://ci.opensuse.org/job/obs_master_testsuite_webui/246/changes
Changes:
[Stephan Kulow] [webui-testsuite] hopefully fix another case of unstable results
[Stephan Kulow] [api] more deletion of active_rbac, more porting to rails 3.2
[Sascha Peilicke] [webui] Don't forget to cancel navigation in JS click events...
[Sascha Peilicke] [webui] Don't expand deleted files in sourcediff
------------------------------------------
[...truncated 2065 lines...]
[[0;37mDEBUG[0m|#10276] [4;36;1mSQL (0.1ms)[0m [0;1mINSERT INTO schema_migrations (version) VALUES ('20120401122058')[0m
[[0;37mDEBUG[0m|#10276] [4;35;1mSQL (0.2ms)[0m [0m SELECT name
FROM sqlite_master
WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
[[0;37mDEBUG[0m|#10276] [4;36;1mSQL (0.1ms)[0m [0;1mSELECT version FROM schema_migrations[0m
[[0;37mDEBUG[0m|#10276] [4;35;1mSQL (0.2ms)[0m [0m SELECT name
FROM sqlite_master
WHERE type = 'table' AND NOT name = 'sqlite_sequence'
[0m
[[0;37mDEBUG[0m|#10276] [4;36;1mSQL (0.1ms)[0m [0;1mPRAGMA index_list("sessions")[0m
[[0;37mDEBUG[0m|#10276] [4;35;1mSQL (0.1ms)[0m [0mPRAGMA index_info('index_sessions_on_updated_at')[0m
[[0;37mDEBUG[0m|#10276] [4;36;1mSQL (0.1ms)[0m [0;1mPRAGMA index_info('index_sessions_on_session_id')[0m
** Erubis 2.7.0
[[32mINFO [0m|#10278] Using theme view path: http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/src/webui/app/views...
[[0;37mDEBUG[0m|#10278] default_server for :rest models: http://localhost:3203
[[0;37mDEBUG[0m|#10278] [REST] initialize( "rest", {:all=>#
See http://ci.opensuse.org/job/obs_master_testsuite_webui/247/
------------------------------------------
[...truncated 111236 lines...]
[[0;37mDEBUG[0m|#12667] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#12667] Completed in 197ms (View: 6, DB: 0, API: 186, XML: 0) | 200 OK [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#12667] REQUESTING PAGE: POST /user/do_login with {"return_to_path"=>"/", "username"=>"tom", "password"=>"thunder", "commit"=>"Login"} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#12667]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-04 14:38:59) [POST]
[[32mINFO [0m|#12667] Parameters: {"return_to_path"=>"/", "username"=>"tom", "password"=>"thunder", "commit"=>"Login"}
[[0;37mDEBUG[0m|#12667] Setting return_to: "/"
[[0;37mDEBUG[0m|#12667] Authenticating with iChain mode: off
[[32mINFO [0m|#12667] Anonymous request to /
[[0;37mDEBUG[0m|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#12667] Doing form authorization to login user tom
[[0;37mDEBUG[0m|#12667] Person.find( nil, tom)
[[0;37mDEBUG[0m|#12667] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#12667] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#12667] Request took 0.056962225 seconds
[[32mINFO [0m|#12667] Redirected to http://www.example.com/
[[32mINFO [0m|#12667] Completed in 61ms (DB: 1, API: 57, XML: 0) | 302 Found [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#12667] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#12667]
Processing MainController#index (for 127.0.0.1 at 2012-04-04 14:38:59) [GET]
[[0;37mDEBUG[0m|#12667] Setting return_to: "/"
[[0;37mDEBUG[0m|#12667] Authenticating with iChain mode: off
[[32mINFO [0m|#12667] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|#12667] Cache delete: Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#12667] Person.find( 1800 seconds, tom, {:is_current=>true})
[[0;37mDEBUG[0m|#12667] Cache miss: Person_bcccc817286c9705b67feb0c7cc953c3 ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#12667] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#12667] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#12667] Request took 0.050888143 seconds
[[0;37mDEBUG[0m|#12667] Cache write (will save 51.32ms): Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#12667] Cache hit: tom_requests_that_need_work ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#12667] Statusmessage.find( 900 seconds, {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#12667] Cache hit: Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#12667] LatestUpdated.find( 300 seconds, {:limit=>6, :shared=>true})
[[0;37mDEBUG[0m|#12667] Cache hit: LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#12667] Project.find( 1800 seconds, home:tom)
[[0;37mDEBUG[0m|#12667] Cache hit: Project_adb9094ae2c389898fafee54514195c4 ({:expires_in=>1800 seconds})
[[32mINFO [0m|#12667] Rendering template within layouts/application
[[32mINFO [0m|#12667] Rendering main/index
[[0;37mDEBUG[0m|#12667] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_latest_updates (3.6ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_sponsors (0.0ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_feeds (0.0ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_personal_navigation (0.4ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#12667] Completed in 69ms (View: 11, DB: 0, API: 51, XML: 1) | 200 OK [http://www.example.com/]
[[32mINFO [0m|#12667]
Processing UserController#logout (for 127.0.0.1 at 2012-04-04 14:39:00) [POST]
[[0;37mDEBUG[0m|#12667] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#12667] Authenticating with iChain mode: off
[[32mINFO [0m|#12667] Authenticated request to "/user/logout" from tom
[[0;37mDEBUG[0m|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#12667] Logging out: tom
[[32mINFO [0m|#12667] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#12667] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#12667] Completed in 4ms (DB: 1, API: 0, XML: 0) | 302 Found [http://www.example.com/user/logout]
[[0;37mDEBUG[0m|#12667] REQUESTING PAGE: GET / with {} and HTTP headers {}
[[32mINFO [0m|#12667]
Processing MainController#index (for 127.0.0.1 at 2012-04-04 14:39:00) [GET]
[[0;37mDEBUG[0m|#12667] Setting return_to: "/"
[[0;37mDEBUG[0m|#12667] Authenticating with iChain mode: off
[[32mINFO [0m|#12667] Anonymous request to /
[[0;37mDEBUG[0m|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#12667] Statusmessage.find( 900 seconds, {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#12667] Cache hit: Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#12667] LatestUpdated.find( 300 seconds, {:limit=>6, :shared=>true})
[[0;37mDEBUG[0m|#12667] Cache hit: LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[32mINFO [0m|#12667] Rendering template within layouts/application
[[32mINFO [0m|#12667] Rendering main/index
[[0;37mDEBUG[0m|#12667] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_latest_updates (3.6ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_sponsors (0.0ms)
[[0;37mDEBUG[0m|#12667] Rendered main/_feeds (0.0ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_personal_navigation (0.6ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#12667] Completed in 15ms (View: 10, DB: 0, API: 0, XML: 1) | 200 OK [http://www.example.com/]
[[0;37mDEBUG[0m|#12667] REQUESTING PAGE: GET /user/login with {} and HTTP headers {"HTTP_REFERER"=>"/"}
[[32mINFO [0m|#12667]
Processing UserController#login (for 127.0.0.1 at 2012-04-04 14:39:00) [GET]
[[0;37mDEBUG[0m|#12667] Setting return_to: "/user/login"
[[0;37mDEBUG[0m|#12667] Authenticating with iChain mode: off
[[32mINFO [0m|#12667] Anonymous request to /user/login
[[0;37mDEBUG[0m|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#12667] Rendering template within layouts/application
[[32mINFO [0m|#12667] Rendering user/login
[[0;37mDEBUG[0m|#12667] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_header (0.8ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_personal_navigation (0.7ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#12667] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#12667] Completed in 9ms (View: 5, DB: 3, API: 0, XML: 0) | 200 OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|#12667] REQUESTING PAGE: POST /user/do_login with {"return_to_path"=>"/", "username"=>"king", "password"=>"sunflower", "commit"=>"Login"} and HTTP headers {"HTTP_REFERER"=>"/user/login"}
[[32mINFO [0m|#12667]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-04 14:39:00) [POST]
[[32mINFO [0m|#12667] Parameters: {"return_to_path"=>"/", "username"=>"king", "password"=>"sunflower", "commit"=>"Login"}
[[0;37mDEBUG[0m|#12667] Setting return_to: "/"
[[0;37mDEBUG[0m|#12667] Authenticating with iChain mode: off
[[32mINFO [0m|#12667] Anonymous request to /
[[0;37mDEBUG[0m|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#12667] Doing form authorization to login user king
[[0;37mDEBUG[0m|#12667] Person.find( nil, king)
[[0;37mDEBUG[0m|#12667] [REST] find( Person, [{:login=>"king"}] )
[[0;37mDEBUG[0m|#12667] http_do #1: method: get url: http://localhost:3203/person/king
[[0;37mDEBUG[0m|#12667] Request took 0.013120739 seconds
[[32mINFO [0m|#12667] Redirected to http://www.example.com/
[[32mINFO [0m|#12667] Completed in 18ms (DB: 0, API: 13, XML: 0) | 302 Found [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#12667] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#12667]
Processing MainController#index (for 127.0.0.1 at 2012-04-04 14:39:00) [GET]
[[0;37mDEBUG[0m|#12667] Setting return_to: "/"
[[0;37mDEBUG[0m|#12667] Authenticating with iChain mode: off
[[32mINFO [0m|#12667] Authenticated request to "/" from king
[[0;37mDEBUG[0m|#12667] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_str- nil
[[0;37mDEBUG[0m|#12667] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#12667] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#12667] Cache miss: Person_31bc44caa5b35568da22b828c6853364 ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#12667] [REST] find( Person, [{:is_current=>"true", :login=>"king"}] )
[[0;37mDEBUG[0m|#12667] http_do #1: method: get url: http://localhost:3203/person/king
[[0;37mDEBUG[0m|#12667] Request took 0.052083102 seconds
[[0;37mDEBUG[0m|#12667] Cache write (will save 52.53ms): Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#12667] Cache miss: king_requests_that_need_work ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#12667] Fetching request list from api
[[0;37mDEBUG[0m|#12667] --> direct_http url: #
See http://ci.opensuse.org/job/obs_master_testsuite_webui/248/changes -- To unsubscribe, e-mail: obs-tests+unsubscribe@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
participants (1)
-
admin@opensuse.org