[obs-tests] Build failed in Jenkins: obs_master_testsuite_webui #250
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/250/changes> Changes: [mls] [backend] serialize source diff creation if the same diff is requested multiple times ------------------------------------------ [...truncated 96693 lines...] [[0;37mDEBUG[0m|#30290] Rendered layouts/_personal_navigation (0.7ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|#30290] Completed in 326ms (View: 6, DB: 0, API: 315, XML: 0) | 200 OK [http://www.example.com/user/do_login] [[0;37mDEBUG[0m|#30290] 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|#30290] Processing UserController#do_login (for 127.0.0.1 at 2012-04-04 18:33:01) [POST] [[32mINFO [0m|#30290] Parameters: {"return_to_path"=>"/", "username"=>"tom", "password"=>"thunder", "commit"=>"Login"} [[0;37mDEBUG[0m|#30290] Setting return_to: "/" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Anonymous request to / [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] Doing form authorization to login user tom [[0;37mDEBUG[0m|#30290] Person.find( nil, tom) [[0;37mDEBUG[0m|#30290] [REST] find( Person, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|#30290] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#30290] Request took 0.091727706 seconds [[32mINFO [0m|#30290] Redirected to http://www.example.com/ [[32mINFO [0m|#30290] Completed in 97ms (DB: 1, API: 92, XML: 0) | 302 Found [http://www.example.com/user/do_login] [[0;37mDEBUG[0m|#30290] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"} [[32mINFO [0m|#30290] Processing MainController#index (for 127.0.0.1 at 2012-04-04 18:33:01) [GET] [[0;37mDEBUG[0m|#30290] Setting return_to: "/" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Authenticated request to "/" from tom [[0;37mDEBUG[0m|#30290] Cache delete: Person_bcccc817286c9705b67feb0c7cc953c3 [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] Person.find( 1800 seconds, tom, {:is_current=>true}) [[0;37mDEBUG[0m|#30290] Cache miss: Person_bcccc817286c9705b67feb0c7cc953c3 ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|#30290] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|#30290] Request took 0.047938818 seconds [[0;37mDEBUG[0m|#30290] Cache write (will save 48.38ms): Person_bcccc817286c9705b67feb0c7cc953c3 [[0;37mDEBUG[0m|#30290] Cache hit: tom_requests_that_need_work ({:expires_in=>600 seconds}) [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] Statusmessage.find( 900 seconds, {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5}) [[0;37mDEBUG[0m|#30290] Cache hit: Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds}) [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] LatestUpdated.find( 300 seconds, {:limit=>6, :shared=>true}) [[0;37mDEBUG[0m|#30290] Cache hit: LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds}) [[0;37mDEBUG[0m|#30290] Project.find( 1800 seconds, home:tom) [[0;37mDEBUG[0m|#30290] Cache hit: Project_adb9094ae2c389898fafee54514195c4 ({:expires_in=>1800 seconds}) [[32mINFO [0m|#30290] Rendering template within layouts/application [[32mINFO [0m|#30290] Rendering main/index [[0;37mDEBUG[0m|#30290] Rendered main/_news (0.5ms) [[0;37mDEBUG[0m|#30290] Rendered main/_contact (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered main/_latest_updates (3.8ms) [[0;37mDEBUG[0m|#30290] Rendered main/_countdown (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered main/_sponsors (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered main/_feeds (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_watch_and_search (0.5ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_header (0.9ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_personal_navigation (0.4ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|#30290] Completed in 67ms (View: 12, DB: 0, API: 48, XML: 1) | 200 OK [http://www.example.com/] [[32mINFO [0m|#30290] Processing UserController#logout (for 127.0.0.1 at 2012-04-04 18:33:02) [POST] [[0;37mDEBUG[0m|#30290] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Authenticated request to "/user/logout" from tom [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[32mINFO [0m|#30290] Logging out: tom [[32mINFO [0m|#30290] Redirected to http://www.example.com/ [[0;37mDEBUG[0m|#30290] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#30290] Completed in 4ms (DB: 1, API: 0, XML: 0) | 302 Found [http://www.example.com/user/logout] [[0;37mDEBUG[0m|#30290] REQUESTING PAGE: GET / with {} and HTTP headers {} [[32mINFO [0m|#30290] Processing MainController#index (for 127.0.0.1 at 2012-04-04 18:33:02) [GET] [[0;37mDEBUG[0m|#30290] Setting return_to: "/" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Anonymous request to / [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] Statusmessage.find( 900 seconds, {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5}) [[0;37mDEBUG[0m|#30290] Cache hit: Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds}) [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] LatestUpdated.find( 300 seconds, {:limit=>6, :shared=>true}) [[0;37mDEBUG[0m|#30290] Cache hit: LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds}) [[32mINFO [0m|#30290] Rendering template within layouts/application [[32mINFO [0m|#30290] Rendering main/index [[0;37mDEBUG[0m|#30290] Rendered main/_news (0.5ms) [[0;37mDEBUG[0m|#30290] Rendered main/_contact (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered main/_latest_updates (3.6ms) [[0;37mDEBUG[0m|#30290] Rendered main/_countdown (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered main/_sponsors (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered main/_feeds (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_watch_and_search (0.3ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_header (0.7ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_personal_navigation (0.6ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|#30290] Completed in 15ms (View: 10, DB: 0, API: 0, XML: 1) | 200 OK [http://www.example.com/] [[0;37mDEBUG[0m|#30290] REQUESTING PAGE: GET /user/login with {} and HTTP headers {"HTTP_REFERER"=>"/"} [[32mINFO [0m|#30290] Processing UserController#login (for 127.0.0.1 at 2012-04-04 18:33:02) [GET] [[0;37mDEBUG[0m|#30290] Setting return_to: "/user/login" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Anonymous request to /user/login [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[32mINFO [0m|#30290] Rendering template within layouts/application [[32mINFO [0m|#30290] Rendering user/login [[0;37mDEBUG[0m|#30290] Rendered layouts/_watch_and_search (0.3ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_header (0.7ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_personal_navigation (0.6ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|#30290] Completed in 8ms (View: 4, DB: 1, API: 0, XML: 0) | 200 OK [http://www.example.com/user/login] [[0;37mDEBUG[0m|#30290] 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|#30290] Processing UserController#do_login (for 127.0.0.1 at 2012-04-04 18:33:02) [POST] [[32mINFO [0m|#30290] Parameters: {"return_to_path"=>"/", "username"=>"king", "password"=>"sunflower", "commit"=>"Login"} [[0;37mDEBUG[0m|#30290] Setting return_to: "/" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Anonymous request to / [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] Doing form authorization to login user king [[0;37mDEBUG[0m|#30290] Person.find( nil, king) [[0;37mDEBUG[0m|#30290] [REST] find( Person, [{:login=>"king"}] ) [[0;37mDEBUG[0m|#30290] http_do #1: method: get url: http://localhost:3203/person/king [[0;37mDEBUG[0m|#30290] Request took 0.01270781 seconds [[32mINFO [0m|#30290] Redirected to http://www.example.com/ [[32mINFO [0m|#30290] Completed in 64ms (DB: 0, API: 13, XML: 0) | 302 Found [http://www.example.com/user/do_login] [[0;37mDEBUG[0m|#30290] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"} [[32mINFO [0m|#30290] Processing MainController#index (for 127.0.0.1 at 2012-04-04 18:33:02) [GET] [[0;37mDEBUG[0m|#30290] Setting return_to: "/" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Authenticated request to "/" from king [[0;37mDEBUG[0m|#30290] Cache delete: Person_31bc44caa5b35568da22b828c6853364 [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] Person.find( 1800 seconds, king, {:is_current=>true}) [[0;37mDEBUG[0m|#30290] Cache miss: Person_31bc44caa5b35568da22b828c6853364 ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] [REST] find( Person, [{:is_current=>"true", :login=>"king"}] ) [[0;37mDEBUG[0m|#30290] http_do #1: method: get url: http://localhost:3203/person/king [[0;37mDEBUG[0m|#30290] Request took 0.012580936 seconds [[0;37mDEBUG[0m|#30290] Cache write (will save 13.00ms): Person_31bc44caa5b35568da22b828c6853364 [[0;37mDEBUG[0m|#30290] Cache miss: king_requests_that_need_work ({:expires_in=>600 seconds}) [[0;37mDEBUG[0m|#30290] Fetching request list from api [[0;37mDEBUG[0m|#30290] --> direct_http url: #<URI::Generic:0x00000001c54580 URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king> [[0;37mDEBUG[0m|#30290] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king [[0;37mDEBUG[0m|#30290] Request took 0.0622241 seconds [[0;37mDEBUG[0m|#30290] Fetching request list from api [[0;37mDEBUG[0m|#30290] --> direct_http url: #<URI::Generic:0x00000001dcb918 URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king> [[0;37mDEBUG[0m|#30290] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king [[0;37mDEBUG[0m|#30290] Request took 0.155340776 seconds [[0;37mDEBUG[0m|#30290] Fetching request list from api [[0;37mDEBUG[0m|#30290] --> direct_http url: #<URI::Generic:0x00000001ded838 URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king> [[0;37mDEBUG[0m|#30290] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king [[0;37mDEBUG[0m|#30290] Request took 0.071403704 seconds [[0;37mDEBUG[0m|#30290] Cache write (will save 291.23ms): king_requests_that_need_work [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] Statusmessage.find( 900 seconds, {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5}) [[0;37mDEBUG[0m|#30290] Cache hit: Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds}) [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] LatestUpdated.find( 300 seconds, {:limit=>6, :shared=>true}) [[0;37mDEBUG[0m|#30290] Cache hit: LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds}) [[0;37mDEBUG[0m|#30290] Project.find( 1800 seconds, home:king) [[0;37mDEBUG[0m|#30290] Cache miss: Project_a5d9fe90affee5686502abd47dc142fa ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] [REST] find( Project, [{:name=>"home:king"}] ) [[0;37mDEBUG[0m|#30290] http_do #1: method: get url: http://localhost:3203/source/home:king/_meta? [[0;37mDEBUG[0m|#30290] Request took 0.049121255 seconds [[0;37mDEBUG[0m|#30290] Project.find( {:name=>"home:king"} ) did not find anything, return nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[32mINFO [0m|#30290] Redirected to http://www.example.com/configuration/connect_instance [[32mINFO [0m|#30290] Completed in 361ms (DB: 1, API: 351, XML: 0) | 302 Found [http://www.example.com/] [[0;37mDEBUG[0m|#30290] REQUESTING PAGE: GET http://www.example.com/configuration/connect_instance with {} and HTTP headers {"HTTP_REFERER"=>"http://www.example.com/"} [[32mINFO [0m|#30290] Processing ConfigurationController#connect_instance (for 127.0.0.1 at 2012-04-04 18:33:02) [GET] [[0;37mDEBUG[0m|#30290] Setting return_to: "/configuration/connect_instance" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Authenticated request to "/configuration/connect_instance" from king [[0;37mDEBUG[0m|#30290] Cache delete: Person_31bc44caa5b35568da22b828c6853364 [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_str- nil [[0;37mDEBUG[0m|#30290] method_missing -to_ary- nil [[0;37mDEBUG[0m|#30290] Person.find( 1800 seconds, king, {:is_current=>true}) [[0;37mDEBUG[0m|#30290] Cache miss: Person_31bc44caa5b35568da22b828c6853364 ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|#30290] [REST] find( Person, [{:is_current=>"true", :login=>"king"}] ) [[0;37mDEBUG[0m|#30290] http_do #1: method: get url: http://localhost:3203/person/king [[0;37mDEBUG[0m|#30290] Request took 0.050866833 seconds [[0;37mDEBUG[0m|#30290] Cache write (will save 51.30ms): Person_31bc44caa5b35568da22b828c6853364 [[0;37mDEBUG[0m|#30290] Cache hit: king_requests_that_need_work ({:expires_in=>600 seconds}) [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[32mINFO [0m|#30290] Rendering template within layouts/application [[32mINFO [0m|#30290] Rendering configuration/connect_instance [[0;37mDEBUG[0m|#30290] Rendered layouts/_watch_and_search (0.4ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_header (0.9ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_personal_navigation (0.6ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|#30290] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|#30290] Completed in 65ms (View: 6, DB: 0, API: 51, XML: 0) | 200 OK [http://www.example.com/configuration/connect_instance] [[32mINFO [0m|#30290] Processing UserController#logout (for 127.0.0.1 at 2012-04-04 18:33:02) [POST] [[0;37mDEBUG[0m|#30290] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|#30290] Authenticating with iChain mode: off [[32mINFO [0m|#30290] Authenticated request to "/user/logout" from king [[0;37mDEBUG[0m|#30290] Cache hit: configuration ({:expires_in=>1800 seconds}) [[32mINFO [0m|#30290] Logging out: king [[32mINFO [0m|#30290] Redirected to http://www.example.com/ [[0;37mDEBUG[0m|#30290] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|#30290] 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/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@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/251/changes> Changes: [Stephan Kulow] [api] update all gems in use to their latest version (as in O:T:U) ------------------------------------------ [...truncated 96673 lines...] [[0;37mDEBUG[0m|# 8565] Rendered layouts/_personal_navigation (0.7ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|# 8565] Completed in 91ms (View: 5, DB: 0, API: 80, XML: 0) | 200 OK [http://www.example.com/user/do_login] [[0;37mDEBUG[0m|# 8565] 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|# 8565] Processing UserController#do_login (for 127.0.0.1 at 2012-04-05 12:58:52) [POST] [[32mINFO [0m|# 8565] Parameters: {"return_to_path"=>"/", "username"=>"tom", "password"=>"thunder", "commit"=>"Login"} [[0;37mDEBUG[0m|# 8565] Setting return_to: "/" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Anonymous request to / [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] Doing form authorization to login user tom [[0;37mDEBUG[0m|# 8565] Person.find( nil, tom) [[0;37mDEBUG[0m|# 8565] [REST] find( Person, [{:login=>"tom"}] ) [[0;37mDEBUG[0m|# 8565] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 8565] Request took 0.017920643 seconds [[32mINFO [0m|# 8565] Redirected to http://www.example.com/ [[32mINFO [0m|# 8565] Completed in 22ms (DB: 1, API: 18, XML: 0) | 302 Found [http://www.example.com/user/do_login] [[0;37mDEBUG[0m|# 8565] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"} [[32mINFO [0m|# 8565] Processing MainController#index (for 127.0.0.1 at 2012-04-05 12:58:52) [GET] [[0;37mDEBUG[0m|# 8565] Setting return_to: "/" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Authenticated request to "/" from tom [[0;37mDEBUG[0m|# 8565] Cache delete: Person_bcccc817286c9705b67feb0c7cc953c3 [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] Person.find( 1800 seconds, tom, {:is_current=>true}) [[0;37mDEBUG[0m|# 8565] Cache miss: Person_bcccc817286c9705b67feb0c7cc953c3 ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] ) [[0;37mDEBUG[0m|# 8565] http_do #1: method: get url: http://localhost:3203/person/tom [[0;37mDEBUG[0m|# 8565] Request took 0.048446643 seconds [[0;37mDEBUG[0m|# 8565] Cache write (will save 48.86ms): Person_bcccc817286c9705b67feb0c7cc953c3 [[0;37mDEBUG[0m|# 8565] Cache hit: tom_requests_that_need_work ({:expires_in=>600 seconds}) [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] Statusmessage.find( 900 seconds, {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5}) [[0;37mDEBUG[0m|# 8565] Cache hit: Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds}) [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] LatestUpdated.find( 300 seconds, {:limit=>6, :shared=>true}) [[0;37mDEBUG[0m|# 8565] Cache hit: LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds}) [[0;37mDEBUG[0m|# 8565] Project.find( 1800 seconds, home:tom) [[0;37mDEBUG[0m|# 8565] Cache hit: Project_adb9094ae2c389898fafee54514195c4 ({:expires_in=>1800 seconds}) [[32mINFO [0m|# 8565] Rendering template within layouts/application [[32mINFO [0m|# 8565] Rendering main/index [[0;37mDEBUG[0m|# 8565] Rendered main/_news (0.5ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_contact (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_latest_updates (3.6ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_countdown (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_sponsors (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_feeds (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_watch_and_search (0.4ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_header (0.9ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_personal_navigation (0.4ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|# 8565] Completed in 67ms (View: 11, DB: 0, API: 49, XML: 1) | 200 OK [http://www.example.com/] [[32mINFO [0m|# 8565] Processing UserController#logout (for 127.0.0.1 at 2012-04-05 12:58:52) [POST] [[0;37mDEBUG[0m|# 8565] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Authenticated request to "/user/logout" from tom [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[32mINFO [0m|# 8565] Logging out: tom [[32mINFO [0m|# 8565] Redirected to http://www.example.com/ [[0;37mDEBUG[0m|# 8565] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|# 8565] Completed in 4ms (DB: 1, API: 0, XML: 0) | 302 Found [http://www.example.com/user/logout] [[0;37mDEBUG[0m|# 8565] REQUESTING PAGE: GET / with {} and HTTP headers {} [[32mINFO [0m|# 8565] Processing MainController#index (for 127.0.0.1 at 2012-04-05 12:58:52) [GET] [[0;37mDEBUG[0m|# 8565] Setting return_to: "/" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Anonymous request to / [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] Statusmessage.find( 900 seconds, {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5}) [[0;37mDEBUG[0m|# 8565] Cache hit: Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds}) [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] LatestUpdated.find( 300 seconds, {:limit=>6, :shared=>true}) [[0;37mDEBUG[0m|# 8565] Cache hit: LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds}) [[32mINFO [0m|# 8565] Rendering template within layouts/application [[32mINFO [0m|# 8565] Rendering main/index [[0;37mDEBUG[0m|# 8565] Rendered main/_news (0.5ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_contact (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_latest_updates (3.6ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_countdown (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_sponsors (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered main/_feeds (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_watch_and_search (0.3ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_header (0.7ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_personal_navigation (0.7ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|# 8565] Completed in 16ms (View: 10, DB: 0, API: 0, XML: 1) | 200 OK [http://www.example.com/] [[0;37mDEBUG[0m|# 8565] REQUESTING PAGE: GET /user/login with {} and HTTP headers {"HTTP_REFERER"=>"/"} [[32mINFO [0m|# 8565] Processing UserController#login (for 127.0.0.1 at 2012-04-05 12:58:52) [GET] [[0;37mDEBUG[0m|# 8565] Setting return_to: "/user/login" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Anonymous request to /user/login [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[32mINFO [0m|# 8565] Rendering template within layouts/application [[32mINFO [0m|# 8565] Rendering user/login [[0;37mDEBUG[0m|# 8565] Rendered layouts/_watch_and_search (0.3ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_header (0.7ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_personal_navigation (0.6ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|# 8565] Completed in 9ms (View: 4, DB: 1, API: 0, XML: 0) | 200 OK [http://www.example.com/user/login] [[0;37mDEBUG[0m|# 8565] 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|# 8565] Processing UserController#do_login (for 127.0.0.1 at 2012-04-05 12:58:52) [POST] [[32mINFO [0m|# 8565] Parameters: {"return_to_path"=>"/", "username"=>"king", "password"=>"sunflower", "commit"=>"Login"} [[0;37mDEBUG[0m|# 8565] Setting return_to: "/" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Anonymous request to / [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] Doing form authorization to login user king [[0;37mDEBUG[0m|# 8565] Person.find( nil, king) [[0;37mDEBUG[0m|# 8565] [REST] find( Person, [{:login=>"king"}] ) [[0;37mDEBUG[0m|# 8565] http_do #1: method: get url: http://localhost:3203/person/king [[0;37mDEBUG[0m|# 8565] Request took 0.012770173 seconds [[32mINFO [0m|# 8565] Redirected to http://www.example.com/ [[32mINFO [0m|# 8565] Completed in 64ms (DB: 0, API: 13, XML: 0) | 302 Found [http://www.example.com/user/do_login] [[0;37mDEBUG[0m|# 8565] REQUESTING PAGE: GET http://www.example.com/ with {} and HTTP headers {"HTTP_REFERER"=>"/user/do_login"} [[32mINFO [0m|# 8565] Processing MainController#index (for 127.0.0.1 at 2012-04-05 12:58:52) [GET] [[0;37mDEBUG[0m|# 8565] Setting return_to: "/" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Authenticated request to "/" from king [[0;37mDEBUG[0m|# 8565] Cache delete: Person_31bc44caa5b35568da22b828c6853364 [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] Person.find( 1800 seconds, king, {:is_current=>true}) [[0;37mDEBUG[0m|# 8565] Cache miss: Person_31bc44caa5b35568da22b828c6853364 ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] [REST] find( Person, [{:is_current=>"true", :login=>"king"}] ) [[0;37mDEBUG[0m|# 8565] http_do #1: method: get url: http://localhost:3203/person/king [[0;37mDEBUG[0m|# 8565] Request took 0.012671545 seconds [[0;37mDEBUG[0m|# 8565] Cache write (will save 13.09ms): Person_31bc44caa5b35568da22b828c6853364 [[0;37mDEBUG[0m|# 8565] Cache miss: king_requests_that_need_work ({:expires_in=>600 seconds}) [[0;37mDEBUG[0m|# 8565] Fetching request list from api [[0;37mDEBUG[0m|# 8565] --> direct_http url: #<URI::Generic:0x00000001e0e588 URL:http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king> [[0;37mDEBUG[0m|# 8565] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=king [[0;37mDEBUG[0m|# 8565] Request took 0.062094862 seconds [[0;37mDEBUG[0m|# 8565] Fetching request list from api [[0;37mDEBUG[0m|# 8565] --> direct_http url: #<URI::Generic:0x00000001d9b0d8 URL:http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king> [[0;37mDEBUG[0m|# 8565] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=king [[0;37mDEBUG[0m|# 8565] Request took 0.071316305 seconds [[0;37mDEBUG[0m|# 8565] Fetching request list from api [[0;37mDEBUG[0m|# 8565] --> direct_http url: #<URI::Generic:0x00000001dbb630 URL:http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king> [[0;37mDEBUG[0m|# 8565] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=king [[0;37mDEBUG[0m|# 8565] Request took 0.071438367 seconds [[0;37mDEBUG[0m|# 8565] Cache write (will save 207.18ms): king_requests_that_need_work [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] Statusmessage.find( 900 seconds, {:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>5}) [[0;37mDEBUG[0m|# 8565] Cache hit: Statusmessage_5b45803e997cc5915704d09b14da5b4f ({:expires_in=>900 seconds}) [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] LatestUpdated.find( 300 seconds, {:limit=>6, :shared=>true}) [[0;37mDEBUG[0m|# 8565] Cache hit: LatestUpdated_3af9e60d376285bdcc1ba8f465ef1f8e ({:expires_in=>300 seconds}) [[0;37mDEBUG[0m|# 8565] Project.find( 1800 seconds, home:king) [[0;37mDEBUG[0m|# 8565] Cache miss: Project_a5d9fe90affee5686502abd47dc142fa ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] [REST] find( Project, [{:name=>"home:king"}] ) [[0;37mDEBUG[0m|# 8565] http_do #1: method: get url: http://localhost:3203/source/home:king/_meta? [[0;37mDEBUG[0m|# 8565] Request took 0.048970014 seconds [[0;37mDEBUG[0m|# 8565] Project.find( {:name=>"home:king"} ) did not find anything, return nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[32mINFO [0m|# 8565] Redirected to http://www.example.com/configuration/connect_instance [[32mINFO [0m|# 8565] Completed in 277ms (DB: 1, API: 267, XML: 0) | 302 Found [http://www.example.com/] [[0;37mDEBUG[0m|# 8565] REQUESTING PAGE: GET http://www.example.com/configuration/connect_instance with {} and HTTP headers {"HTTP_REFERER"=>"http://www.example.com/"} [[32mINFO [0m|# 8565] Processing ConfigurationController#connect_instance (for 127.0.0.1 at 2012-04-05 12:58:52) [GET] [[0;37mDEBUG[0m|# 8565] Setting return_to: "/configuration/connect_instance" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Authenticated request to "/configuration/connect_instance" from king [[0;37mDEBUG[0m|# 8565] Cache delete: Person_31bc44caa5b35568da22b828c6853364 [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_str- nil [[0;37mDEBUG[0m|# 8565] method_missing -to_ary- nil [[0;37mDEBUG[0m|# 8565] Person.find( 1800 seconds, king, {:is_current=>true}) [[0;37mDEBUG[0m|# 8565] Cache miss: Person_31bc44caa5b35568da22b828c6853364 ({:expires_in=>1800 seconds}) [[0;37mDEBUG[0m|# 8565] [REST] find( Person, [{:is_current=>"true", :login=>"king"}] ) [[0;37mDEBUG[0m|# 8565] http_do #1: method: get url: http://localhost:3203/person/king [[0;37mDEBUG[0m|# 8565] Request took 0.050982767 seconds [[0;37mDEBUG[0m|# 8565] Cache write (will save 51.47ms): Person_31bc44caa5b35568da22b828c6853364 [[0;37mDEBUG[0m|# 8565] Cache hit: king_requests_that_need_work ({:expires_in=>600 seconds}) [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[32mINFO [0m|# 8565] Rendering template within layouts/application [[32mINFO [0m|# 8565] Rendering configuration/connect_instance [[0;37mDEBUG[0m|# 8565] Rendered layouts/_watch_and_search (0.4ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_header (0.9ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_personal_navigation (0.6ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_flash (0.1ms) [[0;37mDEBUG[0m|# 8565] Rendered layouts/_sponsor (0.1ms) [[32mINFO [0m|# 8565] Completed in 66ms (View: 6, DB: 0, API: 51, XML: 0) | 200 OK [http://www.example.com/configuration/connect_instance] [[32mINFO [0m|# 8565] Processing UserController#logout (for 127.0.0.1 at 2012-04-05 12:58:52) [POST] [[0;37mDEBUG[0m|# 8565] Setting return_to: "/user/logout" [[0;37mDEBUG[0m|# 8565] Authenticating with iChain mode: off [[32mINFO [0m|# 8565] Authenticated request to "/user/logout" from king [[0;37mDEBUG[0m|# 8565] Cache hit: configuration ({:expires_in=>1800 seconds}) [[32mINFO [0m|# 8565] Logging out: king [[32mINFO [0m|# 8565] Redirected to http://www.example.com/ [[0;37mDEBUG[0m|# 8565] Cache delete: Person_f7754490a4ed0ddff3ff300384cc6faa [[32mINFO [0m|# 8565] 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 + fuser -v <http://ci.opensuse.org/job/obs_master_testsuite_webui/ws/> + egrep 'perl|ruby' 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@opensuse.org To contact the owner, e-mail: obs-tests+owner@opensuse.org
See <http://ci.opensuse.org/job/obs_master_testsuite_webui/252/> -- 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