See http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/338/changes
Changes:
[mls] [backend] dispatch: start implementing an oracle function
------------------------------------------
[...truncated 302337 lines...]
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=RemoteInstance>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=RemoteInstance
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.6158300000000001, "db"=>0.616518, "backend"=>0, "xml"=>0.010842000000000001, :runtime=>16.159, :all=>53.86389}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=target&project=RemoteInstance>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=target&project=RemoteInstance
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.543766, "db"=>0.367699, "backend"=>0, "xml"=>0.0, :runtime=>6.911, :all=>47.443185}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=RemoteInstance>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=RemoteInstance
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.09569, "db"=>1.106267, "backend"=>0, "xml"=>0.0, :runtime=>7.004, :all=>47.477142}
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27RemoteInstance%3A%27%29+and+%40kind%3D%27maintenance_incident%27+and+repository%2Freleasetarget%2F%40trigger%3D%27maintenance%27>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27Remot...
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.473734, "db"=>1.0362489999999998, "backend"=>0, "xml"=>0.061593999999999996, :runtime=>10.825, :all=>51.472480000000004}
[[0;37mDEBUG[0m|# 4309] [REST] find( Package, [:all, {:project=>"RemoteInstance"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/source/RemoteInstance
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.678219, "db"=>0.715209, "backend"=>0, "xml"=>0, :runtime=>11.538, :all=>55.660841000000005}
[[0;37mDEBUG[0m|# 4309] [REST] find( Buildresult, [{:project=>"RemoteInstance", :view=>"status", :code=>["failed", "broken", "unresolvable"]}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/build/RemoteInstance/_result?view=status&code=failed&code=broken&code=unresolvable
[[0;37mDEBUG[0m|# 4309] RT {"view"=>nil, "db"=>0.615603, "backend"=>0, "xml"=>0, :runtime=>13.904, :all=>54.416224}
[[0;37mDEBUG[0m|# 4309] [REST] find( Buildresult, [{:project=>"RemoteInstance", :view=>"summary"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/build/RemoteInstance/_result?view=summary
[[0;37mDEBUG[0m|# 4309] RT {"view"=>nil, "db"=>3.6499560000000004, "backend"=>0, "xml"=>0, :runtime=>64.226, :all=>107.25491400000001}
[[0;37mDEBUG[0m|# 4309] [REST] find( Collection, [:id, {:what=>"project", :predicate=>"maintenance/maintains/@project='RemoteInstance'"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/search/project/id?match=maintenance%2Fmaintains%2F%40p...
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.574374, "db"=>0.9955379999999999, "backend"=>0, "xml"=>0.060801999999999995, :runtime=>11.988, :all=>55.317705000000004}
[[32mINFO [0m|# 4309] Rendered project/_tabs.html.erb (1.6ms)
[[32mINFO [0m|# 4309] Rendered shared/_open_requests.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Rendered shared/_buildresult_box.html.erb (0.8ms)
[[32mINFO [0m|# 4309] Rendered project/show.html.erb within layouts/application (4.4ms)
[[32mINFO [0m|# 4309] Rendered layouts/_watch_and_search.html.erb (0.4ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_header.html.erb (0.9ms)
[[32mINFO [0m|# 4309] Rendered layouts/_personal_navigation.html.erb (1.2ms)
[[32mINFO [0m|# 4309] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Completed 200 OK in 512ms (Views: 9.7ms | ActiveRecord: 0.0ms | API: 494.6ms (XML: 0.1ms , View: 3.3ms , Backend: 0.0ms , DB: 11.5ms , HTTP: 333.6ms) | XML: 0.7ms)
[[32mINFO [0m|# 4309]
Started GET "/project/buildresult?project=RemoteInstance&index=" for 127.0.0.1 at 2012-10-02 14:25:30 +0200
[[32mINFO [0m|# 4309] Processing by ProjectController#buildresult as */*
[[32mINFO [0m|# 4309] Parameters: {"project"=>"RemoteInstance", "index"=>""}
[[0;37mDEBUG[0m|# 4309] Setting return_to: "/project/buildresult?project=RemoteInstance&index="
[[0;37mDEBUG[0m|# 4309] Authenticating with iChain mode: off
[[32mINFO [0m|# 4309] Anonymous request to /project/buildresult?project=RemoteInstance&index=
[[0;37mDEBUG[0m|# 4309] [REST] find( Buildresult, [{:project=>"RemoteInstance", :view=>"summary"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/build/RemoteInstance/_result?view=summary
[[0;37mDEBUG[0m|# 4309] RT {"view"=>nil, "db"=>0.7699179999999999, "backend"=>0, "xml"=>0, :runtime=>23.221, :all=>26.295395}
[[32mINFO [0m|# 4309] Rendered project/_buildstatus.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Completed 200 OK in 28ms (Views: 0.6ms | ActiveRecord: 0.0ms | API: 26.3ms (XML: 0.0ms , Backend: 0.0ms , DB: 0.8ms , HTTP: 3.1ms) | XML: 0.1ms)
[[32mINFO [0m|# 4309]
Started GET "/project/requests?project=RemoteInstance" for 127.0.0.1 at 2012-10-02 14:25:31 +0200
[[32mINFO [0m|# 4309] Processing by ProjectController#requests as HTML
[[32mINFO [0m|# 4309] Parameters: {"project"=>"RemoteInstance"}
[[0;37mDEBUG[0m|# 4309] Setting return_to: "/project/requests?project=RemoteInstance"
[[0;37mDEBUG[0m|# 4309] Authenticating with iChain mode: off
[[32mINFO [0m|# 4309] Anonymous request to /project/requests?project=RemoteInstance
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=RemoteInstance>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=RemoteInstance
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.5694, "db"=>1.40318, "backend"=>0, "xml"=>0.067466, :runtime=>9.173, :all=>12.473995}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=target&project=RemoteInstance>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=target&project=RemoteInstance
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.356223, "db"=>0.47889800000000005, "backend"=>0, "xml"=>0.036792000000000005, :runtime=>6.2059999999999995, :all=>45.976692}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=RemoteInstance>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=RemoteInstance
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.326837, "db"=>0.50889, "backend"=>0, "xml"=>0.033339, :runtime=>6.5329999999999995, :all=>47.599831}
[[32mINFO [0m|# 4309] Rendered project/_tabs.html.erb (1.6ms)
[[32mINFO [0m|# 4309] Rendered shared/_select_requests.html.erb (1.1ms)
[[32mINFO [0m|# 4309] Rendered project/requests.html.erb within layouts/application (3.5ms)
[[32mINFO [0m|# 4309] Rendered layouts/_watch_and_search.html.erb (0.4ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_header.html.erb (0.9ms)
[[32mINFO [0m|# 4309] Rendered layouts/_personal_navigation.html.erb (1.0ms)
[[32mINFO [0m|# 4309] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Completed 200 OK in 119ms (Views: 9.1ms | ActiveRecord: 0.0ms | API: 106.1ms (XML: 0.1ms , View: 1.3ms , Backend: 0.0ms , DB: 2.4ms , HTTP: 84.1ms) | XML: 0.1ms)
[[32mINFO [0m|# 4309]
Started GET "/request/list?states=new%2Creview&types=all&project=RemoteInstance&no_target=true" for 127.0.0.1 at 2012-10-02 14:25:31 +0200
[[32mINFO [0m|# 4309] Processing by RequestController#list as */*
[[32mINFO [0m|# 4309] Parameters: {"states"=>"new,review", "types"=>"all", "project"=>"RemoteInstance", "no_target"=>"true"}
[[0;37mDEBUG[0m|# 4309] Setting return_to: "/request/list?states=new%2Creview&types=all&project=RemoteInstance&no_target=true"
[[0;37mDEBUG[0m|# 4309] Authenticating with iChain mode: off
[[32mINFO [0m|# 4309] Anonymous request to /request/list?states=new%2Creview&types=all&project=RemoteInstance&no_target=true
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=new%2Creview&project=RemoteInstance>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new%2Creview&project=RemoteInstance
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.44530600000000004, "db"=>0.915753, "backend"=>0, "xml"=>0.054939999999999996, :runtime=>7.3759999999999994, :all=>61.975443999999996}
[[32mINFO [0m|# 4309] Rendered shared/_requests.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Completed 200 OK in 65ms (Views: 0.7ms | ActiveRecord: 0.0ms | API: 62.0ms (XML: 0.1ms , View: 0.4ms , Backend: 0.0ms , DB: 0.9ms , HTTP: 54.6ms) | XML: 0.3ms)
[[32mINFO [0m|# 4309]
Started GET "/project/show" for 127.0.0.1 at 2012-10-02 14:25:31 +0200
[[32mINFO [0m|# 4309] Processing by ProjectController#show as HTML
[[0;37mDEBUG[0m|# 4309] Setting return_to: "/project/show"
[[0;37mDEBUG[0m|# 4309] Authenticating with iChain mode: off
[[32mINFO [0m|# 4309] Anonymous request to /project/show
[[32mINFO [0m|# 4309] Redirected to http://localhost:3199/project/list_public?nextstatus=404
[[32mINFO [0m|# 4309] Filter chain halted as :require_project rendered or redirected
[[32mINFO [0m|# 4309] Completed 302 Found in 1ms (ActiveRecord: 0.0ms | XML: 0.0ms)
[[32mINFO [0m|# 4309]
Started GET "/project/list_public?nextstatus=404" for 127.0.0.1 at 2012-10-02 14:25:31 +0200
[[32mINFO [0m|# 4309] Processing by ProjectController#list_public as HTML
[[32mINFO [0m|# 4309] Parameters: {"nextstatus"=>"404"}
[[0;37mDEBUG[0m|# 4309] Setting return_to: "/project/list_public?nextstatus=404"
[[0;37mDEBUG[0m|# 4309] Authenticating with iChain mode: off
[[32mINFO [0m|# 4309] Anonymous request to /project/list_public?nextstatus=404
[[32mINFO [0m|# 4309] Rendered project/_filter_projects.html.erb (1.1ms)
[[32mINFO [0m|# 4309] Rendered project/_search_project.html.erb (6.5ms)
[[32mINFO [0m|# 4309] Rendered project/list.html.erb within layouts/application (9.0ms)
[[32mINFO [0m|# 4309] Rendered layouts/_watch_and_search.html.erb (0.5ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_header.html.erb (1.1ms)
[[32mINFO [0m|# 4309] Rendered layouts/_personal_navigation.html.erb (1.2ms)
[[32mINFO [0m|# 4309] Rendered layouts/_flash.html.erb (0.1ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Completed 404 Not Found in 18ms (Views: 14.5ms | ActiveRecord: 0.0ms | XML: 1.8ms)
[[32mINFO [0m|# 4309]
Started GET "/project/show?project=SourceprotectedProject" for 127.0.0.1 at 2012-10-02 14:25:32 +0200
[[32mINFO [0m|# 4309] Processing by ProjectController#show as HTML
[[32mINFO [0m|# 4309] Parameters: {"project"=>"SourceprotectedProject"}
[[0;37mDEBUG[0m|# 4309] Setting return_to: "/project/show?project=SourceprotectedProject"
[[0;37mDEBUG[0m|# 4309] Authenticating with iChain mode: off
[[32mINFO [0m|# 4309] Anonymous request to /project/show?project=SourceprotectedProject
[[0;37mDEBUG[0m|# 4309] [REST] find( Project, [{:name=>"SourceprotectedProject"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/source/SourceprotectedProject/_meta?
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.6134419999999999, "db"=>2.7269959999999993, "backend"=>0, "xml"=>0, :runtime=>23.162, :all=>26.408535}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=SourceprotectedProject>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=SourceprotectedProject
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.5688909999999999, "db"=>0.589547, "backend"=>0, "xml"=>0.104489, :runtime=>8.052, :all=>49.388775}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=target&project=SourceprotectedProject>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=target&project=SourceprotectedProject
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.28150400000000003, "db"=>0.398706, "backend"=>0, "xml"=>0.035356, :runtime=>5.46, :all=>47.206703000000005}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=SourceprotectedProject>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new%2Creview&roles=source&types=maintenance_incident&project=SourceprotectedProject
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.337634, "db"=>0.578352, "backend"=>0, "xml"=>0.034704, :runtime=>7.526, :all=>47.470917}
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27SourceprotectedProject%3A%27%29+and+%40kind%3D%27maintenance_incident%27+and+repository%2Freleasetarget%2F%40trigger%3D%27maintenance%27>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/search/project/?match=starts-with%28%40name%2C%27Sourc...
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.5112880000000001, "db"=>0.975139, "backend"=>0, "xml"=>0.049302000000000006, :runtime=>11.811, :all=>55.407061}
[[0;37mDEBUG[0m|# 4309] [REST] find( Package, [:all, {:project=>"SourceprotectedProject"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/source/SourceprotectedProject
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.500379, "db"=>1.058836, "backend"=>0, "xml"=>0, :runtime=>10.77, :all=>50.867022}
[[0;37mDEBUG[0m|# 4309] [REST] find( Buildresult, [{:project=>"SourceprotectedProject", :view=>"status", :code=>["failed", "broken", "unresolvable"]}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/build/SourceprotectedProject/_result?view=status&code=failed&code=broken&code=unresolvable
[[0;37mDEBUG[0m|# 4309] RT {"view"=>nil, "db"=>0.51163, "backend"=>0, "xml"=>0, :runtime=>34.184, :all=>75.00159500000001}
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/source/SourceprotectedProject?cmd=showlinked>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: POST url: http://localhost:3203/source/SourceprotectedProject?cmd=showlinked
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.539091, "db"=>0.898529, "backend"=>0, "xml"=>0, :runtime=>12.002, :all=>16.18056}
[[0;37mDEBUG[0m|# 4309] [REST] find( Buildresult, [{:project=>"SourceprotectedProject", :view=>"summary"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/build/SourceprotectedProject/_result?view=summary
[[0;37mDEBUG[0m|# 4309] RT {"view"=>nil, "db"=>0.532523, "backend"=>0, "xml"=>0, :runtime=>25.554000000000002, :all=>66.495025}
[[0;37mDEBUG[0m|# 4309] [REST] find( Collection, [:id, {:what=>"project", :predicate=>"maintenance/maintains/@project='SourceprotectedProject'"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/search/project/id?match=maintenance%2Fmaintains%2F%40p...
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.602432, "db"=>0.935724, "backend"=>0, "xml"=>0.061636, :runtime=>9.768, :all=>51.162147}
[[0;37mDEBUG[0m|# 4309] [REST] find( Project, [{:name=>"SourceprotectedProject"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/source/SourceprotectedProject/_meta?
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.597158, "db"=>0.628644, "backend"=>0, "xml"=>0, :runtime=>12.116999999999999, :all=>54.292058}
[[32mINFO [0m|# 4309] Rendered project/_tabs.html.erb (2.7ms)
[[32mINFO [0m|# 4309] Rendered shared/_open_requests.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Rendered shared/_buildresult_box.html.erb (0.6ms)
[[32mINFO [0m|# 4309] Rendered project/show.html.erb within layouts/application (61.2ms)
[[32mINFO [0m|# 4309] Rendered layouts/_watch_and_search.html.erb (0.5ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_header.html.erb (1.0ms)
[[32mINFO [0m|# 4309] Rendered layouts/_personal_navigation.html.erb (1.0ms)
[[32mINFO [0m|# 4309] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Completed 200 OK in 562ms (Views: 66.4ms | ActiveRecord: 0.0ms | API: 539.9ms (XML: 0.3ms , View: 4.6ms , Backend: 0.0ms , DB: 9.8ms , HTTP: 379.5ms) | XML: 1.4ms)
[[32mINFO [0m|# 4309]
Started GET "/project/buildresult?project=SourceprotectedProject&index=" for 127.0.0.1 at 2012-10-02 14:25:33 +0200
[[32mINFO [0m|# 4309] Processing by ProjectController#buildresult as */*
[[32mINFO [0m|# 4309] Parameters: {"project"=>"SourceprotectedProject", "index"=>""}
[[0;37mDEBUG[0m|# 4309] Setting return_to: "/project/buildresult?project=SourceprotectedProject&index="
[[0;37mDEBUG[0m|# 4309] Authenticating with iChain mode: off
[[32mINFO [0m|# 4309] Anonymous request to /project/buildresult?project=SourceprotectedProject&index=
[[0;37mDEBUG[0m|# 4309] [REST] find( Buildresult, [{:project=>"SourceprotectedProject", :view=>"summary"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/build/SourceprotectedProject/_result?view=summary
[[0;37mDEBUG[0m|# 4309] RT {"view"=>nil, "db"=>0.891395, "backend"=>0, "xml"=>0, :runtime=>24.763, :all=>28.203918}
[[32mINFO [0m|# 4309] Rendered project/_buildstatus.html.erb (1.5ms)
[[32mINFO [0m|# 4309] Completed 200 OK in 33ms (Views: 2.0ms | ActiveRecord: 0.0ms | API: 28.2ms (XML: 0.0ms , Backend: 0.0ms , DB: 0.9ms , HTTP: 3.4ms) | XML: 0.1ms)
[[32mINFO [0m|# 4309]
Started GET "/package/show?package=pack&project=SourceprotectedProject" for 127.0.0.1 at 2012-10-02 14:25:34 +0200
[[32mINFO [0m|# 4309] Processing by PackageController#show as HTML
[[32mINFO [0m|# 4309] Parameters: {"package"=>"pack", "project"=>"SourceprotectedProject"}
[[0;37mDEBUG[0m|# 4309] Setting return_to: "/package/show?package=pack&project=SourceprotectedProject"
[[0;37mDEBUG[0m|# 4309] Authenticating with iChain mode: off
[[32mINFO [0m|# 4309] Anonymous request to /package/show?package=pack&project=SourceprotectedProject
[[0;37mDEBUG[0m|# 4309] [REST] find( Package, [{:project=>"SourceprotectedProject", :name=>"pack"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/source/SourceprotectedProject/pack/_meta?
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.5530729999999999, "db"=>2.0275849999999997, "backend"=>0, "xml"=>0, :runtime=>17.860999999999997, :all=>21.094079}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=SourceprotectedProject&package=pack>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=review&roles=reviewer&reviewstates=new&project=SourceprotectedProject&package=pack
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.43092, "db"=>0.59895, "backend"=>0, "xml"=>0.03884, :runtime=>8.01, :all=>47.621854}
[[0;37mDEBUG[0m|# 4309] Fetching request list from api
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/request?view=collection&states=new&roles=target&project=SourceprotectedProject&package=pack>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: GET url: http://localhost:3203/request?view=collection&states=new&roles=target&project=SourceprotectedProject&package=pack
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.5112209999999999, "db"=>0.47723499999999996, "backend"=>0, "xml"=>0.037512000000000004, :runtime=>6.213, :all=>47.579386}
[[0;37mDEBUG[0m|# 4309] [REST] find( Buildresult, [{:project=>"SourceprotectedProject", :package=>"pack", :view=>"status"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/build/SourceprotectedProject/_result?view=status&package=pack
[[0;37mDEBUG[0m|# 4309] RT {"view"=>nil, "db"=>0.609785, "backend"=>0, "xml"=>0, :runtime=>73.729, :all=>115.259722}
[[0;37mDEBUG[0m|# 4309] --> direct_http url: #http://localhost:3203/source/SourceprotectedProject/pack?cmd=showlinked>
[[0;37mDEBUG[0m|# 4309] http_do #1: method: POST url: http://localhost:3203/source/SourceprotectedProject/pack?cmd=showlinked
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.780311, "db"=>1.178471, "backend"=>6.370247, "xml"=>0, :runtime=>22.415999999999997, :all=>26.375512}
[[0;37mDEBUG[0m|# 4309] [REST] find( Directory, [{:project=>"SourceprotectedProject", :package=>"pack"}] )
[[0;37mDEBUG[0m|# 4309] http_do #1: method: get url: http://localhost:3203/source/SourceprotectedProject/pack?
[[0;37mDEBUG[0m|# 4309] RT {"view"=>0.9090969999999999, "db"=>2.639603, "backend"=>0, "xml"=>0, :runtime=>23.494999999999997, :all=>63.79164900000001}
[[31mERROR[0m|# 4309] rescue_action: caught ActiveXML::Transport::ForbiddenError: <?xml version="1.0"?>
<status code="source_access_no_permission">
<summary>SourceprotectedProject/pack</summary>
<details></details>
</status>
[[0;37mDEBUG[0m|# 4309] ERROR: 401; SourceprotectedProject/pack
[[32mINFO [0m|# 4309] Rendered error.html.erb within layouts/application (1.7ms)
[[32mINFO [0m|# 4309] Rendered layouts/_watch_and_search.html.erb (0.7ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_header.html.erb (1.7ms)
[[32mINFO [0m|# 4309] Rendered layouts/_personal_navigation.html.erb (1.4ms)
[[32mINFO [0m|# 4309] Rendered layouts/_flash.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Rendered vendor/neutral/layouts/_sponsor.html.erb (0.0ms)
[[32mINFO [0m|# 4309] Completed 401 Unauthorized in 341ms (Views: 11.3ms | ActiveRecord: 0.0ms | API: 321.7ms (XML: 0.1ms , View: 3.2ms , Backend: 6.4ms , DB: 7.5ms , HTTP: 170.0ms) | XML: 0.5ms)
+ echo
+ cleanup
+ echo 'Killing backend processes'
Killing backend processes
+ fuser -v http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/ws/
+ egrep 'perl|ruby'
USER PID ACCESS COMMAND
http://ci.opensuse.org/job/obs_master_testsuite_webui-testsuite/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