[OAK-6639] ObservationQueueFullWarnTest.testQueueFullThenFlushing fails sometimes

• Type: Test
• Status: Closed
• Priority: Minor
• Resolution: Fixed
• Fix Version/s: 1.7.8, 1.8.0
• Component/s: jcr
• Assignee: Stefan Egli
• Reporter: Vikas Saurabh
• Created: 08/Sep/17 12:40
• Updated: 26/Sep/19 11:42
• Resolved: 11/Sep/17 14:39

Description

Very intermittently, ObservationQueueFullWarnTest.testQueueFullThenFlushing fails. It had failed once in one of our internal CI setups. And recently (thankfully??) on apache setup [0] [1] [2].

Description from Apache failure:

---

Error Message

Just filled queue must not convert local->external expected:<6> but was:<4>

Stacktrace

java.lang.AssertionError: Just filled queue must not convert local->external expected:<6> but was:<4>
	at org.apache.jackrabbit.oak.jcr.observation.ObservationQueueFullWarnTest.testQueueFullThenFlushing(ObservationQueueFullWarnTest.java:312)

Standard Output

storing: /testNode/local0
storing: /testNode/local1
storing: /testNode/local2
storing: /testNode/local3
storing: /testNode/local4
storing: /testNode/local5
GOT: 1 - COUNTER: 1
 - Event{type=4, path=/testNode/local0, identifier=/testNode, info={jcr:primaryType=nt:unstructured, afterValue=0}, userID=admin, userData=null, date=1504862948917, external=false}
GOT: 1 - COUNTER: 2
 - Event{type=4, path=/testNode/local1, identifier=/testNode, info={jcr:primaryType=nt:unstructured, afterValue=1}, userID=admin, userData=null, date=1504862948918, external=false}
GOT: 1 - COUNTER: 3
 - Event{type=4, path=/testNode/local2, identifier=/testNode, info={jcr:primaryType=nt:unstructured, afterValue=2}, userID=admin, userData=null, date=1504862948919, external=false}
GOT: 1 - COUNTER: 4
 - Event{type=4, path=/testNode/local3, identifier=/testNode, info={jcr:primaryType=nt:unstructured, afterValue=3}, userID=admin, userData=null, date=1504862948919, external=false}
GOT: 2 - COUNTER: 6
 - Event{type=4, path=/testNode/local4, identifier=/testNode, info={jcr:primaryType=nt:unstructured, afterValue=4}, userID=oak:unknown, userData=null, date=1504862873156, external=true}
 - Event{type=4, path=/testNode/local5, identifier=/testNode, info={jcr:primaryType=nt:unstructured, afterValue=5}, userID=oak:unknown, userData=null, date=1504862873156, external=true}

---

[0]: https://lists.apache.org/thread.html/9c952201c132e2c6dce67b2d4fb13d9b0040d9874514885a9ed5bc9f@%3Coak-dev.jackrabbit.apache.org%3E
[1]: https://builds.apache.org/job/Jackrabbit%20Oak/722/
[2]: https://builds.apache.org/job/Jackrabbit%20Oak/722/org.apache.jackrabbit$oak-jcr/testReport/junit/org.apache.jackrabbit.oak.jcr.observation/ObservationQueueFullWarnTest/testQueueFullThenFlushing_SegmentTar_/

Issue Links

• is related to: OAK-6848 Improve ObservationQueueFullWarnTest.testQueueFullThenFlushing to not sleep arbitrarily when not required