[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #231
See http://ci.opensuse.org/job/obs_master_testsuite_webui/231/changes
Changes:
[Stephan Kulow] [dist,webui,api] record coverage for all test suites
[Sascha Peilicke] [webui] Get rid of 'format_comment' and replace with markup...
------------------------------------------
[...truncated 12280 lines...]
[[0;37mDEBUG[0m|#14512] Rendered layouts/_header (1.6ms)
[[0;37mDEBUG[0m|#14512] Rendered layouts/_personal_navigation (1.6ms)
[[0;37mDEBUG[0m|#14512] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#14512] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#14512] Processing ApplicationController#index (for 127.0.0.1 at 2012-04-02 19:43:12) [GET]
[[31mFATAL[0m|#14512] ActionController::RoutingError (No route matches "/stylesheets/obs.min.css" with {:method=>:get}):
test/functional/spider_test.rb:323:in `do_spider'
test/functional/spider_test.rb:451:in `test_1spider'
/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:279
rake (0.9.2) lib/rake/rake_test_loader.rb:5
[[31mERROR[0m|#14512] rescue_action: caught ActionController::RoutingError: No route matches "/stylesheets/obs.min.css" with {:method=>:get}
[[0;37mDEBUG[0m|#14512] ERROR: 404; no such route
[[32mINFO [0m|#14512] Rendering template within layouts/application
[[32mINFO [0m|#14512] Rendering error (404)
[[0;37mDEBUG[0m|#14512] Rendered layouts/_watch_and_search (0.7ms)
[[0;37mDEBUG[0m|#14512] Rendered layouts/_header (1.5ms)
[[0;37mDEBUG[0m|#14512] Rendered layouts/_personal_navigation (1.5ms)
[[0;37mDEBUG[0m|#14512] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#14512] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#14512] Processing UserController#do_login (for 127.0.0.1 at 2012-04-02 19:43:12) [POST]
[[32mINFO [0m|#14512] Parameters: {"password"=>"thunder", "return_to_path"=>"/", "username"=>"tom"}
[[0;37mDEBUG[0m|#14512] Setting return_to: "/"
[[0;37mDEBUG[0m|#14512] Authenticating with iChain mode: off
[[32mINFO [0m|#14512] Anonymous request to /
[[0;37mDEBUG[0m|#14512] Cache miss: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#14512] --> direct_http url: #
See http://ci.opensuse.org/job/obs_master_testsuite_webui/232/changes
Changes:
[Stephan Kulow] [api] more rails 3.2 porting - in huge parts by deleting more of active_rbac
[Stephan Kulow] [webui] show the reason the api does not start to avoid endless hangs
------------------------------------------
[...truncated 4727 lines...]
[[0;37mDEBUG[0m|#30618] Rendered layouts/_header (1.5ms)
[[0;37mDEBUG[0m|#30618] Rendered layouts/_personal_navigation (1.5ms)
[[0;37mDEBUG[0m|#30618] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#30618] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#30618] Processing ApplicationController#index (for 127.0.0.1 at 2012-04-02 19:45:13) [GET]
[[31mFATAL[0m|#30618] ActionController::RoutingError (No route matches "/stylesheets/obs.min.css" with {:method=>:get}):
test/functional/spider_test.rb:323:in `do_spider'
test/functional/spider_test.rb:451:in `test_1spider'
/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:279
rake (0.9.2) lib/rake/rake_test_loader.rb:5
[[31mERROR[0m|#30618] rescue_action: caught ActionController::RoutingError: No route matches "/stylesheets/obs.min.css" with {:method=>:get}
[[0;37mDEBUG[0m|#30618] ERROR: 404; no such route
[[32mINFO [0m|#30618] Rendering template within layouts/application
[[32mINFO [0m|#30618] Rendering error (404)
[[0;37mDEBUG[0m|#30618] Rendered layouts/_watch_and_search (0.9ms)
[[0;37mDEBUG[0m|#30618] Rendered layouts/_header (1.9ms)
[[0;37mDEBUG[0m|#30618] Rendered layouts/_personal_navigation (1.6ms)
[[0;37mDEBUG[0m|#30618] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#30618] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#30618] Processing UserController#do_login (for 127.0.0.1 at 2012-04-02 19:45:13) [POST]
[[32mINFO [0m|#30618] Parameters: {"return_to_path"=>"/", "password"=>"thunder", "username"=>"tom"}
[[0;37mDEBUG[0m|#30618] Setting return_to: "/"
[[0;37mDEBUG[0m|#30618] Authenticating with iChain mode: off
[[32mINFO [0m|#30618] Anonymous request to /
[[0;37mDEBUG[0m|#30618] Cache miss: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#30618] --> direct_http url: #
See http://ci.opensuse.org/job/obs_master_testsuite_webui/233/changes
Changes:
[Stephan Kulow] [webui] not eveyone has ruby1.9
------------------------------------------
[...truncated 67209 lines...]
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_personal_navigation (1.5ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|# 4492] Completed in 10ms (View: 7, DB: 1, API: 0, XML: 0) | 200 OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|# 4492] REQUESTING PAGE: POST /user/do_login with {"commit"=>"Login", "username"=>"tom", "password"=>"thunderz", "return_to_path"=>"/"} and HTTP headers {"HTTP_REFERER"=>"/user/login"}
[[32mINFO [0m|# 4492] Processing UserController#do_login (for 127.0.0.1 at 2012-04-02 20:48:46) [POST]
[[32mINFO [0m|# 4492] Parameters: {"commit"=>"Login", "username"=>"tom", "password"=>"thunderz", "return_to_path"=>"/"}
[[0;37mDEBUG[0m|# 4492] Setting return_to: "/"
[[0;37mDEBUG[0m|# 4492] Authenticating with iChain mode: off
[[32mINFO [0m|# 4492] Anonymous request to /
[[0;37mDEBUG[0m|# 4492] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|# 4492] Doing form authorization to login user tom
[[0;37mDEBUG[0m|# 4492] Person.find( nil, tom)
[[0;37mDEBUG[0m|# 4492] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|# 4492] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 4492] Request took 0.240914 seconds
[[32mINFO [0m|# 4492] Login to / failed for tom: <?xml version="1.0"?>
<status code="unknown">
<summary>Unknown user 'tom' or invalid password</summary>
<details></details>
</status>
[[32mINFO [0m|# 4492] Rendering template within layouts/application
[[32mINFO [0m|# 4492] Rendering user/login
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_watch_and_search (0.8ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_header (1.7ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_personal_navigation (1.7ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_flash (0.2ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|# 4492] Completed in 255ms (View: 9, DB: 1, API: 241, XML: 0) | 200 OK [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|# 4492] REQUESTING PAGE: POST /user/do_login with {"commit"=>"Login", "username"=>"tom", "password"=>"thunder", "return_to_path"=>"/"} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|# 4492] Processing UserController#do_login (for 127.0.0.1 at 2012-04-02 20:48:46) [POST]
[[32mINFO [0m|# 4492] Parameters: {"commit"=>"Login", "username"=>"tom", "password"=>"thunder", "return_to_path"=>"/"}
[[0;37mDEBUG[0m|# 4492] Setting return_to: "/"
[[0;37mDEBUG[0m|# 4492] Authenticating with iChain mode: off
[[32mINFO [0m|# 4492] Anonymous request to /
[[0;37mDEBUG[0m|# 4492] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|# 4492] Doing form authorization to login user tom
[[0;37mDEBUG[0m|# 4492] Person.find( nil, tom)
[[0;37mDEBUG[0m|# 4492] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|# 4492] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 4492] Request took 0.061777 seconds
[[32mINFO [0m|# 4492] Redirected to http://www.example.com/
[[32mINFO [0m|# 4492] Completed in 65ms (DB: 1, API: 62, XML: 0) | 302 Found [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|# 4492] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|# 4492] Processing MainController#index (for 127.0.0.1 at 2012-04-02 20:48:46) [GET]
[[0;37mDEBUG[0m|# 4492] Setting return_to: "/"
[[0;37mDEBUG[0m|# 4492] Authenticating with iChain mode: off
[[32mINFO [0m|# 4492] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|# 4492] Cache delete: Person_00050ad2c3fbf1b3ed06befa376bf798
[[0;37mDEBUG[0m|# 4492] Person.find( 1800 seconds, tom, is_currenttrue)
[[0;37mDEBUG[0m|# 4492] Cache miss: Person_00050ad2c3fbf1b3ed06befa376bf798 ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|# 4492] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|# 4492] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 4492] Request took 0.055773 seconds
[[0;37mDEBUG[0m|# 4492] Cache write (will save 56.27ms): Person_00050ad2c3fbf1b3ed06befa376bf798
[[0;37mDEBUG[0m|# 4492] Cache hit: tom_requests_that_need_work ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|# 4492] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|# 4492] Statusmessage.find( 900 seconds, limit5ordercreate_at DESCconditionsdeleted_at IS NULL)
[[0;37mDEBUG[0m|# 4492] Cache hit: Statusmessage_a709033f132bcb337b990e28a21471da ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|# 4492] LatestUpdated.find( 300 seconds, limit6sharedtrue)
[[0;37mDEBUG[0m|# 4492] Cache hit: LatestUpdated_54ced7cca117da57aa3710fa85a856ff ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|# 4492] Project.find( 1800 seconds, home:tom)
[[0;37mDEBUG[0m|# 4492] Cache hit: Project_037574d33f576da476dc5d210c90782d ({:expires_in=>1800 seconds})
[[32mINFO [0m|# 4492] Rendering template within layouts/application
[[32mINFO [0m|# 4492] Rendering main/index
[[0;37mDEBUG[0m|# 4492] Rendered main/_news (0.9ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_contact (0.2ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_latest_updates (6.9ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_feeds (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_watch_and_search (0.9ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_header (1.8ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_personal_navigation (1.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|# 4492] Completed in 83ms (View: 20, DB: 1, API: 56, XML: 1) | 200 OK [http://www.example.com/]
[[32mINFO [0m|# 4492] Processing UserController#logout (for 127.0.0.1 at 2012-04-02 20:48:46) [POST]
[[0;37mDEBUG[0m|# 4492] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|# 4492] Authenticating with iChain mode: off
[[32mINFO [0m|# 4492] Authenticated request to "/user/logout" from tom
[[0;37mDEBUG[0m|# 4492] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|# 4492] Logging out: tom
[[32mINFO [0m|# 4492] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|# 4492] Cache delete: Person_c81e728d9d4c2f636f067f89cc14862c
[[32mINFO [0m|# 4492] Completed in 3ms (DB: 1, API: 0, XML: 0) | 302 Found [http://www.example.com/user/logout]
[[0;37mDEBUG[0m|# 4492] REQUESTING PAGE: GET / with {} and HTTP headers {}
[[32mINFO [0m|# 4492] Processing MainController#index (for 127.0.0.1 at 2012-04-02 20:48:46) [GET]
[[0;37mDEBUG[0m|# 4492] Setting return_to: "/"
[[0;37mDEBUG[0m|# 4492] Authenticating with iChain mode: off
[[32mINFO [0m|# 4492] Anonymous request to /
[[0;37mDEBUG[0m|# 4492] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|# 4492] Statusmessage.find( 900 seconds, limit5ordercreate_at DESCconditionsdeleted_at IS NULL)
[[0;37mDEBUG[0m|# 4492] Cache hit: Statusmessage_a709033f132bcb337b990e28a21471da ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|# 4492] LatestUpdated.find( 300 seconds, limit6sharedtrue)
[[0;37mDEBUG[0m|# 4492] Cache hit: LatestUpdated_54ced7cca117da57aa3710fa85a856ff ({:expires_in=>300 seconds})
[[32mINFO [0m|# 4492] Rendering template within layouts/application
[[32mINFO [0m|# 4492] Rendering main/index
[[0;37mDEBUG[0m|# 4492] Rendered main/_news (0.9ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_contact (0.2ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_latest_updates (85.5ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered main/_feeds (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_watch_and_search (0.8ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_header (1.6ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_personal_navigation (1.6ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|# 4492] Completed in 101ms (View: 97, DB: 0, API: 0, XML: 1) | 200 OK [http://www.example.com/]
[[0;37mDEBUG[0m|# 4492] REQUESTING PAGE: GET /user/login with {} and HTTP headers {"HTTP_REFERER"=>"/"}
[[32mINFO [0m|# 4492] Processing UserController#login (for 127.0.0.1 at 2012-04-02 20:48:46) [GET]
[[0;37mDEBUG[0m|# 4492] Setting return_to: "/user/login"
[[0;37mDEBUG[0m|# 4492] Authenticating with iChain mode: off
[[32mINFO [0m|# 4492] Anonymous request to /user/login
[[0;37mDEBUG[0m|# 4492] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|# 4492] Rendering template within layouts/application
[[32mINFO [0m|# 4492] Rendering user/login
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_watch_and_search (0.8ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_header (1.6ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_personal_navigation (1.6ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|# 4492] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|# 4492] Completed in 11ms (View: 8, DB: 1, API: 0, XML: 0) | 200 OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|# 4492] REQUESTING PAGE: POST /user/do_login with {"commit"=>"Login", "username"=>"king", "password"=>"sunflower", "return_to_path"=>"/"} and HTTP headers {"HTTP_REFERER"=>"/user/login"}
[[32mINFO [0m|# 4492] Processing UserController#do_login (for 127.0.0.1 at 2012-04-02 20:48:46) [POST]
[[32mINFO [0m|# 4492] Parameters: {"commit"=>"Login", "username"=>"king", "password"=>"sunflower", "return_to_path"=>"/"}
[[0;37mDEBUG[0m|# 4492] Setting return_to: "/"
[[0;37mDEBUG[0m|# 4492] Authenticating with iChain mode: off
[[32mINFO [0m|# 4492] Anonymous request to /
[[0;37mDEBUG[0m|# 4492] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|# 4492] Doing form authorization to login user king
[[0;37mDEBUG[0m|# 4492] Person.find( nil, king)
[[0;37mDEBUG[0m|# 4492] [REST] find( Person, [{:login=>"king"}] )
[[0;37mDEBUG[0m|# 4492] http_do #1: method: get url: http://localhost:3203/person/king
[[0;37mDEBUG[0m|# 4492] Request took 0.018665 seconds
[[32mINFO [0m|# 4492] Redirected to http://www.example.com/
[[32mINFO [0m|# 4492] Completed in 21ms (DB: 0, API: 19, XML: 0) | 302 Found [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|# 4492] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|# 4492] Processing MainController#index (for 127.0.0.1 at 2012-04-02 20:48:46) [GET]
[[0;37mDEBUG[0m|# 4492] Setting return_to: "/"
[[0;37mDEBUG[0m|# 4492] Authenticating with iChain mode: off
[[32mINFO [0m|# 4492] Authenticated request to "/" from king
[[0;37mDEBUG[0m|# 4492] Cache delete: Person_a5f5de8c0030b237f5238d965949964a
[[0;37mDEBUG[0m|# 4492] Person.find( 1800 seconds, king, is_currenttrue)
[[0;37mDEBUG[0m|# 4492] Cache miss: Person_a5f5de8c0030b237f5238d965949964a ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|# 4492] [REST] find( Person, [{:is_current=>"true", :login=>"king"}] )
[[0;37mDEBUG[0m|# 4492] http_do #1: method: get url: http://localhost:3203/person/king
[[0;37mDEBUG[0m|# 4492] Request took 0.055703 seconds
[[0;37mDEBUG[0m|# 4492] Cache write (will save 56.22ms): Person_a5f5de8c0030b237f5238d965949964a
[[0;37mDEBUG[0m|# 4492] Cache miss: king_requests_that_need_work ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|# 4492] Fetching request list from api
[[0;37mDEBUG[0m|# 4492] --> direct_http url: #
See http://ci.opensuse.org/job/obs_master_testsuite_webui/234/changes
Changes:
[Stephan Kulow] [webui] readd ids important for the test suite
[Stephan Kulow] [api] some more fixes for the test suites
[Stephan Kulow] [webui] revert back to bento master, wasn't my intention
------------------------------------------
[...truncated 67182 lines...]
[[0;37mDEBUG[0m|#11975] Rendered layouts/_personal_navigation (1.5ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_flash (7.0ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#11975] Completed in 86ms (View: 83, DB: 1, API: 0, XML: 0) | 200 OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|#11975] REQUESTING PAGE: POST /user/do_login with {"commit"=>"Login", "return_to_path"=>"/", "password"=>"thunderz", "username"=>"tom"} and HTTP headers {"HTTP_REFERER"=>"/user/login"}
[[32mINFO [0m|#11975] Processing UserController#do_login (for 127.0.0.1 at 2012-04-02 21:50:14) [POST]
[[32mINFO [0m|#11975] Parameters: {"commit"=>"Login", "return_to_path"=>"/", "password"=>"thunderz", "username"=>"tom"}
[[0;37mDEBUG[0m|#11975] Setting return_to: "/"
[[0;37mDEBUG[0m|#11975] Authenticating with iChain mode: off
[[32mINFO [0m|#11975] Anonymous request to /
[[0;37mDEBUG[0m|#11975] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#11975] Doing form authorization to login user tom
[[0;37mDEBUG[0m|#11975] Person.find( nil, tom)
[[0;37mDEBUG[0m|#11975] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#11975] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#11975] Request took 0.101626 seconds
[[32mINFO [0m|#11975] Login to / failed for tom: <?xml version="1.0"?>
<status code="unknown">
<summary>Unknown user 'tom' or invalid password</summary>
<details></details>
</status>
[[32mINFO [0m|#11975] Rendering template within layouts/application
[[32mINFO [0m|#11975] Rendering user/login
[[0;37mDEBUG[0m|#11975] Rendered layouts/_watch_and_search (0.8ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_header (1.7ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_personal_navigation (1.7ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_flash (0.2ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#11975] Completed in 116ms (View: 9, DB: 1, API: 102, XML: 0) | 200 OK [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#11975] REQUESTING PAGE: POST /user/do_login with {"commit"=>"Login", "return_to_path"=>"/", "password"=>"thunder", "username"=>"tom"} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#11975] Processing UserController#do_login (for 127.0.0.1 at 2012-04-02 21:50:14) [POST]
[[32mINFO [0m|#11975] Parameters: {"commit"=>"Login", "return_to_path"=>"/", "password"=>"thunder", "username"=>"tom"}
[[0;37mDEBUG[0m|#11975] Setting return_to: "/"
[[0;37mDEBUG[0m|#11975] Authenticating with iChain mode: off
[[32mINFO [0m|#11975] Anonymous request to /
[[0;37mDEBUG[0m|#11975] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#11975] Doing form authorization to login user tom
[[0;37mDEBUG[0m|#11975] Person.find( nil, tom)
[[0;37mDEBUG[0m|#11975] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#11975] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#11975] Request took 0.305395 seconds
[[32mINFO [0m|#11975] Redirected to http://www.example.com/
[[32mINFO [0m|#11975] Completed in 308ms (DB: 1, API: 305, XML: 0) | 302 Found [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#11975] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#11975] Processing MainController#index (for 127.0.0.1 at 2012-04-02 21:50:14) [GET]
[[0;37mDEBUG[0m|#11975] Setting return_to: "/"
[[0;37mDEBUG[0m|#11975] Authenticating with iChain mode: off
[[32mINFO [0m|#11975] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|#11975] Cache delete: Person_00050ad2c3fbf1b3ed06befa376bf798
[[0;37mDEBUG[0m|#11975] Person.find( 1800 seconds, tom, is_currenttrue)
[[0;37mDEBUG[0m|#11975] Cache miss: Person_00050ad2c3fbf1b3ed06befa376bf798 ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#11975] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#11975] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#11975] Request took 0.055744 seconds
[[0;37mDEBUG[0m|#11975] Cache write (will save 56.24ms): Person_00050ad2c3fbf1b3ed06befa376bf798
[[0;37mDEBUG[0m|#11975] Cache hit: tom_requests_that_need_work ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#11975] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#11975] Statusmessage.find( 900 seconds, limit5ordercreate_at DESCconditionsdeleted_at IS NULL)
[[0;37mDEBUG[0m|#11975] Cache hit: Statusmessage_a709033f132bcb337b990e28a21471da ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#11975] LatestUpdated.find( 300 seconds, limit6sharedtrue)
[[0;37mDEBUG[0m|#11975] Cache hit: LatestUpdated_54ced7cca117da57aa3710fa85a856ff ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#11975] Project.find( 1800 seconds, home:tom)
[[0;37mDEBUG[0m|#11975] Cache hit: Project_037574d33f576da476dc5d210c90782d ({:expires_in=>1800 seconds})
[[32mINFO [0m|#11975] Rendering template within layouts/application
[[32mINFO [0m|#11975] Rendering main/index
[[0;37mDEBUG[0m|#11975] Rendered main/_news (1.0ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_contact (0.2ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_latest_updates (6.9ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_feeds (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_watch_and_search (1.0ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_header (1.9ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_personal_navigation (1.1ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#11975] Completed in 83ms (View: 20, DB: 1, API: 56, XML: 1) | 200 OK [http://www.example.com/]
[[32mINFO [0m|#11975] Processing UserController#logout (for 127.0.0.1 at 2012-04-02 21:50:14) [POST]
[[0;37mDEBUG[0m|#11975] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#11975] Authenticating with iChain mode: off
[[32mINFO [0m|#11975] Authenticated request to "/user/logout" from tom
[[0;37mDEBUG[0m|#11975] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#11975] Logging out: tom
[[32mINFO [0m|#11975] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#11975] Cache delete: Person_c81e728d9d4c2f636f067f89cc14862c
[[32mINFO [0m|#11975] Completed in 3ms (DB: 1, API: 0, XML: 0) | 302 Found [http://www.example.com/user/logout]
[[0;37mDEBUG[0m|#11975] REQUESTING PAGE: GET / with {} and HTTP headers {}
[[32mINFO [0m|#11975] Processing MainController#index (for 127.0.0.1 at 2012-04-02 21:50:14) [GET]
[[0;37mDEBUG[0m|#11975] Setting return_to: "/"
[[0;37mDEBUG[0m|#11975] Authenticating with iChain mode: off
[[32mINFO [0m|#11975] Anonymous request to /
[[0;37mDEBUG[0m|#11975] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#11975] Statusmessage.find( 900 seconds, limit5ordercreate_at DESCconditionsdeleted_at IS NULL)
[[0;37mDEBUG[0m|#11975] Cache hit: Statusmessage_a709033f132bcb337b990e28a21471da ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#11975] LatestUpdated.find( 300 seconds, limit6sharedtrue)
[[0;37mDEBUG[0m|#11975] Cache hit: LatestUpdated_54ced7cca117da57aa3710fa85a856ff ({:expires_in=>300 seconds})
[[32mINFO [0m|#11975] Rendering template within layouts/application
[[32mINFO [0m|#11975] Rendering main/index
[[0;37mDEBUG[0m|#11975] Rendered main/_news (1.0ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_contact (0.2ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_latest_updates (7.7ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered main/_feeds (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_watch_and_search (0.8ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_header (1.7ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_personal_navigation (1.8ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#11975] Completed in 108ms (View: 21, DB: 10, API: 0, XML: 1) | 200 OK [http://www.example.com/]
[[0;37mDEBUG[0m|#11975] REQUESTING PAGE: GET /user/login with {} and HTTP headers {"HTTP_REFERER"=>"/"}
[[32mINFO [0m|#11975] Processing UserController#login (for 127.0.0.1 at 2012-04-02 21:50:15) [GET]
[[0;37mDEBUG[0m|#11975] Setting return_to: "/user/login"
[[0;37mDEBUG[0m|#11975] Authenticating with iChain mode: off
[[32mINFO [0m|#11975] Anonymous request to /user/login
[[0;37mDEBUG[0m|#11975] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#11975] Rendering template within layouts/application
[[32mINFO [0m|#11975] Rendering user/login
[[0;37mDEBUG[0m|#11975] Rendered layouts/_watch_and_search (1.2ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_header (2.1ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_personal_navigation (1.7ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#11975] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#11975] Completed in 11ms (View: 8, DB: 1, API: 0, XML: 0) | 200 OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|#11975] REQUESTING PAGE: POST /user/do_login with {"commit"=>"Login", "return_to_path"=>"/", "password"=>"sunflower", "username"=>"king"} and HTTP headers {"HTTP_REFERER"=>"/user/login"}
[[32mINFO [0m|#11975] Processing UserController#do_login (for 127.0.0.1 at 2012-04-02 21:50:15) [POST]
[[32mINFO [0m|#11975] Parameters: {"commit"=>"Login", "return_to_path"=>"/", "password"=>"sunflower", "username"=>"king"}
[[0;37mDEBUG[0m|#11975] Setting return_to: "/"
[[0;37mDEBUG[0m|#11975] Authenticating with iChain mode: off
[[32mINFO [0m|#11975] Anonymous request to /
[[0;37mDEBUG[0m|#11975] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#11975] Doing form authorization to login user king
[[0;37mDEBUG[0m|#11975] Person.find( nil, king)
[[0;37mDEBUG[0m|#11975] [REST] find( Person, [{:login=>"king"}] )
[[0;37mDEBUG[0m|#11975] http_do #1: method: get url: http://localhost:3203/person/king
[[0;37mDEBUG[0m|#11975] Request took 0.019935 seconds
[[32mINFO [0m|#11975] Redirected to http://www.example.com/
[[32mINFO [0m|#11975] Completed in 23ms (DB: 0, API: 20, XML: 0) | 302 Found [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#11975] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#11975] Processing MainController#index (for 127.0.0.1 at 2012-04-02 21:50:15) [GET]
[[0;37mDEBUG[0m|#11975] Setting return_to: "/"
[[0;37mDEBUG[0m|#11975] Authenticating with iChain mode: off
[[32mINFO [0m|#11975] Authenticated request to "/" from king
[[0;37mDEBUG[0m|#11975] Cache delete: Person_a5f5de8c0030b237f5238d965949964a
[[0;37mDEBUG[0m|#11975] Person.find( 1800 seconds, king, is_currenttrue)
[[0;37mDEBUG[0m|#11975] Cache miss: Person_a5f5de8c0030b237f5238d965949964a ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#11975] [REST] find( Person, [{:is_current=>"true", :login=>"king"}] )
[[0;37mDEBUG[0m|#11975] http_do #1: method: get url: http://localhost:3203/person/king
[[0;37mDEBUG[0m|#11975] Request took 0.056696 seconds
[[0;37mDEBUG[0m|#11975] Cache write (will save 57.22ms): Person_a5f5de8c0030b237f5238d965949964a
[[0;37mDEBUG[0m|#11975] Cache miss: king_requests_that_need_work ({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#11975] Fetching request list from api
[[0;37mDEBUG[0m|#11975] --> direct_http url: #
See http://ci.opensuse.org/job/obs_master_testsuite_webui/235/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