Bug 1697682

Summary:

'Error processing event data' errors seen in engine.log

Product:

[oVirt] ovirt-engine

Reporter:

SATHEESARAN <sasundar>

Component:

BLL.Gluster

Assignee:

Sahina Bose <sabose>

Status:

CLOSED CURRENTRELEASE

QA Contact:

SATHEESARAN <sasundar>

Severity:

medium

Docs Contact:

Priority:

high

Version:

4.3.2.1

CC:

bshetty, bugs, rhs-bugs, sabose, sankarshan

Target Milestone:

ovirt-4.3.5

Flags:

pm-rhel: ovirt-4.3+

Target Release:

4.3.5.1

Hardware:

x86_64

OS:

Linux

Whiteboard:

Fixed In Version:

ovirt-engine-4.3.5.1

Doc Type:

Bug Fix

Doc Text:

Cause: Gluster events data was not deserialized due to abstract Map element present in Java object Consequence: Gluster events were not processed by engine Fix: Deserialization does not use strong object type mapping Result: Events are processed correctly

Story Points:

---

Clone Of:

1697681

Environment:

Last Closed:

2019-07-30 14:08:24 UTC

Type:

---

Regression:

---

Mount Type:

---

Documentation:

---

CRM:

Verified Versions:

Category:

---

oVirt Team:

Gluster

RHEL 7.3 requirements from Atomic Host:

Cloudforms Team:

---

Target Upstream Version:

Embargoed:

Bug Depends On:

Bug Blocks:

1697681

Attachments:

Description	Flags
engine.log	none

Description SATHEESARAN 2019-04-09 02:55:07 UTC

Description of problem:
-----------------------
Engine log has re-occuring errors : 'Error processing event data'. So far these errors are harmless and doesn't affect any functionality.

Version-Release number of selected component (if applicable):
-------------------------------------------------------------
RHHI-V 1.6
RHV 4.3.3

How reproducible:
-----------------
Always

Steps to Reproduce:
--------------------
1. Install HC deployment, with HE setup
2. Manage 3 hosts in the gluster+virt cluster
3. Check engine logs

Actual results:
---------------
Errors seen in the engine.log

Expected results:
-----------------
No errors should be seen

Additional info:
----------------
[root@hostedenginesm1 ~]# grep  -i ' error processing' /var/log/ovirt-engine/engine.log 
2019-04-04 15:12:22,359+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-2) [] Error processing event data
2019-04-04 15:12:22,364+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-2) [] Error processing event data
2019-04-04 15:12:22,367+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-2) [] Error processing event data

Comment 1 SATHEESARAN 2019-04-09 02:57:35 UTC

Created attachment 1553775 [details]
engine.log

Comment 2 bipin 2019-06-06 06:58:30 UTC

Moving back the bug to assigned state since I could still see the error reported above. 

Tested with ovirt-engine-4.3.4.2-0.1.el7.noarch.


Snippet:
=======
2019-06-04 12:51:53,575+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:51:53,591+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:51:53,605+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:51:53,624+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:51:53,635+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:51:53,648+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:51:55,695+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:51:55,703+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:51:55,712+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-3) [] Error processing event data
2019-06-04 12:53:34,628+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data
2019-06-04 12:53:34,639+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data
2019-06-04 12:53:34,648+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data
2019-06-04 12:53:34,657+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data
2019-06-04 12:53:34,665+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data
2019-06-04 12:53:34,674+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data
2019-06-04 12:53:37,560+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data
2019-06-04 12:53:37,572+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data
2019-06-04 12:53:37,581+05 ERROR [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default task-13) [] Error processing event data

Comment 3 RHEL Program Management 2019-06-06 06:59:24 UTC

Target release should be placed once a package build is known to fix a issue. Since this bug is not modified, the target version has been reset. Please use target milestone to plan a fix for a oVirt release.

Comment 6 Sahina Bose 2019-06-06 15:09:40 UTC

(In reply to bipin from comment #2)
> Moving back the bug to assigned state since I could still see the error
> reported above. 
> 
> Tested with ovirt-engine-4.3.4.2-0.1.el7.noarch.
> 
> 
> Snippet:
> =======
> 2019-06-04 12:51:53,575+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:51:53,591+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:51:53,605+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:51:53,624+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:51:53,635+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:51:53,648+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:51:55,695+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:51:55,703+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:51:55,712+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-3) [] Error processing event data
> 2019-06-04 12:53:34,628+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data
> 2019-06-04 12:53:34,639+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data
> 2019-06-04 12:53:34,648+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data
> 2019-06-04 12:53:34,657+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data
> 2019-06-04 12:53:34,665+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data
> 2019-06-04 12:53:34,674+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data
> 2019-06-04 12:53:37,560+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data
> 2019-06-04 12:53:37,572+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data
> 2019-06-04 12:53:37,581+05 ERROR
> [org.ovirt.engine.core.services.GlusterEventsWebHookServlet] (default
> task-13) [] Error processing event data

Can you provide debug logs from engine?

Comment 11 SATHEESARAN 2019-07-18 07:10:41 UTC

Tested with RHV-4.3.5.4

No more such error messages seen in engine.log

[root@rhvm-basic ~]#  grep  -i ' error processing' /var/log/ovirt-engine/engine.log
[root@rhvm-basic ~]#

Comment 12 Sandro Bonazzola 2019-07-30 14:08:24 UTC

This bugzilla is included in oVirt 4.3.5 release, published on July 30th 2019.

Since the problem described in this bug report should be
resolved in oVirt 4.3.5 release, it has been closed with a resolution of CURRENT RELEASE.

If the solution does not work for you, please open a new bug report.