Bug 1408725 - 4.0.7: UX: exception when opening UI (many times, until UI loads) (""Error while executing action: A Request to the Server failed: java.lang.reflect.InvocationTargetException")
Summary: 4.0.7: UX: exception when opening UI (many times, until UI loads) (""Error wh...
Keywords:
Status: CLOSED CURRENTRELEASE
Alias: None
Product: ovirt-engine
Classification: oVirt
Component: Frontend.WebAdmin
Version: 4.0.6
Hardware: Unspecified
OS: Unspecified
unspecified
high
Target Milestone: ovirt-4.0.7
: ---
Assignee: Arik
QA Contact: Lucie Leistnerova
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2016-12-26 18:44 UTC by Yaniv Kaul
Modified: 2017-02-27 11:45 UTC (History)
7 users (show)

Fixed In Version:
Doc Type: If docs needed, set a value
Doc Text:
Clone Of:
Environment:
Last Closed: 2017-02-27 11:45:47 UTC
oVirt Team: Virt
Embargoed:
oourfali: ovirt-4.0.z?
rule-engine: blocker?
oourfali: planning_ack?
rule-engine: devel_ack+
pstehlik: testing_ack+

Attachments (Terms of Use)


Links
System ID Private Priority Status Summary Last Updated
oVirt gerrit 69178 0 ovirt-engine-4.0 MERGED core: fix the serialization of vm statistics for gwt 2016-12-27 12:56:44 UTC

Description Yaniv Kaul 2016-12-26 18:44:54 UTC 
Description of problem:
http://resources.ovirt.org/pub/ovirt-4.0-snapshot/rpm/el7/noarch/ovirt-engine-webadmin-portal-debuginfo-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch.rpm


"Error while executing action: A Request to the Server failed: java.lang.reflect.InvocationTargetException"

Nothing on ui.log (debug log RPM is installed, service restarted)
On server.log:
2016-12-26 13:33:46,867 WARNING [com.google.gwt.rpc.server.WebModePayloadSink] (default task-20) Skipped sending the field org.ovirt.engine.core.common.migration.MigrationPolicy.config because it's unused in the client. It should either be changed to transient or removed.
2016-12-26 13:33:46,867 WARNING [com.google.gwt.rpc.server.WebModePayloadSink] (default task-20) Skipped sending the field org.ovirt.engine.core.common.migration.ConvergenceConfig.convergenceItems because it's unused in the client. It should either be changed to transient or removed.
2016-12-26 13:33:46,867 WARNING [com.google.gwt.rpc.server.WebModePayloadSink] (default task-20) Skipped sending the field org.ovirt.engine.core.common.migration.ConvergenceConfig.initialItems because it's unused in the client. It should either be changed to transient or removed.
2016-12-26 13:33:46,867 WARNING [com.google.gwt.rpc.server.WebModePayloadSink] (default task-20) Skipped sending the field org.ovirt.engine.core.common.migration.ConvergenceConfig.lastItems because it's unused in the client. It should either be changed to transient or removed.
2016-12-26 13:33:46,867 WARNING [com.google.gwt.rpc.server.WebModePayloadSink] (default task-20) Skipped sending the field org.ovirt.engine.core.common.migration.ConvergenceItemWithStallingLimit.convergenceItem because it's unused in the client. It should either be changed to transient or removed.
2016-12-26 13:33:46,867 WARNING [com.google.gwt.rpc.server.WebModePayloadSink] (default task-20) Skipped sending the field org.ovirt.engine.core.common.migration.ConvergenceItem.params because it's unused in the client. It should either be changed to transient or removed.
2016-12-26 13:33:50,935 INFO  [org.jboss.as.clustering.infinispan] (default task-27) WFLYCLINF0002: Started dashboard cache from ovirt-engine container
2016-12-26 13:33:50,941 INFO  [org.jboss.as.clustering.infinispan] (default task-27) WFLYCLINF0002: Started inventory cache from ovirt-engine container
2016-12-26 13:33:50,992 WARN  [org.jboss.jca.core.connectionmanager.pool.strategy.OnePool] (default task-27) IJ000407: No lazy enlistment available for DWHDataSource


httpd ssl_error_log is full with:
Mon Dec 26 13:10:14.965623 2016] [proxy:error] [pid 26599] AH00940: AJP: disabled connection for (127.0.0.1)
[Mon Dec 26 13:10:14.991160 2016] [proxy:error] [pid 26889] AH00940: AJP: disabled connection for (127.0.0.1)
[Mon Dec 26 13:10:15.026485 2016] [proxy:error] [pid 26848] AH00940: AJP: disabled connection for (127.0.0.1)
[Mon Dec 26 13:10:15.047199 2016] [proxy:error] [pid 26601] AH00940: AJP: disabled connection for (127.0.0.1)
[Mon Dec 26 13:10:15.085687 2016] [proxy:error] [pid 26597] AH00940: AJP: disabled connection for (127.0.0.1)


which makes me think it sounds like related to https://gerrit.ovirt.org/#/c/68394/




Version-Release number of selected component (if applicable):
[root@lago-basic-suite-4-0-engine ovirt-engine]# rpm -qa |grep ovirt |grep -E "engine|web"
ovirt-engine-setup-plugin-ovirt-engine-common-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-tools-backup-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-setup-plugin-vmconsole-proxy-helper-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-tools-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-backend-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-extensions-api-impl-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-lib-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-setup-plugin-websocket-proxy-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-dwh-setup-4.0.7-0.1.master.20161204142138.el7.centos.noarch
ovirt-engine-restapi-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-vmconsole-proxy-helper-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-setup-plugin-ovirt-engine-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-webadmin-portal-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-userportal-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-extension-aaa-ldap-1.2.3-0.0.master.20161216110759.git7206896.el7.noarch
ovirt-engine-extension-aaa-jdbc-1.1.3-0.0.master.20161118164739.gitd0ff686.el7.noarch
ovirt-engine-sdk-python-3.6.9.2-0.1.20161207.gite99bbd1.el7.centos.noarch
ovirt-engine-wildfly-10.1.0-1.el7.x86_64
python-ovirt-engine-sdk4-4.0.4-1.el7.centos.x86_64
ovirt-engine-setup-base-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-cli-3.6.9.2-1.el7.centos.noarch
ovirt-engine-websocket-proxy-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-dwh-4.0.7-0.1.master.20161204142138.el7.centos.noarch
ovirt-engine-setup-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-dashboard-1.0.6-1.el7.centos.noarch
ovirt-engine-dbscripts-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-extension-aaa-ldap-setup-1.2.3-0.0.master.20161216110759.git7206896.el7.noarch
ovirt-engine-webadmin-portal-debuginfo-4.0.7-0.0.master.20161225152228.gitce33304.el7.centos.noarch
ovirt-engine-wildfly-overlay-10.0.0-1.el7.noarch

How reproducible:
Always, on the first time entering the UI, clicking many times makes it go away.

Steps to Reproduce:
1. Run ovirt-system-test suite 4.0, login to UI.
Actual results:



Additional info:
ui.log is empty, even with debug RPM installed and service restarted.
Comment 1 Oved Ourfali 2016-12-27 06:23:39 UTC 
Can you please attach all logs?
Comment 2 Yaniv Kaul 2016-12-27 08:35:40 UTC 
Interesting - doesn't reproduce with ovirt-engine-webadmin-portal-4.0.7-0.0.master.20161226130549.git8fe5e67.el7.centos.noarch - worth looking into what the difference is. I remember already closing such a TargetInvocation bug from QE because they could not reproduce it later either...
Comment 3 Oved Ourfali 2016-12-27 08:40:29 UTC 
(In reply to Yaniv Kaul from comment #2)
> Interesting - doesn't reproduce with
> ovirt-engine-webadmin-portal-4.0.7-0.0.master.20161226130549.git8fe5e67.el7.
> centos.noarch - worth looking into what the difference is. I remember
> already closing such a TargetInvocation bug from QE because they could not
> reproduce it later either...

We closed it because it was already fixed, and they were using an older version.
Comment 4 Juan Hernández 2016-12-27 09:13:04 UTC 
Note also that in the web server log are kind of normal. They indicate that the web server wasn't able to connect to the application server, and thus the web server disabled the failed worker (temporarily, 60 seconds by default, 5 in our setup, can be adjusted). Note that a request that returns an error response, like 404 or 500, is *not* considered a failure, only if the TCP connection isn't established or no response is received it is considered a failure. The application server starts the AJP listener very soon, even before deploying the application. So if this is happening it means that some client is trying to access the application while the engine is down or starting. That client may be the UI, if it is kept open while the engine is restarted.
Comment 5 Oved Ourfali 2016-12-27 11:51:09 UTC 
Seems like the virt issue was fixed only on the 4.0.6 branch and not on the 4.0 branch, so moving to Virt and assigning to Arik (after offline discussing it with him).
Comment 6 Red Hat Bugzilla Rules Engine 2016-12-27 11:51:16 UTC 
This bug report has Keywords: Regression or TestBlocker.
Since no regressions or test blockers are allowed between releases, it is also being identified as a blocker for this release. Please resolve ASAP.
Comment 7 Sandro Bonazzola 2017-01-25 07:56:45 UTC 
4.0.6 has been the last oVirt 4.0 release, please re-target this bug.
Comment 8 Lucie Leistnerova 2017-01-31 14:47:55 UTC 
admin portal runs without any error, with/without debuginfo and running VM

verified in ovirt-engine-webadmin-portal-4.0.7-0.1.el7ev.noarch with ovirt-engine-webadmin-portal-debuginfo-4.0.7-0.1.el7ev.noarch
Comment 9 Sandro Bonazzola 2017-02-02 07:07:51 UTC 
4.0.6 has been the last oVirt 4.0 release, please re-target this bug.
Note You need to log in before you can comment on or make changes to this bug.