-
Type: Bug
-
Status: Resolved
-
Priority: Minor
-
Resolution: Fixed
-
Affects Version/s: None
-
Component/s: Elasticsearch, Tests
-
Tags:
-
Team:PLATFORM
-
Sprint:nxplatform #23
-
Story Points:1
We want to fix the random TestElasticsearchObject.shouldRunIndexingOnDocumentAndItsChildren happening on PostgreSQL, see the stack below:
[2020-09-09T19:00:17.961Z] [ERROR] shouldRunIndexingOnDocumentAndItsChildren(org.nuxeo.ecm.restapi.server.jaxrs.management.TestElasticsearchObject) Time elapsed: 0.741 s <<< FAILURE! [2020-09-09T19:00:17.961Z] java.lang.AssertionError: expected:<3> but was:<0 [2020-09-09T19:00:17.961Z] at org.junit.Assert.fail(Assert.java:89) [2020-09-09T19:00:17.961Z] at org.junit.Assert.failNotEquals(Assert.java:835) [2020-09-09T19:00:17.961Z] at org.junit.Assert.assertEquals(Assert.java:647) [2020-09-09T19:00:17.961Z] at org.junit.Assert.assertEquals(Assert.java:633) [2020-09-09T19:00:17.961Z] at org.nuxeo.ecm.restapi.server.jaxrs.management.TestElasticsearchObject.verifyIndexingResponse(TestElasticsearchObject.java:175) [2020-09-09T19:00:17.961Z] at org.nuxeo.ecm.restapi.server.jaxrs.management.TestElasticsearchObject.shouldRunIndexingOnDocumentAndItsChildren(TestElasticsearchObject.java:131) [2020-09-09T19:00:17.961Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2020-09-09T19:00:17.961Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2020-09-09T19:00:17.961Z] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2020-09-09T19:00:17.961Z] at java.base/java.lang.reflect.Method.invoke(Method.java:566) [2020-09-09T19:00:17.961Z] at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59) [2020-09-09T19:00:17.961Z] at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [2020-09-09T19:00:17.961Z] at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56) [2020-09-09T19:00:17.961Z] at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeMethodRunStatement.evaluate(FeaturesRunner.java:396) [2020-09-09T19:00:17.961Z] at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeSetupStatement.evaluate(FeaturesRunner.java:410) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner.evaluateRunnable(FeaturesRunner.java:267) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterMethodRunStatement.evaluate(FeaturesRunner.java:432) [2020-09-09T19:00:17.961Z] at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner.evaluateRunnable(FeaturesRunner.java:267) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterTeardownStatement.evaluate(FeaturesRunner.java:445) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$RulesFactory$1.evaluate(FeaturesRunner.java:515) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.RuntimeDeployment$DeploymentStatement.evaluate(RuntimeDeployment.java:326) [2020-09-09T19:00:17.961Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [2020-09-09T19:00:17.961Z] at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) [2020-09-09T19:00:17.961Z] at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) [2020-09-09T19:00:17.961Z] at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) [2020-09-09T19:00:17.961Z] at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) [2020-09-09T19:00:17.961Z] at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331 [2020-09-09T19:00:17.961Z] at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [2020-09-09T19:00:17.961Z] at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [2020-09-09T19:00:17.961Z] at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [2020-09-09T19:00:17.961Z] at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterClassStatement.evaluate(FeaturesRunner.java:343) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$RulesFactory$1.evaluate(FeaturesRunner.java:515) [2020-09-09T19:00:17.961Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeClassStatement.evaluate(FeaturesRunner.java:326) [2020-09-09T19:00:17.961Z] at org.junit.rules.RunRules.evaluate(RunRules.java:20) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [2020-09-09T19:00:17.962Z] at org.junit.runners.Suite.runChild(Suite.java:128) [2020-09-09T19:00:17.962Z] at org.junit.runners.Suite.runChild(Suite.java:27) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [2020-09-09T19:00:17.962Z] at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [2020-09-09T19:00:18.225Z] at org.apache.maven.surefire.junitcore.JUnitCore.run(JUnitCore.java:55) [2020-09-09T19:00:18.225Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:137) [2020-09-09T19:00:18.225Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:107) [2020-09-09T19:00:18.225Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:83) [2020-09-09T19:00:18.225Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:75) [2020-09-09T19:00:18.225Z] at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:158) [2020-09-09T19:00:18.225Z] at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) [2020-09-09T19:00:18.226Z] at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) [2020-09-09T19:00:18.226Z] at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) [2020-09-09T19:00:18.226Z] at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
Standard Output:
2020-09-10 11:33:03,955 [bulk/indexCompletionPool-00,in:2,inCheckpoint:2,out:0,lastRead:1599737583342,lastTimer:0,wm:209680804521050113,loop:83,checkpoint] WARN [IndexCompletionComputation] Index command: 4b3a117d-60a4-4709-86d5-42692069eff4 completed: 0 in 0.01s (wait: 0.00s, scroll: 0.01s) rate: 0.00 docs/s 2020-09-10 11:33:03,957 [bulk/indexCompletionPool-00,in:2,inCheckpoint:2,out:0,lastRead:1599737583342,lastTimer:0,wm:209680804521050113,loop:83,checkpoint] WARN [IndexCompletionComputation] Update alias requested by command: 4b3a117d-60a4-4709-86d5-42692069eff4