Mailinglist Archive: obs-tests (232 mails)

< Previous Next >
[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #247
  • From: admin@xxxxxxxxxxxx
  • Date: Wed, 4 Apr 2012 14:39:02 +0200 (CEST)
  • Message-id: <1137722320.111333543142695.JavaMail.jenkins@ci-opensuse>
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/247/>

------------------------------------------
[...truncated 111236 lines...]
[DEBUG|#12667] Rendered layouts/_flash (0.1ms)
[DEBUG|#12667] Rendered layouts/_sponsor (0.1ms)
[INFO |#12667] Completed in 197ms (View: 6, DB: 0, API: 186, XML: 0) |
200 OK [http://www.example.com/user/do_login]
[DEBUG|#12667] REQUESTING PAGE: POST /user/do_login with
{"return_to_path"=>"/", "username"=>"tom", "password"=>"thunder",
"commit"=>"Login"} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[INFO |#12667]

Processing UserController#do_login (for 127.0.0.1 at 2012-04-04 14:38:59) [POST]
[INFO |#12667] Parameters: {"return_to_path"=>"/",
"username"=>"tom", "password"=>"thunder", "commit"=>"Login"}
[DEBUG|#12667] Setting return_to: "/"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Anonymous request to /
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[DEBUG|#12667] Doing form authorization to login user tom
[DEBUG|#12667] Person.find( nil, tom)
[DEBUG|#12667] [REST] find( Person, [{:login=>"tom"}] )
[DEBUG|#12667] http_do #1: method: get url:
http://localhost:3203/person/tom
[DEBUG|#12667] Request took 0.056962225 seconds
[INFO |#12667] Redirected to http://www.example.com/
[INFO |#12667] Completed in 61ms (DB: 1, API: 57, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[DEBUG|#12667] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[INFO |#12667]

Processing MainController#index (for 127.0.0.1 at 2012-04-04 14:38:59) [GET]
[DEBUG|#12667] Setting return_to: "/"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Authenticated request to "/" from tom
[DEBUG|#12667] Cache delete: Person_bcccc817286c9705b67feb0c7cc953c3
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] Person.find( 1800 seconds, tom, {:is_current=>true})
[DEBUG|#12667] Cache miss: Person_bcccc817286c9705b67feb0c7cc953c3
({:expires_in=>1800 seconds})
[DEBUG|#12667] [REST] find( Person, [{:is_current=>"true",
:login=>"tom"}] )
[DEBUG|#12667] http_do #1: method: get url:
http://localhost:3203/person/tom
[DEBUG|#12667] Request took 0.050888143 seconds
[DEBUG|#12667] Cache write (will save 51.32ms):
Person_bcccc817286c9705b67feb0c7cc953c3
[DEBUG|#12667] Cache hit: tom_requests_that_need_work
({:expires_in=>600 seconds})
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[DEBUG|#12667] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[DEBUG|#12667] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[DEBUG|#12667] Project.find( 1800 seconds, home:tom)
[DEBUG|#12667] Cache hit: Project_adb9094ae2c389898fafee54514195c4
({:expires_in=>1800 seconds})
[INFO |#12667] Rendering template within layouts/application
[INFO |#12667] Rendering main/index
[DEBUG|#12667] Rendered main/_news (0.5ms)
[DEBUG|#12667] Rendered main/_contact (0.1ms)
[DEBUG|#12667] Rendered main/_latest_updates (3.6ms)
[DEBUG|#12667] Rendered main/_countdown (0.1ms)
[DEBUG|#12667] Rendered main/_sponsors (0.0ms)
[DEBUG|#12667] Rendered main/_feeds (0.0ms)
[DEBUG|#12667] Rendered layouts/_watch_and_search (0.4ms)
[DEBUG|#12667] Rendered layouts/_header (0.9ms)
[DEBUG|#12667] Rendered layouts/_personal_navigation (0.4ms)
[DEBUG|#12667] Rendered layouts/_flash (0.1ms)
[DEBUG|#12667] Rendered layouts/_sponsor (0.1ms)
[INFO |#12667] Completed in 69ms (View: 11, DB: 0, API: 51, XML: 1) |
200 OK [http://www.example.com/]
[INFO |#12667]

Processing UserController#logout (for 127.0.0.1 at 2012-04-04 14:39:00) [POST]
[DEBUG|#12667] Setting return_to: "/user/logout"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Authenticated request to "/user/logout" from tom
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[INFO |#12667] Logging out: tom
[INFO |#12667] Redirected to http://www.example.com/
[DEBUG|#12667] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[INFO |#12667] Completed in 4ms (DB: 1, API: 0, XML: 0) | 302 Found
[http://www.example.com/user/logout]
[DEBUG|#12667] REQUESTING PAGE: GET / with {} and HTTP headers {}
[INFO |#12667]

Processing MainController#index (for 127.0.0.1 at 2012-04-04 14:39:00) [GET]
[DEBUG|#12667] Setting return_to: "/"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Anonymous request to /
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[DEBUG|#12667] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[DEBUG|#12667] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[INFO |#12667] Rendering template within layouts/application
[INFO |#12667] Rendering main/index
[DEBUG|#12667] Rendered main/_news (0.5ms)
[DEBUG|#12667] Rendered main/_contact (0.1ms)
[DEBUG|#12667] Rendered main/_latest_updates (3.6ms)
[DEBUG|#12667] Rendered main/_countdown (0.1ms)
[DEBUG|#12667] Rendered main/_sponsors (0.0ms)
[DEBUG|#12667] Rendered main/_feeds (0.0ms)
[DEBUG|#12667] Rendered layouts/_watch_and_search (0.3ms)
[DEBUG|#12667] Rendered layouts/_header (0.7ms)
[DEBUG|#12667] Rendered layouts/_personal_navigation (0.6ms)
[DEBUG|#12667] Rendered layouts/_flash (0.1ms)
[DEBUG|#12667] Rendered layouts/_sponsor (0.1ms)
[INFO |#12667] Completed in 15ms (View: 10, DB: 0, API: 0, XML: 1) |
200 OK [http://www.example.com/]
[DEBUG|#12667] REQUESTING PAGE: GET /user/login with {} and HTTP
headers {"HTTP_REFERER"=>"/"}
[INFO |#12667]

Processing UserController#login (for 127.0.0.1 at 2012-04-04 14:39:00) [GET]
[DEBUG|#12667] Setting return_to: "/user/login"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Anonymous request to /user/login
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[INFO |#12667] Rendering template within layouts/application
[INFO |#12667] Rendering user/login
[DEBUG|#12667] Rendered layouts/_watch_and_search (0.3ms)
[DEBUG|#12667] Rendered layouts/_header (0.8ms)
[DEBUG|#12667] Rendered layouts/_personal_navigation (0.7ms)
[DEBUG|#12667] Rendered layouts/_flash (0.1ms)
[DEBUG|#12667] Rendered layouts/_sponsor (0.1ms)
[INFO |#12667] Completed in 9ms (View: 5, DB: 3, API: 0, XML: 0) | 200
OK [http://www.example.com/user/login]
[DEBUG|#12667] REQUESTING PAGE: POST /user/do_login with
{"return_to_path"=>"/", "username"=>"king", "password"=>"sunflower",
"commit"=>"Login"} and HTTP headers {"HTTP_REFERER"=>"/user/login"}
[INFO |#12667]

Processing UserController#do_login (for 127.0.0.1 at 2012-04-04 14:39:00) [POST]
[INFO |#12667] Parameters: {"return_to_path"=>"/",
"username"=>"king", "password"=>"sunflower", "commit"=>"Login"}
[DEBUG|#12667] Setting return_to: "/"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Anonymous request to /
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[DEBUG|#12667] Doing form authorization to login user king
[DEBUG|#12667] Person.find( nil, king)
[DEBUG|#12667] [REST] find( Person, [{:login=>"king"}] )
[DEBUG|#12667] http_do #1: method: get url:
http://localhost:3203/person/king
[DEBUG|#12667] Request took 0.013120739 seconds
[INFO |#12667] Redirected to http://www.example.com/
[INFO |#12667] Completed in 18ms (DB: 0, API: 13, XML: 0) | 302 Found
[http://www.example.com/user/do_login]
[DEBUG|#12667] REQUESTING PAGE: GET http://www.example.com/ with {}
and HTTP headers {"HTTP_REFERER"=>"/user/do_login"}
[INFO |#12667]

Processing MainController#index (for 127.0.0.1 at 2012-04-04 14:39:00) [GET]
[DEBUG|#12667] Setting return_to: "/"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Authenticated request to "/" from king
[DEBUG|#12667] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] Person.find( 1800 seconds, king, {:is_current=>true})
[DEBUG|#12667] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[DEBUG|#12667] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[DEBUG|#12667] http_do #1: method: get url:
http://localhost:3203/person/king
[DEBUG|#12667] Request took 0.052083102 seconds
[DEBUG|#12667] Cache write (will save 52.53ms):
Person_31bc44caa5b35568da22b828c6853364
[DEBUG|#12667] Cache miss: king_requests_that_need_work
({:expires_in=>600 seconds})
[DEBUG|#12667] Fetching request list from api
[DEBUG|#12667] --> direct_http url: #<URI::Generic:0x000000020a8140
URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king>
[DEBUG|#12667] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king
[DEBUG|#12667] Request took 0.0588989 seconds
[DEBUG|#12667] Fetching request list from api
[DEBUG|#12667] --> direct_http url: #<URI::Generic:0x000000020b86a8
URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king>
[DEBUG|#12667] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king
[DEBUG|#12667] Request took 0.067377115 seconds
[DEBUG|#12667] Fetching request list from api
[DEBUG|#12667] --> direct_http url: #<URI::Generic:0x000000020c3e18
URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king>
[DEBUG|#12667] http_do #1: method: GET url:
http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king
[DEBUG|#12667] Request took 0.071429849 seconds
[DEBUG|#12667] Cache write (will save 199.87ms):
king_requests_that_need_work
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] Statusmessage.find( 900 seconds,
{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5})
[DEBUG|#12667] Cache hit:
Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds})
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] LatestUpdated.find( 300 seconds, {:limit=>6,
:shared=>true})
[DEBUG|#12667] Cache hit:
LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds})
[DEBUG|#12667] Project.find( 1800 seconds, home:king)
[DEBUG|#12667] Cache miss: Project_a5d9fe90affee5686502abd47dc142fa
({:expires_in=>1800 seconds})
[DEBUG|#12667] [REST] find( Project, [{:name=>"home:king"}] )
[DEBUG|#12667] http_do #1: method: get url:
http://localhost:3203/source/home:king/_meta?
[DEBUG|#12667] Request took 0.049248778 seconds
[DEBUG|#12667] Project.find( {:name=>"home:king"} ) did not find
anything, return nil
[DEBUG|#12667] method_missing -to_str- nil
[INFO |#12667] Redirected to
http://www.example.com/configuration/connect_instance
[INFO |#12667] Completed in 309ms (DB: 1, API: 300, XML: 0) | 302
Found [http://www.example.com/]
[DEBUG|#12667] REQUESTING PAGE: GET
http://www.example.com/configuration/connect_instance with {} and HTTP headers
{"HTTP_REFERER"=>"http://www.example.com/"}
[INFO |#12667]

Processing ConfigurationController#connect_instance (for 127.0.0.1 at
2012-04-04 14:39:00) [GET]
[DEBUG|#12667] Setting return_to: "/configuration/connect_instance"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Authenticated request to
"/configuration/connect_instance" from king
[DEBUG|#12667] Cache delete: Person_31bc44caa5b35568da22b828c6853364
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_str- nil
[DEBUG|#12667] method_missing -to_ary- nil
[DEBUG|#12667] Person.find( 1800 seconds, king, {:is_current=>true})
[DEBUG|#12667] Cache miss: Person_31bc44caa5b35568da22b828c6853364
({:expires_in=>1800 seconds})
[DEBUG|#12667] [REST] find( Person, [{:is_current=>"true",
:login=>"king"}] )
[DEBUG|#12667] http_do #1: method: get url:
http://localhost:3203/person/king
[DEBUG|#12667] Request took 0.05093262 seconds
[DEBUG|#12667] Cache write (will save 51.36ms):
Person_31bc44caa5b35568da22b828c6853364
[DEBUG|#12667] Cache hit: king_requests_that_need_work
({:expires_in=>600 seconds})
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[INFO |#12667] Rendering template within layouts/application
[INFO |#12667] Rendering configuration/connect_instance
[DEBUG|#12667] Rendered layouts/_watch_and_search (0.4ms)
[DEBUG|#12667] Rendered layouts/_header (0.9ms)
[DEBUG|#12667] Rendered layouts/_personal_navigation (0.5ms)
[DEBUG|#12667] Rendered layouts/_flash (0.1ms)
[DEBUG|#12667] Rendered layouts/_sponsor (0.1ms)
[INFO |#12667] Completed in 65ms (View: 6, DB: 0, API: 51, XML: 0) |
200 OK [http://www.example.com/configuration/connect_instance]
[INFO |#12667]

Processing UserController#logout (for 127.0.0.1 at 2012-04-04 14:39:00) [POST]
[DEBUG|#12667] Setting return_to: "/user/logout"
[DEBUG|#12667] Authenticating with iChain mode: off
[INFO |#12667] Authenticated request to "/user/logout" from king
[DEBUG|#12667] Cache hit: configuration ({:expires_in=>1800 seconds})
[INFO |#12667] Logging out: king
[INFO |#12667] Redirected to http://www.example.com/
[DEBUG|#12667] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa
[INFO |#12667] 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/development.log src/webui/log/test.log src/webui/tmp/cache
src/webui/tmp/pids src/webui/tmp/sessions src/webui/tmp/sockets
+ exit 0
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
No test report files were found. Configuration error?
Build step 'Publish JUnit test result report' changed build result to FAILURE

--
To unsubscribe, e-mail: obs-tests+unsubscribe@xxxxxxxxxxxx
To contact the owner, e-mail: obs-tests+owner@xxxxxxxxxxxx

< Previous Next >
Follow Ups
References