Mailinglist Archive: obs-tests (232 mails)
| < Previous | Next > |
[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #266
- From: admin@xxxxxxxxxxxx
- Date: Fri, 13 Apr 2012 12:57:18 +0200 (CEST)
- Message-id: <1622040750.1361334314639217.JavaMail.jenkins@ci-opensuse>
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/266/changes>
Changes:
[Sascha Peilicke] [webui] Fix doubled breadcrumbs for remote projects
------------------------------------------
[...truncated 93467 lines...]
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.8ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 227ms (View: 6, DB: 0, API: 166, XML: 0) |
200 OK [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#28561] 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|#28561]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-13 12:57:16) [POST]
[[32mINFO [0m|#28561] Parameters: {"return_to_path"=>"/",
"username"=>"tom", "password"=>"thunder", "commit"=>"Login"}
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Anonymous request to /
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] Doing form authorization to login user tom
[[0;37mDEBUG[0m|#28561] Person.find( nil, tom)
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#28561] Request took 0.05536717 seconds
[[32mINFO [0m|#28561] Redirected to http://www.example.com/
[[32mINFO [0m|#28561] Completed in 60ms (DB: 1, API: 55, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#28561]
Processing MainController#index (for 127.0.0.1 at 2012-04-13 12:57:16) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|#28561] Cache delete: Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Person.find( 1800 seconds, tom, {:is_current=>true})
[[0;37mDEBUG[0m|#28561] Cache miss: Person_bcccc817286c9705b67feb0c7cc953c3
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:is_current=>"true",
:login=>"tom"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#28561] Request took 0.050941281 seconds
[[0;37mDEBUG[0m|#28561] Cache write (will save 51.35ms):
Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#28561] Cache hit: tom_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#28561] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#28561] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#28561] Project.find( 1800 seconds, home:tom)
[[0;37mDEBUG[0m|#28561] Cache hit: Project_adb9094ae2c389898fafee54514195c4
({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Rendering template within layouts/application
[[32mINFO [0m|#28561] Rendering main/index
[[0;37mDEBUG[0m|#28561] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_latest_updates (3.7ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_feeds (0.0ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.4ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 70ms (View: 11, DB: 0, API: 51, XML: 1) |
200 OK [http://www.example.com/]
[[32mINFO [0m|#28561]
Processing UserController#logout (for 127.0.0.1 at 2012-04-13 12:57:16) [POST]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to "/user/logout" from tom
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Logging out: tom
[[32mINFO [0m|#28561] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#28561] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#28561] Completed in 4ms (DB: 1, API: 0, XML: 0) | 302 Found
[http://www.example.com/user/logout]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET / with {} and HTTP headers {}
[[32mINFO [0m|#28561]
Processing MainController#index (for 127.0.0.1 at 2012-04-13 12:57:16) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Anonymous request to /
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#28561] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#28561] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[32mINFO [0m|#28561] Rendering template within layouts/application
[[32mINFO [0m|#28561] Rendering main/index
[[0;37mDEBUG[0m|#28561] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_latest_updates (3.6ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_feeds (0.0ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.7ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 15ms (View: 10, DB: 0, API: 0, XML: 1) |
200 OK [http://www.example.com/]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET /user/login with {} and HTTP
headers {"HTTP_REFERER"=>"/"}
[[32mINFO [0m|#28561]
Processing UserController#login (for 127.0.0.1 at 2012-04-13 12:57:16) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/user/login"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Anonymous request to /user/login
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Rendering template within layouts/application
[[32mINFO [0m|#28561] Rendering user/login
[[0;37mDEBUG[0m|#28561] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.6ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 8ms (View: 4, DB: 1, API: 0, XML: 0) | 200
OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|#28561] 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|#28561]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-13 12:57:16) [POST]
[[32mINFO [0m|#28561] Parameters: {"return_to_path"=>"/",
"username"=>"king", "password"=>"sunflower", "commit"=>"Login"}
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Anonymous request to /
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] Doing form authorization to login user king
[[0;37mDEBUG[0m|#28561] Person.find( nil, king)
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:login=>"king"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#28561] Request took 0.013616039 seconds
[[32mINFO [0m|#28561] Redirected to http://www.example.com/
[[32mINFO [0m|#28561] Completed in 18ms (DB: 0, API: 14, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#28561]
Processing MainController#index (for 127.0.0.1 at 2012-04-13 12:57:16) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to "/" from king
[[0;37mDEBUG[0m|#28561] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#28561] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#28561] Request took 0.04929432 seconds
[[0;37mDEBUG[0m|#28561] Cache write (will save 49.75ms):
Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#28561] Cache miss: king_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#28561] Fetching request list from api
[[0;37mDEBUG[0m|#28561] --> direct_http url: #<URI::Generic:0x00000001f67808
URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king>
[[0;37mDEBUG[0m|#28561] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king
[[0;37mDEBUG[0m|#28561] Request took 0.0588567 seconds
[[0;37mDEBUG[0m|#28561] Fetching request list from api
[[0;37mDEBUG[0m|#28561] --> direct_http url: #<URI::Generic:0x00000001f863c0
URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king>
[[0;37mDEBUG[0m|#28561] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king
[[0;37mDEBUG[0m|#28561] Request took 0.071364434 seconds
[[0;37mDEBUG[0m|#28561] Fetching request list from api
[[0;37mDEBUG[0m|#28561] --> direct_http url: #<URI::Generic:0x00000001fc4580
URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king>
[[0;37mDEBUG[0m|#28561] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king
[[0;37mDEBUG[0m|#28561] Request took 0.071456324 seconds
[[0;37mDEBUG[0m|#28561] Cache write (will save 203.88ms):
king_requests_that_need_work
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#28561] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#28561] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#28561] Project.find( 1800 seconds, home:king)
[[0;37mDEBUG[0m|#28561] Cache miss: Project_a5d9fe90affee5686502abd47dc142fa
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] [REST] find( Project, [{:name=>"home:king"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/source/home:king/_meta?
[[0;37mDEBUG[0m|#28561] Request took 0.048892877 seconds
[[0;37mDEBUG[0m|#28561] Project.find( {:name=>"home:king"} ) did not find
anything, return nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[32mINFO [0m|#28561] Redirected to
http://www.example.com/configuration/connect_instance
[[32mINFO [0m|#28561] Completed in 310ms (DB: 1, API: 300, XML: 0) | 302
Found [http://www.example.com/]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET
http://www.example.com/configuration/connect_instance with {} and HTTP headers
{"HTTP_REFERER"=>"http://www.example.com/"}
[[32mINFO [0m|#28561]
Processing ConfigurationController#connect_instance (for 127.0.0.1 at
2012-04-13 12:57:17) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/configuration/connect_instance"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to
"/configuration/connect_instance" from king
[[0;37mDEBUG[0m|#28561] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#28561] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#28561] Request took 0.050895331 seconds
[[0;37mDEBUG[0m|#28561] Cache write (will save 51.33ms):
Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#28561] Cache hit: king_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Rendering template within layouts/application
[[32mINFO [0m|#28561] Rendering configuration/connect_instance
[[0;37mDEBUG[0m|#28561] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.6ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 65ms (View: 6, DB: 0, API: 51, XML: 0) |
200 OK [http://www.example.com/configuration/connect_instance]
[[32mINFO [0m|#28561]
Processing UserController#logout (for 127.0.0.1 at 2012-04-13 12:57:17) [POST]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to "/user/logout" from king
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Logging out: king
[[32mINFO [0m|#28561] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#28561] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#28561] Completed in 4ms (DB: 1, 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/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] Fix doubled breadcrumbs for remote projects
------------------------------------------
[...truncated 93467 lines...]
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.8ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 227ms (View: 6, DB: 0, API: 166, XML: 0) |
200 OK [http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#28561] 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|#28561]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-13 12:57:16) [POST]
[[32mINFO [0m|#28561] Parameters: {"return_to_path"=>"/",
"username"=>"tom", "password"=>"thunder", "commit"=>"Login"}
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Anonymous request to /
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] Doing form authorization to login user tom
[[0;37mDEBUG[0m|#28561] Person.find( nil, tom)
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#28561] Request took 0.05536717 seconds
[[32mINFO [0m|#28561] Redirected to http://www.example.com/
[[32mINFO [0m|#28561] Completed in 60ms (DB: 1, API: 55, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#28561]
Processing MainController#index (for 127.0.0.1 at 2012-04-13 12:57:16) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|#28561] Cache delete: Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Person.find( 1800 seconds, tom, {:is_current=>true})
[[0;37mDEBUG[0m|#28561] Cache miss: Person_bcccc817286c9705b67feb0c7cc953c3
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:is_current=>"true",
:login=>"tom"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#28561] Request took 0.050941281 seconds
[[0;37mDEBUG[0m|#28561] Cache write (will save 51.35ms):
Person_bcccc817286c9705b67feb0c7cc953c3
[[0;37mDEBUG[0m|#28561] Cache hit: tom_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#28561] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#28561] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#28561] Project.find( 1800 seconds, home:tom)
[[0;37mDEBUG[0m|#28561] Cache hit: Project_adb9094ae2c389898fafee54514195c4
({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Rendering template within layouts/application
[[32mINFO [0m|#28561] Rendering main/index
[[0;37mDEBUG[0m|#28561] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_latest_updates (3.7ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_feeds (0.0ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.4ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 70ms (View: 11, DB: 0, API: 51, XML: 1) |
200 OK [http://www.example.com/]
[[32mINFO [0m|#28561]
Processing UserController#logout (for 127.0.0.1 at 2012-04-13 12:57:16) [POST]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to "/user/logout" from tom
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Logging out: tom
[[32mINFO [0m|#28561] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#28561] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#28561] Completed in 4ms (DB: 1, API: 0, XML: 0) | 302 Found
[http://www.example.com/user/logout]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET / with {} and HTTP headers {}
[[32mINFO [0m|#28561]
Processing MainController#index (for 127.0.0.1 at 2012-04-13 12:57:16) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Anonymous request to /
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#28561] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#28561] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[32mINFO [0m|#28561] Rendering template within layouts/application
[[32mINFO [0m|#28561] Rendering main/index
[[0;37mDEBUG[0m|#28561] Rendered main/_news (0.5ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_contact (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_latest_updates (3.6ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_countdown (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_sponsors (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered main/_feeds (0.0ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.7ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 15ms (View: 10, DB: 0, API: 0, XML: 1) |
200 OK [http://www.example.com/]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET /user/login with {} and HTTP
headers {"HTTP_REFERER"=>"/"}
[[32mINFO [0m|#28561]
Processing UserController#login (for 127.0.0.1 at 2012-04-13 12:57:16) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/user/login"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Anonymous request to /user/login
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Rendering template within layouts/application
[[32mINFO [0m|#28561] Rendering user/login
[[0;37mDEBUG[0m|#28561] Rendered layouts/_watch_and_search (0.3ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_header (0.7ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.6ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 8ms (View: 4, DB: 1, API: 0, XML: 0) | 200
OK [http://www.example.com/user/login]
[[0;37mDEBUG[0m|#28561] 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|#28561]
Processing UserController#do_login (for 127.0.0.1 at 2012-04-13 12:57:16) [POST]
[[32mINFO [0m|#28561] Parameters: {"return_to_path"=>"/",
"username"=>"king", "password"=>"sunflower", "commit"=>"Login"}
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Anonymous request to /
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] Doing form authorization to login user king
[[0;37mDEBUG[0m|#28561] Person.find( nil, king)
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:login=>"king"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#28561] Request took 0.013616039 seconds
[[32mINFO [0m|#28561] Redirected to http://www.example.com/
[[32mINFO [0m|#28561] Completed in 18ms (DB: 0, API: 14, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[[32mINFO [0m|#28561]
Processing MainController#index (for 127.0.0.1 at 2012-04-13 12:57:16) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to "/" from king
[[0;37mDEBUG[0m|#28561] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#28561] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#28561] Request took 0.04929432 seconds
[[0;37mDEBUG[0m|#28561] Cache write (will save 49.75ms):
Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#28561] Cache miss: king_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#28561] Fetching request list from api
[[0;37mDEBUG[0m|#28561] --> direct_http url: #<URI::Generic:0x00000001f67808
URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king>
[[0;37mDEBUG[0m|#28561] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king
[[0;37mDEBUG[0m|#28561] Request took 0.0588567 seconds
[[0;37mDEBUG[0m|#28561] Fetching request list from api
[[0;37mDEBUG[0m|#28561] --> direct_http url: #<URI::Generic:0x00000001f863c0
URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king>
[[0;37mDEBUG[0m|#28561] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king
[[0;37mDEBUG[0m|#28561] Request took 0.071364434 seconds
[[0;37mDEBUG[0m|#28561] Fetching request list from api
[[0;37mDEBUG[0m|#28561] --> direct_http url: #<URI::Generic:0x00000001fc4580
URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king>
[[0;37mDEBUG[0m|#28561] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king
[[0;37mDEBUG[0m|#28561] Request took 0.071456324 seconds
[[0;37mDEBUG[0m|#28561] Cache write (will save 203.88ms):
king_requests_that_need_work
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[[0;37mDEBUG[0m|#28561] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[[0;37mDEBUG[0m|#28561] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[[0;37mDEBUG[0m|#28561] Project.find( 1800 seconds, home:king)
[[0;37mDEBUG[0m|#28561] Cache miss: Project_a5d9fe90affee5686502abd47dc142fa
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] [REST] find( Project, [{:name=>"home:king"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/source/home:king/_meta?
[[0;37mDEBUG[0m|#28561] Request took 0.048892877 seconds
[[0;37mDEBUG[0m|#28561] Project.find( {:name=>"home:king"} ) did not find
anything, return nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[32mINFO [0m|#28561] Redirected to
http://www.example.com/configuration/connect_instance
[[32mINFO [0m|#28561] Completed in 310ms (DB: 1, API: 300, XML: 0) | 302
Found [http://www.example.com/]
[[0;37mDEBUG[0m|#28561] REQUESTING PAGE: GET
http://www.example.com/configuration/connect_instance with {} and HTTP headers
{"HTTP_REFERER"=>"http://www.example.com/"}
[[32mINFO [0m|#28561]
Processing ConfigurationController#connect_instance (for 127.0.0.1 at
2012-04-13 12:57:17) [GET]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/configuration/connect_instance"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to
"/configuration/connect_instance" from king
[[0;37mDEBUG[0m|#28561] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_str- nil
[[0;37mDEBUG[0m|#28561] method_missing -to_ary- nil
[[0;37mDEBUG[0m|#28561] Person.find( 1800 seconds, king, {:is_current=>true})
[[0;37mDEBUG[0m|#28561] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[[0;37mDEBUG[0m|#28561] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[[0;37mDEBUG[0m|#28561] http_do #1: method: get url:
http://localhost:3203/person/king
[[0;37mDEBUG[0m|#28561] Request took 0.050895331 seconds
[[0;37mDEBUG[0m|#28561] Cache write (will save 51.33ms):
Person_31bc44caa5b35568da22b828c6853364
[[0;37mDEBUG[0m|#28561] Cache hit: king_requests_that_need_work
({:expires_in=>600 seconds})
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Rendering template within layouts/application
[[32mINFO [0m|#28561] Rendering configuration/connect_instance
[[0;37mDEBUG[0m|#28561] Rendered layouts/_watch_and_search (0.4ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_header (0.9ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_personal_navigation (0.6ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_flash (0.1ms)
[[0;37mDEBUG[0m|#28561] Rendered layouts/_sponsor (0.1ms)
[[32mINFO [0m|#28561] Completed in 65ms (View: 6, DB: 0, API: 51, XML: 0) |
200 OK [http://www.example.com/configuration/connect_instance]
[[32mINFO [0m|#28561]
Processing UserController#logout (for 127.0.0.1 at 2012-04-13 12:57:17) [POST]
[[0;37mDEBUG[0m|#28561] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#28561] Authenticating with iChain mode: off
[[32mINFO [0m|#28561] Authenticated request to "/user/logout" from king
[[0;37mDEBUG[0m|#28561] Cache hit: configuration ({:expires_in=>1800 seconds})
[[32mINFO [0m|#28561] Logging out: king
[[32mINFO [0m|#28561] Redirected to http://www.example.com/
[[0;37mDEBUG[0m|#28561] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#28561] Completed in 4ms (DB: 1, 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/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 > |