Mailinglist Archive: obs-tests (232 mails)
| < Previous | Next > |
[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #257
- From: admin@xxxxxxxxxxxx
- Date: Wed, 11 Apr 2012 12:06:02 +0200 (CEST)
- Message-id: <926103347.301334138763195.JavaMail.jenkins@ci-opensuse>
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/257/changes>
Changes:
[Sascha Peilicke] [webui] Adjust redirects for the PackageController's
'packages' action to 'show' action
[Sascha Peilicke] [webui] Adjust testsuite to wording and route changes
------------------------------------------
[...truncated 76556 lines...]
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.7ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 365ms (View: 6, DB: 0, API: 354, XML: 0) |
200 OK [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#13520] 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|#13520]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-11 12:06:00) [POST]
[[32mINFO [0m|#13520] Parameters: {"return_to_path"=>"/",
"username"=>"tom", "password"=>"thunder", "commit"=>"Login"}
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Anonymous request to /
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] Doing form authorization to login user tom
[[0;37mDEBUG[0m|#13520] Person.find( nil, tom)
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#13520] Request took 0.056104995 seconds
[[32mINFO [0m|#13520] Redirected to http://www.example.com/
[[32mINFO [0m|#13520] Completed in 60ms (DB: 1, API: 56, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#13520]
Processing MainController#index (for 127.0.0.1 at 2012-04-11 12:06:00) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|#13520] Cache delete: Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Person.find( 1800 seconds, tom, {:is_current=>true})
[[0;37mDEBUG[0m|#13520] Cache miss: Person_bcccc817286c9705b67feb0c7cc953c3
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:is_current=>"true",
:login=>"tom"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#13520] Request took 0.05101106 seconds
[[0;37mDEBUG[0m|#13520] Cache write (will save 51.49ms):
Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#13520] Cache hit: tom_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#13520] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#13520] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#13520] Project.find( 1800 seconds, home:tom)
[[0;37mDEBUG[0m|#13520] Cache hit: Project_adb9094ae2c389898fafee54514195c4
({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Rendering template within layouts/application
[[32mINFO [0m|#13520] Rendering main/index
[[0;37mDEBUG[0m|#13520] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_latest_updates (3.6ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_feeds (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.4ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 70ms (View: 11, DB: 0, API: 51, XML: 1) |
200 OK [http://www.example.com/]
[[32mINFO [0m|#13520]
Processing UserController#logout (for 127.0.0.1 at 2012-04-11 12:06:00) [POST]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to "/user/logout" from tom
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Logging out: tom
[[32mINFO [0m|#13520] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#13520] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#13520] Completed in 4ms (DB: 1, API: 0, XML: 0) | 302 Found
[http://www.example.com/user/logout]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET / with {} and HTTP headers {}
[[32mINFO [0m|#13520]
Processing MainController#index (for 127.0.0.1 at 2012-04-11 12:06:00) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Anonymous request to /
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#13520] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#13520] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[32mINFO [0m|#13520] Rendering template within layouts/application
[[32mINFO [0m|#13520] Rendering main/index
[[0;37mDEBUG[0m|#13520] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_latest_updates (3.7ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_sponsors (0.0ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_feeds (0.0ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.7ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 16ms (View: 10, DB: 0, API: 0, XML: 1) |
200 OK [http://www.example.com/]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET /user/login with {} and HTTP
headers {"HTTP_REFERER"=>"/"}
[[32mINFO [0m|#13520]
Processing UserController#login (for 127.0.0.1 at 2012-04-11 12:06:00) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/user/login"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Anonymous request to /user/login
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Rendering template within layouts/application
[[32mINFO [0m|#13520] Rendering user/login
[[0;37mDEBUG[0m|#13520] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.6ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 8ms (View: 4, DB: 1, API: 0, XML: 0) | 200
OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|#13520] 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|#13520]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-11 12:06:00) [POST]
[[32mINFO [0m|#13520] Parameters: {"return_to_path"=>"/",
"username"=>"king", "password"=>"sunflower", "commit"=>"Login"}
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Anonymous request to /
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] Doing form authorization to login user king
[[0;37mDEBUG[0m|#13520] Person.find( nil, king)
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:login=>"king"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#13520] Request took 0.013123834 seconds
[[32mINFO [0m|#13520] Redirected to http://www.example.com/
[[32mINFO [0m|#13520] Completed in 17ms (DB: 0, API: 13, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#13520]
Processing MainController#index (for 127.0.0.1 at 2012-04-11 12:06:00) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to "/" from king
[[0;37mDEBUG[0m|#13520] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#13520] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#13520] Request took 0.049987566 seconds
[[0;37mDEBUG[0m|#13520] Cache write (will save 50.39ms):
Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#13520] Cache miss: king_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#13520] Fetching request list from api
[[0;37mDEBUG[0m|#13520] --> direct_http url: #<URI::Generic:0x00000005849bd0
URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king>
[[0;37mDEBUG[0m|#13520] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king
[[0;37mDEBUG[0m|#13520] Request took 0.059003323 seconds
[[0;37mDEBUG[0m|#13520] Fetching request list from api
[[0;37mDEBUG[0m|#13520] --> direct_http url: #<URI::Generic:0x00000005866af0
URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king>
[[0;37mDEBUG[0m|#13520] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king
[[0;37mDEBUG[0m|#13520] Request took 0.075504087 seconds
[[0;37mDEBUG[0m|#13520] Fetching request list from api
[[0;37mDEBUG[0m|#13520] --> direct_http url: #<URI::Generic:0x00000005a50730
URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king>
[[0;37mDEBUG[0m|#13520] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king
[[0;37mDEBUG[0m|#13520] Request took 0.071319963 seconds
[[0;37mDEBUG[0m|#13520] Cache write (will save 207.95ms):
king_requests_that_need_work
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#13520] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#13520] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#13520] Project.find( 1800 seconds, home:king)
[[0;37mDEBUG[0m|#13520] Cache miss: Project_a5d9fe90affee5686502abd47dc142fa
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] [REST] find( Project, [{:name=>"home:king"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/source/home:king/_meta?
[[0;37mDEBUG[0m|#13520] Request took 0.05319015 seconds
[[0;37mDEBUG[0m|#13520] Project.find( {:name=>"home:king"} ) did not find
anything, return nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[32mINFO [0m|#13520] Redirected to
http://www.example.com/configuration/connect_instance
[[32mINFO [0m|#13520] Completed in 318ms (DB: 1, API: 310, XML: 0) | 302
Found [http://www.example.com/]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET
http://www.example.com/configuration/connect_instance with {} and HTTP headers
{"HTTP_REFERER"=>"http://www.example.com/"}
[[32mINFO [0m|#13520]
Processing ConfigurationController#connect_instance (for 127.0.0.1 at
2012-04-11 12:06:01) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/configuration/connect_instance"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to
"/configuration/connect_instance" from king
[[0;37mDEBUG[0m|#13520] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#13520] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#13520] Request took 0.051330799 seconds
[[0;37mDEBUG[0m|#13520] Cache write (will save 51.73ms):
Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#13520] Cache hit: king_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Rendering template within layouts/application
[[32mINFO [0m|#13520] Rendering configuration/connect_instance
[[0;37mDEBUG[0m|#13520] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.5ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 65ms (View: 6, DB: 0, API: 51, XML: 0) |
200 OK [http://www.example.com/configuration/connect_instance]
[[32mINFO [0m|#13520]
Processing UserController#logout (for 127.0.0.1 at 2012-04-11 12:06:01) [POST]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to "/user/logout" from king
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Logging out: king
[[32mINFO [0m|#13520] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#13520] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#13520] Completed in 51ms (DB: 3, API: 0, XML: 0) | 302 Found
[http://www.example.com/user/logout]
+ echo
+ cleanup
+ echo 'Killing backend processes'
Killing backend processes
+ egrep 'perl|ruby'
+ fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>
USER PID ACCESS COMMAND
<http://ci.opensuse.org/job/obs_master_testsuite_webui/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
Recording test results
--
To unsubscribe, e-mail: obs-tests+unsubscribe@xxxxxxxxxxxx
To contact the owner, e-mail: obs-tests+owner@xxxxxxxxxxxx
Changes:
[Sascha Peilicke] [webui] Adjust redirects for the PackageController's
'packages' action to 'show' action
[Sascha Peilicke] [webui] Adjust testsuite to wording and route changes
------------------------------------------
[...truncated 76556 lines...]
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.7ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 365ms (View: 6, DB: 0, API: 354, XML: 0) |
200 OK [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#13520] 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|#13520]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-11 12:06:00) [POST]
[[32mINFO [0m|#13520] Parameters: {"return_to_path"=>"/",
"username"=>"tom", "password"=>"thunder", "commit"=>"Login"}
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Anonymous request to /
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] Doing form authorization to login user tom
[[0;37mDEBUG[0m|#13520] Person.find( nil, tom)
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#13520] Request took 0.056104995 seconds
[[32mINFO [0m|#13520] Redirected to http://www.example.com/
[[32mINFO [0m|#13520] Completed in 60ms (DB: 1, API: 56, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#13520]
Processing MainController#index (for 127.0.0.1 at 2012-04-11 12:06:00) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|#13520] Cache delete: Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Person.find( 1800 seconds, tom, {:is_current=>true})
[[0;37mDEBUG[0m|#13520] Cache miss: Person_bcccc817286c9705b67feb0c7cc953c3
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:is_current=>"true",
:login=>"tom"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#13520] Request took 0.05101106 seconds
[[0;37mDEBUG[0m|#13520] Cache write (will save 51.49ms):
Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#13520] Cache hit: tom_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#13520] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#13520] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#13520] Project.find( 1800 seconds, home:tom)
[[0;37mDEBUG[0m|#13520] Cache hit: Project_adb9094ae2c389898fafee54514195c4
({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Rendering template within layouts/application
[[32mINFO [0m|#13520] Rendering main/index
[[0;37mDEBUG[0m|#13520] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_latest_updates (3.6ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_feeds (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.4ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 70ms (View: 11, DB: 0, API: 51, XML: 1) |
200 OK [http://www.example.com/]
[[32mINFO [0m|#13520]
Processing UserController#logout (for 127.0.0.1 at 2012-04-11 12:06:00) [POST]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to "/user/logout" from tom
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Logging out: tom
[[32mINFO [0m|#13520] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#13520] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#13520] Completed in 4ms (DB: 1, API: 0, XML: 0) | 302 Found
[http://www.example.com/user/logout]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET / with {} and HTTP headers {}
[[32mINFO [0m|#13520]
Processing MainController#index (for 127.0.0.1 at 2012-04-11 12:06:00) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Anonymous request to /
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#13520] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#13520] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[32mINFO [0m|#13520] Rendering template within layouts/application
[[32mINFO [0m|#13520] Rendering main/index
[[0;37mDEBUG[0m|#13520] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_latest_updates (3.7ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_sponsors (0.0ms)
[[0;37mDEBUG[0m|#13520] Rendered main/_feeds (0.0ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.7ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 16ms (View: 10, DB: 0, API: 0, XML: 1) |
200 OK [http://www.example.com/]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET /user/login with {} and HTTP
headers {"HTTP_REFERER"=>"/"}
[[32mINFO [0m|#13520]
Processing UserController#login (for 127.0.0.1 at 2012-04-11 12:06:00) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/user/login"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Anonymous request to /user/login
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Rendering template within layouts/application
[[32mINFO [0m|#13520] Rendering user/login
[[0;37mDEBUG[0m|#13520] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.6ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 8ms (View: 4, DB: 1, API: 0, XML: 0) | 200
OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|#13520] 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|#13520]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-11 12:06:00) [POST]
[[32mINFO [0m|#13520] Parameters: {"return_to_path"=>"/",
"username"=>"king", "password"=>"sunflower", "commit"=>"Login"}
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Anonymous request to /
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] Doing form authorization to login user king
[[0;37mDEBUG[0m|#13520] Person.find( nil, king)
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:login=>"king"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#13520] Request took 0.013123834 seconds
[[32mINFO [0m|#13520] Redirected to http://www.example.com/
[[32mINFO [0m|#13520] Completed in 17ms (DB: 0, API: 13, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#13520]
Processing MainController#index (for 127.0.0.1 at 2012-04-11 12:06:00) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to "/" from king
[[0;37mDEBUG[0m|#13520] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#13520] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#13520] Request took 0.049987566 seconds
[[0;37mDEBUG[0m|#13520] Cache write (will save 50.39ms):
Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#13520] Cache miss: king_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#13520] Fetching request list from api
[[0;37mDEBUG[0m|#13520] --> direct_http url: #<URI::Generic:0x00000005849bd0
URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king>
[[0;37mDEBUG[0m|#13520] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king
[[0;37mDEBUG[0m|#13520] Request took 0.059003323 seconds
[[0;37mDEBUG[0m|#13520] Fetching request list from api
[[0;37mDEBUG[0m|#13520] --> direct_http url: #<URI::Generic:0x00000005866af0
URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king>
[[0;37mDEBUG[0m|#13520] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king
[[0;37mDEBUG[0m|#13520] Request took 0.075504087 seconds
[[0;37mDEBUG[0m|#13520] Fetching request list from api
[[0;37mDEBUG[0m|#13520] --> direct_http url: #<URI::Generic:0x00000005a50730
URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king>
[[0;37mDEBUG[0m|#13520] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king
[[0;37mDEBUG[0m|#13520] Request took 0.071319963 seconds
[[0;37mDEBUG[0m|#13520] Cache write (will save 207.95ms):
king_requests_that_need_work
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#13520] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#13520] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#13520] Project.find( 1800 seconds, home:king)
[[0;37mDEBUG[0m|#13520] Cache miss: Project_a5d9fe90affee5686502abd47dc142fa
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] [REST] find( Project, [{:name=>"home:king"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/source/home:king/_meta?
[[0;37mDEBUG[0m|#13520] Request took 0.05319015 seconds
[[0;37mDEBUG[0m|#13520] Project.find( {:name=>"home:king"} ) did not find
anything, return nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[32mINFO [0m|#13520] Redirected to
http://www.example.com/configuration/connect_instance
[[32mINFO [0m|#13520] Completed in 318ms (DB: 1, API: 310, XML: 0) | 302
Found [http://www.example.com/]
[[0;37mDEBUG[0m|#13520] REQUESTING PAGE: GET
http://www.example.com/configuration/connect_instance with {} and HTTP headers
{"HTTP_REFERER"=>"http://www.example.com/"}
[[32mINFO [0m|#13520]
Processing ConfigurationController#connect_instance (for 127.0.0.1 at
2012-04-11 12:06:01) [GET]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/configuration/connect_instance"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to
"/configuration/connect_instance" from king
[[0;37mDEBUG[0m|#13520] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_str- nil
[[0;37mDEBUG[0m|#13520] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#13520] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#13520] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#13520] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[[0;37mDEBUG[0m|#13520] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#13520] Request took 0.051330799 seconds
[[0;37mDEBUG[0m|#13520] Cache write (will save 51.73ms):
Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#13520] Cache hit: king_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Rendering template within layouts/application
[[32mINFO [0m|#13520] Rendering configuration/connect_instance
[[0;37mDEBUG[0m|#13520] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_personal_navigation (0.5ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#13520] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#13520] Completed in 65ms (View: 6, DB: 0, API: 51, XML: 0) |
200 OK [http://www.example.com/configuration/connect_instance]
[[32mINFO [0m|#13520]
Processing UserController#logout (for 127.0.0.1 at 2012-04-11 12:06:01) [POST]
[[0;37mDEBUG[0m|#13520] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#13520] Authenticating with iChain mode: off
[[32mINFO [0m|#13520] Authenticated request to "/user/logout" from king
[[0;37mDEBUG[0m|#13520] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#13520] Logging out: king
[[32mINFO [0m|#13520] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#13520] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#13520] Completed in 51ms (DB: 3, API: 0, XML: 0) | 302 Found
[http://www.example.com/user/logout]
+ echo
+ cleanup
+ echo 'Killing backend processes'
Killing backend processes
+ egrep 'perl|ruby'
+ fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/>
USER PID ACCESS COMMAND
<http://ci.opensuse.org/job/obs_master_testsuite_webui/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
Recording test results
--
To unsubscribe, e-mail: obs-tests+unsubscribe@xxxxxxxxxxxx
To contact the owner, e-mail: obs-tests+owner@xxxxxxxxxxxx
| < Previous | Next > |