See http://ci.opensuse.org/job/obs_master_testsuite_webui/486/changes
Changes:
[mls] fix BSXML::attribute definition, fix indentation
[mls] [backend] implement constraints passing, probably needs fixing
------------------------------------------
[...truncated 17671 lines...]
[[32mINFO [0m|# 2246] Rendered layouts/_watch_and_search.html.erb (0.4ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_header.html.erb (1.1ms)
[[32mINFO [0m|# 2246] Rendered layouts/_personal_navigation.html.erb (1.1ms)
[[32mINFO [0m|# 2246] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Completed 200 OK in 675ms (Views: 119.5ms | ActiveRecord: 0.0ms | API: 651.7ms (XML: 0.1ms , View: 6.4ms , Backend: 0.0ms , DB: 10.1ms , HTTP: 455.8ms) | XML: 1.2ms)
[[32mINFO [0m|# 2246] Started GET "/project/show?project=c%2B%2B" for 127.0.0.1 at 2012-10-08 20:19:17 +0200
[[32mINFO [0m|# 2246] Processing by ProjectController#show as HTML
[[32mINFO [0m|# 2246] Parameters: {"project"=>"c++"}
[[0;37mDEBUG[0m|# 2246] Setting return_to: "/project/show?project=c%2B%2B"
[[0;37mDEBUG[0m|# 2246] Authenticating with iChain mode: off
[[32mINFO [0m|# 2246] Anonymous request to /project/show?project=c%2B%2B
[[0;37mDEBUG[0m|# 2246] [REST] find( Project, [{:name=>"c++"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/source/c++/_meta?
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.49485, "db"=>1.8029629999999999, "backend"=>0, "xml"=>0, :runtime=>18.358, :all=>58.295215999999996}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=c%2B%2B>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=c%2B%2B
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.435092, "db"=>0.632352, "backend"=>0, "xml"=>0.046173, :runtime=>8.312, :all=>49.88992}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=target&project=c%2B%2B>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=target&project=c%2B%2B
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.279922, "db"=>0.45772599999999997, "backend"=>0, "xml"=>0.03867, :runtime=>6.819000000000001, :all=>47.443247}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=c%2B%2B>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=c%2B%2B
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.322746, "db"=>0.43411500000000003, "backend"=>0, "xml"=>0.033643000000000006, :runtime=>6.525, :all=>47.446632}
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27c%2B%2B%3A%27%29+and+%40kind%3D%27maintenance_incident%27+and+repository%2Freleasetarget%2F%40trigger%3D%27maintenance%27>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27c%2B%...
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.45330400000000004, "db"=>0.9316430000000001, "backend"=>0, "xml"=>0.046393000000000004, :runtime=>9.867, :all=>64.975306}
[[0;37mDEBUG[0m|# 2246] [REST] find( Package, [:all, {:project=>"c++"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/source/c++
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.485418, "db"=>1.037509, "backend"=>0, "xml"=>0, :runtime=>9.802999999999999, :all=>49.5348}
[[0;37mDEBUG[0m|# 2246] [REST] find( Buildresult, [{:project=>"c++", :view=>"status", :code=>["failed", "broken", "unresolvable"]}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/build/c++/_result?view=status&code=failed&code=broken&code=unresolvable
[[0;37mDEBUG[0m|# 2246] RT {"view"=>nil, "db"=>0.6716139999999999, "backend"=>0, "xml"=>0, :runtime=>16.823, :all=>58.707772}
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/source/c++?cmd=showlinked>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: POST url: http://localhost:3203/source/c++?cmd=showlinked
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.510853, "db"=>0.92968, "backend"=>0, "xml"=>0, :runtime=>12.345, :all=>16.539237}
[[0;37mDEBUG[0m|# 2246] [REST] find( Buildresult, [{:project=>"c++", :view=>"summary"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/build/c++/_result?view=summary
[[0;37mDEBUG[0m|# 2246] RT {"view"=>nil, "db"=>0.554816, "backend"=>0, "xml"=>0, :runtime=>13.478, :all=>53.864649}
[[0;37mDEBUG[0m|# 2246] [REST] find( Collection, [:id, {:what=>"project", :predicate=>"maintenance/maintains/@project='c++'"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/search/project/id?match=maintenance%2Fmaintains%2F%40p...
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.509027, "db"=>0.872984, "backend"=>0, "xml"=>0.061895000000000006, :runtime=>10.764, :all=>51.041045}
[[0;37mDEBUG[0m|# 2246] [REST] find( Project, [{:name=>"c++"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/source/c++/_meta?
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.516973, "db"=>0.517301, "backend"=>0, "xml"=>0, :runtime=>9.673, :all=>49.784217}
[[32mINFO [0m|# 2246] Rendered project/_tabs.html.erb (3.8ms)
[[32mINFO [0m|# 2246] Rendered shared/_buildresult_box.html.erb (1.0ms)
[[32mINFO [0m|# 2246] Rendered layouts/_watch_and_search.html.erb (0.5ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_header.html.erb (1.1ms)
[[32mINFO [0m|# 2246] Rendered layouts/_personal_navigation.html.erb (1.2ms)
[[32mINFO [0m|# 2246] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Completed 200 OK in 572ms (Views: 63.4ms | ActiveRecord: 0.0ms | API: 547.5ms (XML: 0.2ms , View: 4.0ms , Backend: 0.0ms , DB: 8.8ms , HTTP: 424.8ms) | XML: 1.2ms)
[[32mINFO [0m|# 2246] Started GET "/project/show?project=home%3Acoolo%3Atest" for 127.0.0.1 at 2012-10-08 20:19:18 +0200
[[32mINFO [0m|# 2246] Processing by ProjectController#show as HTML
[[32mINFO [0m|# 2246] Parameters: {"project"=>"home:coolo:test"}
[[0;37mDEBUG[0m|# 2246] Setting return_to: "/project/show?project=home%3Acoolo%3Atest"
[[0;37mDEBUG[0m|# 2246] Authenticating with iChain mode: off
[[32mINFO [0m|# 2246] Anonymous request to /project/show?project=home%3Acoolo%3Atest
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=home%3Acoolo%3Atest>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=home%3Acoolo%3Atest
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.450424, "db"=>0.70716, "backend"=>0, "xml"=>0.04865, :runtime=>7.6499999999999995, :all=>45.388332000000005}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=target&project=home%3Acoolo%3Atest>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=target&project=home%3Acoolo%3Atest
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.39287099999999997, "db"=>0.516624, "backend"=>0, "xml"=>0.047821, :runtime=>6.881, :all=>47.083277}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=home%3Acoolo%3Atest>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=home%3Acoolo%3Atest
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.436372, "db"=>0.693906, "backend"=>0, "xml"=>0.046268, :runtime=>7.449, :all=>47.204102999999996}
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27home%3Acoolo%3Atest%3A%27%29+and+%40kind%3D%27maintenance_incident%27+and+repository%2Freleasetarget%2F%40trigger%3D%27maintenance%27>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27home%...
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.512497, "db"=>1.014746, "backend"=>0, "xml"=>0.047255, :runtime=>12.383, :all=>55.190498}
[[0;37mDEBUG[0m|# 2246] [REST] find( Package, [:all, {:project=>"home:coolo:test"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/source/home:coolo:test
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.534167, "db"=>1.391969, "backend"=>0, "xml"=>0, :runtime=>16.309, :all=>54.836577}
[[0;37mDEBUG[0m|# 2246] [REST] find( Buildresult, [{:project=>"home:coolo:test", :view=>"status", :code=>["failed", "broken", "unresolvable"]}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/build/home:coolo:test/_result?view=status&code=failed&code=broken&code=unresolvable
[[0;37mDEBUG[0m|# 2246] RT {"view"=>nil, "db"=>0.6645780000000001, "backend"=>0, "xml"=>0, :runtime=>18.044, :all=>59.169852}
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/source/home:coolo:test?cmd=showlinked>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: POST url: http://localhost:3203/source/home:coolo:test?cmd=showlinked
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.571054, "db"=>0.9183000000000001, "backend"=>0, "xml"=>0, :runtime=>14.016, :all=>63.34537399999999}
[[0;37mDEBUG[0m|# 2246] [REST] find( Buildresult, [{:project=>"home:coolo:test", :view=>"summary"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/build/home:coolo:test/_result?view=summary
[[0;37mDEBUG[0m|# 2246] RT {"view"=>nil, "db"=>0.528514, "backend"=>0, "xml"=>0, :runtime=>17.011, :all=>63.041847}
[[0;37mDEBUG[0m|# 2246] [REST] find( Collection, [:id, {:what=>"project", :predicate=>"maintenance/maintains/@project='home:coolo:test'"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/search/project/id?match=maintenance%2Fmaintains%2F%40p...
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.563647, "db"=>0.7623800000000001, "backend"=>0, "xml"=>0.077007, :runtime=>9.455, :all=>51.178494}
[[32mINFO [0m|# 2246] Rendered project/_tabs.html.erb (4.0ms)
[[32mINFO [0m|# 2246] Rendered shared/_buildresult_box.html.erb (0.7ms)
[[32mINFO [0m|# 2246] Rendered layouts/_watch_and_search.html.erb (0.5ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_header.html.erb (1.0ms)
[[32mINFO [0m|# 2246] Rendered layouts/_personal_navigation.html.erb (1.1ms)
[[32mINFO [0m|# 2246] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Completed 200 OK in 510ms (Views: 13.2ms | ActiveRecord: 0.0ms | API: 486.4ms (XML: 0.3ms , View: 3.5ms , Backend: 0.0ms , DB: 7.2ms , HTTP: 377.2ms) | XML: 1.2ms)
[[32mINFO [0m|# 2246] Started GET "/project/show?project=deleted" for 127.0.0.1 at 2012-10-08 20:19:18 +0200
[[32mINFO [0m|# 2246] Processing by ProjectController#show as HTML
[[32mINFO [0m|# 2246] Parameters: {"project"=>"deleted"}
[[0;37mDEBUG[0m|# 2246] Setting return_to: "/project/show?project=deleted"
[[0;37mDEBUG[0m|# 2246] Authenticating with iChain mode: off
[[32mINFO [0m|# 2246] Anonymous request to /project/show?project=deleted
[[0;37mDEBUG[0m|# 2246] [REST] find( Project, [{:name=>"deleted"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/source/deleted/_meta?
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.484278, "db"=>2.9398779999999998, "backend"=>0, "xml"=>0, :runtime=>23.211, :all=>64.708841}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=deleted>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=deleted
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.47313500000000003, "db"=>0.655701, "backend"=>0, "xml"=>0.047209999999999995, :runtime=>10.028, :all=>50.013187}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=target&project=deleted>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=target&project=deleted
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.414769, "db"=>0.601182, "backend"=>0, "xml"=>0.049658, :runtime=>7.739, :all=>51.158914}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=deleted>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=deleted
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.39617899999999995, "db"=>0.49771499999999996, "backend"=>0, "xml"=>0.073475, :runtime=>7.163, :all=>47.433091}
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27deleted%3A%27%29+and+%40kind%3D%27maintenance_incident%27+and+repository%2Freleasetarget%2F%40trigger%3D%27maintenance%27>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27delet...
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.523087, "db"=>1.348817, "backend"=>0, "xml"=>0.096432, :runtime=>13.299999999999999, :all=>55.423107}
[[0;37mDEBUG[0m|# 2246] [REST] find( Package, [:all, {:project=>"deleted"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/source/deleted
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.560037, "db"=>0.817319, "backend"=>0, "xml"=>0, :runtime=>10.272, :all=>50.833808}
[[0;37mDEBUG[0m|# 2246] [REST] find( Buildresult, [{:project=>"deleted", :view=>"status", :code=>["failed", "broken", "unresolvable"]}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/build/deleted/_result?view=status&code=failed&code=broken&code=unresolvable
[[0;37mDEBUG[0m|# 2246] RT {"view"=>nil, "db"=>0.797868, "backend"=>0, "xml"=>0, :runtime=>15.372, :all=>55.233563}
[[0;37mDEBUG[0m|# 2246] Buildresult.find( {:project=>"deleted", :view=>"status", :code=>["failed", "broken", "unresolvable"]} ) did not find anything, return nil
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/source/deleted?cmd=showlinked>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: POST url: http://localhost:3203/source/deleted?cmd=showlinked
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.7202270000000001, "db"=>0.9823439999999999, "backend"=>0, "xml"=>0, :runtime=>12.876, :all=>17.453461}
[[0;37mDEBUG[0m|# 2246] [REST] find( Buildresult, [{:project=>"deleted", :view=>"summary"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/build/deleted/_result?view=summary
[[0;37mDEBUG[0m|# 2246] RT {"view"=>nil, "db"=>0.5183139999999999, "backend"=>0, "xml"=>0, :runtime=>12.762, :all=>52.326219}
[[0;37mDEBUG[0m|# 2246] Buildresult.find( {:project=>"deleted", :view=>"summary"} ) did not find anything, return nil
[[0;37mDEBUG[0m|# 2246] [REST] find( Collection, [:id, {:what=>"project", :predicate=>"maintenance/maintains/@project='deleted'"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/search/project/id?match=maintenance%2Fmaintains%2F%40p...
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.517984, "db"=>0.652935, "backend"=>0, "xml"=>0.06694699999999999, :runtime=>9.395999999999999, :all=>51.0728}
[[0;37mDEBUG[0m|# 2246] [REST] find( Project, [{:name=>"deleted"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/source/deleted/_meta?
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.49425399999999997, "db"=>0.728185, "backend"=>0, "xml"=>0, :runtime=>11.775, :all=>54.313810999999994}
[[32mINFO [0m|# 2246] Rendered project/_tabs.html.erb (4.0ms)
[[32mINFO [0m|# 2246] Rendered shared/_buildresult_box.html.erb (0.7ms)
[[32mINFO [0m|# 2246] Rendered layouts/_watch_and_search.html.erb (0.4ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_header.html.erb (1.0ms)
[[32mINFO [0m|# 2246] Rendered layouts/_personal_navigation.html.erb (1.3ms)
[[32mINFO [0m|# 2246] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Completed 200 OK in 575ms (Views: 68.0ms | ActiveRecord: 0.0ms | API: 550.0ms (XML: 0.3ms , View: 4.6ms , Backend: 0.0ms , DB: 10.5ms , HTTP: 416.1ms) | XML: 1.2ms)
[[32mINFO [0m|# 2246] Started POST "/user/logout" for 127.0.0.1 at 2012-10-08 20:19:19 +0200
[[32mINFO [0m|# 2246] Processing by UserController#logout as HTML
[[0;37mDEBUG[0m|# 2246] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|# 2246] Authenticating with iChain mode: off
[[32mINFO [0m|# 2246] Anonymous request to /user/logout
[[32mINFO [0m|# 2246] Logging out:
[[32mINFO [0m|# 2246] Redirected to http://example.org/
[[32mINFO [0m|# 2246] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|# 2246] [1m[35m (0.1ms)[0m rollback transaction
[[0;37mDEBUG[0m|# 2246] [1m[36m (0.1ms)[0m [1mbegin transaction[0m
[[32mINFO [0m|# 2246] Started POST "/user/do_login" for 127.0.0.1 at 2012-10-08 20:19:19 +0200
[[32mINFO [0m|# 2246] Processing by UserController#do_login as HTML
[[32mINFO [0m|# 2246] Parameters: {"username"=>"tom", "password"=>"[FILTERED]", "return_to_path"=>"/"}
[[0;37mDEBUG[0m|# 2246] Setting return_to: "/"
[[0;37mDEBUG[0m|# 2246] Authenticating with iChain mode: off
[[32mINFO [0m|# 2246] Anonymous request to /
[[0;37mDEBUG[0m|# 2246] Doing form authorization to login user tom
[[0;37mDEBUG[0m|# 2246] [REST] find( Person, [{:login=>"tom"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.6516719999999999, "db"=>1.410039, "backend"=>0, "xml"=>0, :runtime=>10.465, :all=>53.565033}
[[32mINFO [0m|# 2246] Redirected to http://example.org/
[[32mINFO [0m|# 2246] Completed 302 Found in 56ms (ActiveRecord: 0.0ms | API: 53.6ms (XML: 0.0ms , View: 0.7ms , Backend: 0.0ms , DB: 1.4ms , HTTP: 43.1ms) | XML: 0.1ms)
[[32mINFO [0m|# 2246] Started GET "/" for 127.0.0.1 at 2012-10-08 20:19:19 +0200
[[32mINFO [0m|# 2246] Processing by MainController#index as HTML
[[0;37mDEBUG[0m|# 2246] Setting return_to: "/"
[[0;37mDEBUG[0m|# 2246] Authenticating with iChain mode: off
[[32mINFO [0m|# 2246] Authenticated request to "/" from tom
[[0;37mDEBUG[0m|# 2246] [REST] find( Person, [{:is_current=>"true", :login=>"tom"}] )
[[0;37mDEBUG[0m|# 2246] http_do #1: method: get url: http://localhost:3203/person/tom
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.479742, "db"=>0.918727, "backend"=>0, "xml"=>0, :runtime=>9.283, :all=>49.400594999999996}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=declined&roles=creator&user=tom
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.515884, "db"=>0.733379, "backend"=>0, "xml"=>0.042334, :runtime=>10.839, :all=>50.773463}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&user=tom
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.562329, "db"=>2.5209770000000002, "backend"=>0, "xml"=>0.056839999999999995, :runtime=>24.666, :all=>67.263769}
[[0;37mDEBUG[0m|# 2246] Fetching request list from api
[[0;37mDEBUG[0m|# 2246] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom>
[[0;37mDEBUG[0m|# 2246] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=maintainer&user=tom
[[0;37mDEBUG[0m|# 2246] RT {"view"=>0.602912, "db"=>2.345365, "backend"=>0, "xml"=>0.047455, :runtime=>21.529, :all=>63.138250000000006}
[[32mINFO [0m|# 2246] Rendered main/_news.html.erb (0.7ms)
[[32mINFO [0m|# 2246] Rendered main/_contact.html.erb (0.1ms)
[[32mINFO [0m|# 2246] Rendered main/_latest_updates.erb (5.0ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/main/_countdown.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/main/_sponsors.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/main/_feeds.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Rendered layouts/_watch_and_search.html.erb (0.8ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_header.html.erb (1.7ms)
[[32mINFO [0m|# 2246] Rendered layouts/_personal_navigation.html.erb (1.4ms)
[[32mINFO [0m|# 2246] Rendered layouts/_flash.html.erb (0.2ms)
[[32mINFO [0m|# 2246] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 2246] Completed 200 OK in 308ms (Views: 19.7ms | ActiveRecord: 0.0ms | API: 230.6ms (XML: 0.1ms , View: 2.2ms , Backend: 0.0ms , DB: 6.5ms , HTTP: 164.3ms) | XML: 1.0ms)
[[32mINFO [0m|# 2246] Started POST "/user/logout" for 127.0.0.1 at 2012-10-08 20:19:19 +0200
[[32mINFO [0m|# 2246] Processing by UserController#logout as HTML
[[0;37mDEBUG[0m|# 2246] Setting return_to: "/user/logout"
[[0;37mDEBUG[0m|# 2246] Authenticating with iChain mode: off
[[32mINFO [0m|# 2246] Authenticated request to "/user/logout" from tom
[[32mINFO [0m|# 2246] Logging out: tom
[[32mINFO [0m|# 2246] Redirected to http://example.org/
[[32mINFO [0m|# 2246] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms)
[[0;37mDEBUG[0m|# 2246] [1m[35m (0.1ms)[0m rollback transaction
+ 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