See http://ci.opensuse.org/job/obs_master_testsuite_webui/689/changes
Changes:
[Stephan Kulow] [webui] more work on the user vs login confusion
[Stephan Kulow] [dist] cat the log for single failed tests
------------------------------------------
[...truncated 148623 lines...]
[[0;37mDEBUG[0m|#23293] Authenticating with iChain mode: off
[[32mINFO [0m|#23293] Authenticated request to "/project/buildresult?project=BaseDistro&index=" from tom
[[0;37mDEBUG[0m|#23293] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|#23293] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#23293] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|#23293] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/person/tom {"view"=>0.64644, "db"=>1.4889189999999999, "backend"=>0, "xml"=>0, :runtime=>16.279, :all=>19.854176000000002}
[[0;37mDEBUG[0m|#23293] returning [{:name=>"BaseDistro"}] from rails cache Project_f726314c8d941efeb9d0b888fe97b37e
[[0;37mDEBUG[0m|#23293] free_cache [{:project=>"BaseDistro", :view=>"summary"}] Buildresult_81f2400bb79dc620ddf8b0bf87e74935
[[0;37mDEBUG[0m|#23293] [REST] find( Buildresult, [{:project=>"BaseDistro", :view=>"summary"}] )
[[0;37mDEBUG[0m|#23293] params {:project=>"BaseDistro", :view=>"summary"}
[[0;37mDEBUG[0m|#23293] uri is: http://localhost:3203/build/:project/_result?:view&:package&:code&:lastbuild&:arch&:repository
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/build/BaseDistro/_result?view=summary
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/build/BaseDistro/_result?view=summary {"view"=>nil, "db"=>0.574098, "backend"=>0, "xml"=>0, :runtime=>124.3, :all=>167.564516}
[[32mINFO [0m|#23293] Rendered project/_buildstatus.html.erb (0.1ms)
[[32mINFO [0m|#23293] Completed 200 OK in 191ms (Views: 0.8ms | ActiveRecord: 0.0ms | API: 187.4ms (XML: 0.0ms , View: 0.6ms , Backend: 0.0ms , DB: 2.1ms , HTTP: 46.8ms) | XML: 0.3ms)
[[32mINFO [0m|#23293] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2012-11-29 11:41:23 +0100
[[32mINFO [0m|#23293] Processing by ProjectController#show as HTML
[[32mINFO [0m|#23293] Parameters: {"project"=>"My:Maintenance"}
[[0;37mDEBUG[0m|#23293] Setting return_to: "/project/show?project=My%3AMaintenance"
[[0;37mDEBUG[0m|#23293] Authenticating with iChain mode: off
[[32mINFO [0m|#23293] Authenticated request to "/project/show?project=My%3AMaintenance" from tom
[[0;37mDEBUG[0m|#23293] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|#23293] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#23293] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|#23293] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/person/tom {"view"=>0.993351, "db"=>1.5833999999999997, "backend"=>0, "xml"=>0, :runtime=>17.642000000000003, :all=>58.324925}
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.30012, "db"=>3.40919, "backend"=>0, "xml"=>0, :runtime=>36.251, :all=>78.812065}
[[0;37mDEBUG[0m|#23293] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.478115, "db"=>3.3001250000000004, "backend"=>0, "xml"=>0, :runtime=>36.093, :all=>79.584954}
[[0;37mDEBUG[0m|#23293] data {
"name": "My:Maintenance",
"packages": [
],
"xml": "\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n \n <maintenance>\n \n \n \n </maintenance>\n</project>\n",
"incidents": [
],
"maintained_projects": [
"BaseDistro",
"BaseDistro2.0:LinkedUpdateProject",
"BaseDistro3"
],
"linking_projects": [
],
"requests": [
],
"nr_of_problem_packages": 0
}
[[0;37mDEBUG[0m|#23293] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02
[[32mINFO [0m|#23293] Rendered project/_tabs.html.erb (3.5ms)
[[32mINFO [0m|#23293] Rendered shared/_open_requests.html.erb (0.1ms)
[[32mINFO [0m|#23293] Rendered layouts/_watch_and_search.html.erb (1.5ms)
[[32mINFO [0m|#23293] Rendered layouts/_header.html.erb (2.6ms)
[[32mINFO [0m|#23293] Rendered layouts/_personal_navigation.html.erb (1.1ms)
[[32mINFO [0m|#23293] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|#23293] Rendered layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|#23293] Completed 200 OK in 240ms (Views: 17.7ms | ActiveRecord: 0.0ms | API: 216.7ms (XML: 0.0ms , View: 1.8ms , Backend: 0.0ms , DB: 8.3ms , HTTP: 126.7ms) | XML: 0.7ms)
[[32mINFO [0m|#23293] Started GET "/project/toggle_watch?project=My%3AMaintenance" for 127.0.0.1 at 2012-11-29 11:41:24 +0100
[[32mINFO [0m|#23293] Processing by ProjectController#toggle_watch as HTML
[[32mINFO [0m|#23293] Parameters: {"project"=>"My:Maintenance"}
[[0;37mDEBUG[0m|#23293] Setting return_to: "/project/toggle_watch?project=My%3AMaintenance"
[[0;37mDEBUG[0m|#23293] Authenticating with iChain mode: off
[[32mINFO [0m|#23293] Authenticated request to "/project/toggle_watch?project=My%3AMaintenance" from tom
[[0;37mDEBUG[0m|#23293] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|#23293] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#23293] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|#23293] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/person/tom {"view"=>0.836481, "db"=>1.94821, "backend"=>0, "xml"=>0, :runtime=>16.711, :all=>20.799475}
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.285265, "db"=>3.553219, "backend"=>0, "xml"=>0, :runtime=>33.402, :all=>76.587538}
[[0;37mDEBUG[0m|#23293] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|#23293] returning [{:name=>"My:Maintenance"}] from rails cache Project_ce8cfb5ef2a35543461dbbb6b22579cb
[[0;37mDEBUG[0m|#23293] Remove My:Maintenance from watchlist for tom
[[0;37mDEBUG[0m|#23293] user 'tom' removes project 'My:Maintenance' from watchlist
[[0;37mDEBUG[0m|#23293] saving object Person ({:is_current=>"true", :login=>"tom"}) to api:
<person>
<login>tom</login>
<email>tschmidt@suse.de</email>
<realname>Thor</realname>
<watchlist>
</watchlist>
</person>
[[0;37mDEBUG[0m|#23293] http_do #1: method: put url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/person/tom {"view"=>1.168358, "db"=>1.9056919999999995, "backend"=>0, "xml"=>0, :runtime=>21.402, :all=>25.781683}
[[0;37mDEBUG[0m|#23293] [REST] find( PersonGroup, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|#23293] params {:login=>"tom"}
[[0;37mDEBUG[0m|#23293] uri is: http://localhost:3203/person/:login/group
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/person/tom/group
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/person/tom/group {"view"=>0.667531, "db"=>0.626085, "backend"=>0, "xml"=>0, :runtime=>8.472, :all=>13.32783}
[[0;37mDEBUG[0m|#23293] free_cache [:id, {:what=>"project", :predicate=>"person/@userid='tom'"}] Collection_8c1f4f93580a7c15e1f5fefa4bf90a08
[[0;37mDEBUG[0m|#23293] free_cache [:id, {:what=>"package", :predicate=>"person/@userid='tom'"}] Collection_09c0d884aeab5856e9b6a54d49db8a54
[[32mINFO [0m|#23293] Redirected to http://127.0.0.1:47409/project/show?project=My%3AMaintenance
[[32mINFO [0m|#23293] Completed 302 Found in 142ms (ActiveRecord: 0.0ms | API: 136.5ms (XML: 0.0ms , View: 3.0ms , Backend: 0.0ms , DB: 8.0ms , HTTP: 56.5ms) | XML: 0.4ms)
[[32mINFO [0m|#23293] Started GET "/project/show?project=My%3AMaintenance" for 127.0.0.1 at 2012-11-29 11:41:24 +0100
[[32mINFO [0m|#23293] Processing by ProjectController#show as HTML
[[32mINFO [0m|#23293] Parameters: {"project"=>"My:Maintenance"}
[[0;37mDEBUG[0m|#23293] Setting return_to: "/project/show?project=My%3AMaintenance"
[[0;37mDEBUG[0m|#23293] Authenticating with iChain mode: off
[[32mINFO [0m|#23293] Authenticated request to "/project/show?project=My%3AMaintenance" from tom
[[0;37mDEBUG[0m|#23293] free_cache [{:is_current=>"true", :login=>"tom"}] Person_3c475779e8513d9b679039491ed37e83
[[0;37mDEBUG[0m|#23293] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|#23293] params {:is_current=>"true", :login=>"tom"}
[[0;37mDEBUG[0m|#23293] uri is: http://localhost:3203/person/:login
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/person/tom {"view"=>0.528012, "db"=>0.815291, "backend"=>0, "xml"=>0, :runtime=>8.878, :all=>47.841046}
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/webui/person_requests_that_need_work?login=tom
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/webui/person_requests_that_need_work?login=tom {"view"=>0.27859199999999995, "db"=>5.9949330000000005, "backend"=>0, "xml"=>0, :runtime=>50.852000000000004, :all=>94.687052}
[[0;37mDEBUG[0m|#23293] data {
"declined": [
],
"new": [
],
"reviews": [
1000
]
}
[[0;37mDEBUG[0m|#23293] http_do #1: method: get url: http://localhost:3203/webui/project_infos?project=My%3AMaintenance
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/webui/project_infos?project=My%3AMaintenance {"view"=>0.506504, "db"=>3.1577010000000008, "backend"=>0, "xml"=>0, :runtime=>33.766999999999996, :all=>76.229319}
[[0;37mDEBUG[0m|#23293] data {
"name": "My:Maintenance",
"packages": [
],
"xml": "\n <title>official maintenance space</title>\n <description>official maintenance space, maintained by maintenance ;)</description>\n \n <maintenance>\n \n \n \n </maintenance>\n</project>\n",
"incidents": [
],
"maintained_projects": [
"BaseDistro",
"BaseDistro2.0:LinkedUpdateProject",
"BaseDistro3"
],
"linking_projects": [
],
"requests": [
],
"nr_of_problem_packages": 0
}
[[0;37mDEBUG[0m|#23293] returning [{:login=>"maintenance_coord"}] from rails cache Person_11966180e3080c963c5f78cfc0951d02
[[32mINFO [0m|#23293] Rendered project/_tabs.html.erb (2.3ms)
[[32mINFO [0m|#23293] Rendered shared/_open_requests.html.erb (0.0ms)
[[32mINFO [0m|#23293] Rendered layouts/_watch_and_search.html.erb (1.0ms)
[[32mINFO [0m|#23293] Rendered layouts/_header.html.erb (1.8ms)
[[32mINFO [0m|#23293] Rendered layouts/_personal_navigation.html.erb (1.0ms)
[[32mINFO [0m|#23293] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|#23293] Rendered layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|#23293] Completed 200 OK in 237ms (Views: 12.6ms | ActiveRecord: 0.0ms | API: 218.8ms (XML: 0.0ms , View: 1.3ms , Backend: 0.0ms , DB: 10.0ms , HTTP: 125.3ms) | XML: 0.5ms)
[[32mINFO [0m|#23293] Started POST "/user/logout" for 127.0.0.1 at 2012-11-29 11:41:25 +0100
[[32mINFO [0m|#23293] Processing by UserController#logout as HTML
[[0;37mDEBUG[0m|#23293] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|#23293] Authenticating with iChain mode: off
[[32mINFO [0m|#23293] Authenticated request to "/user/logout" from tom
[[32mINFO [0m|#23293] Logging out: tom
[[32mINFO [0m|#23293] Redirected to http://127.0.0.1:47409/
[[0;37mDEBUG[0m|#23293] free_cache [{}] Person_f7754490a4ed0ddff3ff300384cc6faa
[[32mINFO [0m|#23293] Completed 302 Found in 33ms (ActiveRecord: 29.0ms | XML: 0.0ms)
[[32mINFO [0m|#23293] Started GET "/" for 127.0.0.1 at 2012-11-29 11:41:25 +0100
[[32mINFO [0m|#23293] Processing by MainController#index as HTML
[[0;37mDEBUG[0m|#23293] Setting return_to: "/"
[[0;37mDEBUG[0m|#23293] Authenticating with iChain mode: off
[[32mINFO [0m|#23293] Anonymous request to /
[[0;37mDEBUG[0m|#23293] returning [{:conditions=>"deleted_at IS NULL", :order=>"create_at DESC", :limit=>"5"}] from rails cache Statusmessage_753097322d9cc873836d791589547e90
[[0;37mDEBUG[0m|#23293] returning [{:limit=>"6", :shared=>"true"}] from rails cache LatestUpdated_ee34770dc62e51dca62baed2d5258b33
[[0;37mDEBUG[0m|#23293] returning [{:login=>"king"}] from rails cache Person_d11b7899dedf6f054f648e67eed36b8c
[[32mINFO [0m|#23293] Rendered shared/_user_with_realname_and_icon.html.erb (80.1ms)
[[32mINFO [0m|#23293] Rendered main/_news.html.erb (82.5ms)
[[32mINFO [0m|#23293] Rendered main/_contact.html.erb (4.2ms)
[[32mINFO [0m|#23293] Rendered main/_latest_updates.erb (5.8ms)
[[32mINFO [0m|#23293] Rendered main/_countdown.html.erb (0.0ms)
[[32mINFO [0m|#23293] Rendered main/_sponsors.html.erb (0.0ms)
[[32mINFO [0m|#23293] Rendered main/_feeds.html.erb (0.0ms)
[[32mINFO [0m|#23293] Rendered layouts/_watch_and_search.html.erb (0.6ms)
[[32mINFO [0m|#23293] Rendered layouts/_header.html.erb (1.3ms)
[[32mINFO [0m|#23293] Rendered layouts/_personal_navigation.html.erb (1.2ms)
[[32mINFO [0m|#23293] Rendered layouts/_flash.html.erb (0.1ms)
[[32mINFO [0m|#23293] Rendered layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|#23293] Completed 200 OK in 108ms (Views: 104.3ms | ActiveRecord: 0.0ms | XML: 1.1ms)
[[32mINFO [0m|#23293] Started GET "/home/king/icon?size=20" for 127.0.0.1 at 2012-11-29 11:41:25 +0100
[[32mINFO [0m|#23293] Processing by HomeController#icon as HTML
[[32mINFO [0m|#23293] Parameters: {"size"=>"20", "user"=>"king"}
[[0;37mDEBUG[0m|#23293] Setting return_to: "/home/king/icon?size=20"
[[0;37mDEBUG[0m|#23293] Authenticating with iChain mode: off
[[32mINFO [0m|#23293] Anonymous request to /home/king/icon?size=20
[[32mINFO [0m|#23293] Completed 200 OK in 5ms (Views: 0.4ms | ActiveRecord: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|#23293] Started GET "/main/systemstatus" for 127.0.0.1 at 2012-11-29 11:41:25 +0100
[[32mINFO [0m|#23293] Processing by MainController#systemstatus as */*
[[0;37mDEBUG[0m|#23293] Setting return_to: "/main/systemstatus"
[[0;37mDEBUG[0m|#23293] Authenticating with iChain mode: off
[[32mINFO [0m|#23293] Anonymous request to /main/systemstatus
[[0;37mDEBUG[0m|#23293] returning [{:shared=>"true"}] from rails cache GlobalCounters_2899b016f456189a42bc9c5c8fc7013a
[[0;37mDEBUG[0m|#23293] returning [:available] from rails cache Architecture_82f3aea44c00f161487e3359eb33cff4
[[32mINFO [0m|#23293] Rendered main/_systemstatus.html.erb (1.5ms)
[[32mINFO [0m|#23293] Completed 200 OK in 4ms (Views: 2.2ms | ActiveRecord: 0.0ms | XML: 0.5ms)
[[0;37mDEBUG[0m|#23293] http_do #1: method: post url: http://localhost:3203/test/test_end
[[0;37mDEBUG[0m|#23293] RT http://localhost:3203/test/test_end {"view"=>1.637947, "db"=>34.137701, "backend"=>0, "xml"=>0, :runtime=>41.583, :all=>47.27313100000001}
+ 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/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/capybara 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