-
Type: Bug
-
Status: Resolved
-
Priority: Major
-
Resolution: Cannot Reproduce
-
Affects Version/s: None
-
Fix Version/s: None
-
Component/s: CI/CD
-
Tags:
-
Team:PLATFORM
-
Story Points:5
See https://jenkins.platform.dev.nuxeo.com/job/nuxeo/job/nuxeo/job/master/405/.
[2020-04-08T19:58:13.690Z] [INFO] Running org.nuxeo.ecm.core.storage.sql.TestSQLBackendNoPathOptims [2020-04-08T19:58:15.597Z] 2020-04-08 19:58:15,565 [main] WARN [ConnectionFactoryImpl] cannot dispose connection manager of test [2020-04-08T19:58:47.712Z] 2020-04-08 19:58:45,619 [main] WARN [ConnectionFactoryImpl] cannot dispose connection manager of test [2020-04-08T20:00:09.149Z] 2020-04-08 20:00:00,014 [Quartz_Worker-1] ERROR [EventServiceImpl] Exception during findRetentionExpired sync listener execution, continuing to run other listeners [2020-04-08T20:00:09.149Z] java.lang.NullPointerException: null [2020-04-08T20:00:09.149Z] at org.nuxeo.ecm.core.security.RetentionExpiredFinderListener.handleEvent(RetentionExpiredFinderListener.java:53) ~[classes/:?] [2020-04-08T20:00:09.149Z] at org.nuxeo.ecm.core.event.impl.EventServiceImpl.fireEvent(EventServiceImpl.java:241) [classes/:?] [2020-04-08T20:00:09.149Z] at org.nuxeo.ecm.core.scheduler.EventJob.execute(EventJob.java:107) [classes/:?] [2020-04-08T20:00:09.149Z] at org.nuxeo.ecm.core.scheduler.EventJob.execute(EventJob.java:65) [classes/:?] [2020-04-08T20:00:09.149Z] at org.quartz.core.JobRunShell.run(JobRunShell.java:202) [quartz-2.3.2.jar:?] [2020-04-08T20:00:09.149Z] at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:573) [quartz-2.3.2.jar:?] [2020-04-08T20:22:31.566Z] 2020-04-08 20:22:28,262 [main] WARN [TransactionImpl] Error ending association for XAResource org.nuxeo.ecm.core.storage.sql.TestSQLBackend$1@14339a16; transaction will roll back. XA error code: 104 [2020-04-08T20:22:31.566Z] javax.transaction.xa.XAException: null [2020-04-08T20:22:31.566Z] at org.nuxeo.ecm.core.storage.sql.TestSQLBackend$1.end(TestSQLBackend.java:1664) ~[test-classes/:?] [2020-04-08T20:22:31.566Z] at org.apache.geronimo.transaction.manager.TransactionImpl.endResources(TransactionImpl.java:569) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.566Z] at org.apache.geronimo.transaction.manager.TransactionImpl.endResources(TransactionImpl.java:548) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.566Z] at org.apache.geronimo.transaction.manager.TransactionImpl.beforePrepare(TransactionImpl.java:408) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.566Z] at org.apache.geronimo.transaction.manager.TransactionImpl.commit(TransactionImpl.java:255) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.566Z] at org.apache.geronimo.transaction.manager.TransactionManagerImpl.commit(TransactionManagerImpl.java:252) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.jtajca.NuxeoContainer$UserTransactionImpl.commit(NuxeoContainer.java:538) [nuxeo-runtime-jtajca-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.transaction.TransactionHelper.commitOrRollbackTransaction(TransactionHelper.java:393) [nuxeo-runtime-jtajca-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.nuxeo.ecm.core.storage.sql.TestSQLBackend.testRollback(TestSQLBackend.java:1693) [test-classes/:?] [2020-04-08T20:22:31.566Z] at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?] [2020-04-08T20:22:31.566Z] at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:?] [2020-04-08T20:22:31.566Z] at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?] [2020-04-08T20:22:31.566Z] at java.lang.reflect.Method.invoke(Method.java:566) ~[?:?] [2020-04-08T20:22:31.566Z] at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeMethodRunStatement.evaluate(FeaturesRunner.java:308) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeSetupStatement.evaluate(FeaturesRunner.java:322) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterMethodRunStatement.evaluate(FeaturesRunner.java:345) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterTeardownStatement.evaluate(FeaturesRunner.java:362) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$RulesFactory$1.evaluate(FeaturesRunner.java:435) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.RuntimeDeployment$DeploymentStatement.evaluate(RuntimeDeployment.java:326) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterClassStatement.evaluate(FeaturesRunner.java:251) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$RulesFactory$1.evaluate(FeaturesRunner.java:435) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeClassStatement.evaluate(FeaturesRunner.java:234) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.566Z] at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.Suite.runChild(Suite.java:128) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.Suite.runChild(Suite.java:27) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.566Z] at org.apache.maven.surefire.junitcore.JUnitCore.run(JUnitCore.java:55) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.566Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:137) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.566Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:107) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:83) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:75) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:158) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) [surefire-booter-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) [surefire-booter-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) [surefire-booter-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) [surefire-booter-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] 2020-04-08 20:22:28,288 [main] WARN [TransactionImpl] Error ending association for XAResource org.nuxeo.ecm.core.storage.sql.TestSQLBackend$1@14339a16; transaction will roll back. XA error code: 104 [2020-04-08T20:22:31.567Z] javax.transaction.xa.XAException: null [2020-04-08T20:22:31.567Z] at org.nuxeo.ecm.core.storage.sql.TestSQLBackend$1.end(TestSQLBackend.java:1664) ~[test-classes/:?] [2020-04-08T20:22:31.567Z] at org.apache.geronimo.transaction.manager.TransactionImpl.endResources(TransactionImpl.java:569) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.567Z] at org.apache.geronimo.transaction.manager.TransactionImpl.endResources(TransactionImpl.java:548) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.567Z] at org.apache.geronimo.transaction.manager.TransactionImpl.rollback(TransactionImpl.java:488) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.567Z] at org.apache.geronimo.transaction.manager.TransactionManagerImpl.rollback(TransactionManagerImpl.java:265) [geronimo-transaction-2.2.1.jar:2.2.1] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.jtajca.NuxeoContainer$UserTransactionImpl.rollback(NuxeoContainer.java:556) [nuxeo-runtime-jtajca-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.transaction.TransactionHelper.commitOrRollbackTransaction(TransactionHelper.java:416) [nuxeo-runtime-jtajca-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.nuxeo.ecm.core.storage.sql.TestSQLBackend.testRollback(TestSQLBackend.java:1715) [test-classes/:?] [2020-04-08T20:22:31.567Z] at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?] [2020-04-08T20:22:31.567Z] at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:?] [2020-04-08T20:22:31.567Z] at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?] [2020-04-08T20:22:31.567Z] at java.lang.reflect.Method.invoke(Method.java:566) ~[?:?] [2020-04-08T20:22:31.567Z] at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeMethodRunStatement.evaluate(FeaturesRunner.java:308) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeSetupStatement.evaluate(FeaturesRunner.java:322) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterMethodRunStatement.evaluate(FeaturesRunner.java:345) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterTeardownStatement.evaluate(FeaturesRunner.java:362) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$RulesFactory$1.evaluate(FeaturesRunner.java:435) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.RuntimeDeployment$DeploymentStatement.evaluate(RuntimeDeployment.java:326) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterClassStatement.evaluate(FeaturesRunner.java:251) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$RulesFactory$1.evaluate(FeaturesRunner.java:435) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeClassStatement.evaluate(FeaturesRunner.java:234) [nuxeo-runtime-test-11.1.9.jar:?] [2020-04-08T20:22:31.567Z] at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.Suite.runChild(Suite.java:128) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.Suite.runChild(Suite.java:27) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.jar:4.13] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCore.run(JUnitCore.java:55) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:137) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:107) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:83) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:75) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:158) [surefire-junit47-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) [surefire-booter-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) [surefire-booter-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) [surefire-booter-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) [surefire-booter-2.22.2.jar:2.22.2] [2020-04-08T20:22:31.567Z] 2020-04-08 20:22:29,102 [main] WARN [ConnectionFactoryImpl] cannot dispose connection manager of test [2020-04-08T20:22:33.472Z] 2020-04-08 20:22:33,133 [main] WARN [ConnectionFactoryImpl] cannot dispose connection manager of test [2020-04-08T20:22:33.472Z] [ERROR] Tests run: 97, Failures: 0, Errors: 1, Skipped: 4, Time elapsed: 1,459.532 s <<< FAILURE! - in org.nuxeo.ecm.core.storage.sql.TestSQLBackendNoPathOptims [2020-04-08T20:22:33.472Z] [ERROR] testRecursiveRemovalBig(org.nuxeo.ecm.core.storage.sql.TestSQLBackendNoPathOptims) Time elapsed: 1,415.586 s <<< ERROR! [2020-04-08T20:22:33.472Z] org.nuxeo.runtime.transaction.TransactionRuntimeException: Unable to commit: Transaction timeout [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.transaction.TransactionHelper.commitOrRollbackTransaction(TransactionHelper.java:410) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.transaction.TransactionHelper.runInTransaction(TransactionHelper.java:617) [2020-04-08T20:22:33.472Z] at org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapperConnector.doConnectAndInvoke(JDBCMapperConnector.java:95) [2020-04-08T20:22:33.472Z] at org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapperConnector.invoke(JDBCMapperConnector.java:84) [2020-04-08T20:22:33.472Z] at com.sun.proxy.$Proxy57.updateReadAcls(Unknown Source) [2020-04-08T20:22:33.472Z] at org.nuxeo.ecm.core.storage.sql.SoftRefCachingMapper.updateReadAcls(SoftRefCachingMapper.java:131) [2020-04-08T20:22:33.472Z] at org.nuxeo.ecm.core.storage.sql.SessionImpl.updateReadAcls(SessionImpl.java:1268) [2020-04-08T20:22:33.472Z] at org.nuxeo.ecm.core.storage.sql.SessionImpl.flush(SessionImpl.java:348) [2020-04-08T20:22:33.472Z] at org.nuxeo.ecm.core.storage.sql.SessionImpl.save(SessionImpl.java:325) [2020-04-08T20:22:33.472Z] at org.nuxeo.ecm.core.storage.sql.TestSQLBackend.testRecursiveRemovalBig(TestSQLBackend.java:410) [2020-04-08T20:22:33.472Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2020-04-08T20:22:33.472Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2020-04-08T20:22:33.472Z] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2020-04-08T20:22:33.472Z] at java.base/java.lang.reflect.Method.invoke(Method.java:566) [2020-04-08T20:22:33.472Z] at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59) [2020-04-08T20:22:33.472Z] at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [2020-04-08T20:22:33.472Z] at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56) [2020-04-08T20:22:33.472Z] at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeMethodRunStatement.evaluate(FeaturesRunner.java:308) [2020-04-08T20:22:33.472Z] at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeSetupStatement.evaluate(FeaturesRunner.java:322) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterMethodRunStatement.evaluate(FeaturesRunner.java:345) [2020-04-08T20:22:33.472Z] at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterTeardownStatement.evaluate(FeaturesRunner.java:362) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$RulesFactory$1.evaluate(FeaturesRunner.java:435) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.RuntimeDeployment$DeploymentStatement.evaluate(RuntimeDeployment.java:326) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [2020-04-08T20:22:33.472Z] at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) [2020-04-08T20:22:33.472Z] at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) [2020-04-08T20:22:33.472Z] at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$AfterClassStatement.evaluate(FeaturesRunner.java:251) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$RulesFactory$1.evaluate(FeaturesRunner.java:435) [2020-04-08T20:22:33.472Z] at org.nuxeo.runtime.test.runner.FeaturesRunner$BeforeClassStatement.evaluate(FeaturesRunner.java:234) [2020-04-08T20:22:33.472Z] at org.junit.rules.RunRules.evaluate(RunRules.java:20) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [2020-04-08T20:22:33.472Z] at org.junit.runners.Suite.runChild(Suite.java:128) [2020-04-08T20:22:33.472Z] at org.junit.runners.Suite.runChild(Suite.java:27) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [2020-04-08T20:22:33.472Z] at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [2020-04-08T20:22:33.473Z] at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [2020-04-08T20:22:33.473Z] at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [2020-04-08T20:22:33.473Z] at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [2020-04-08T20:22:33.473Z] at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.junitcore.JUnitCore.run(JUnitCore.java:55) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:137) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:107) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:83) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:75) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:158) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) [2020-04-08T20:22:33.473Z] at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) [2020-04-08T20:22:33.473Z] Caused by: javax.transaction.RollbackException: Unable to commit: Transaction timeout [2020-04-08T20:22:33.473Z] at org.apache.geronimo.transaction.manager.TransactionImpl.commit(TransactionImpl.java:267) [2020-04-08T20:22:33.473Z] at org.apache.geronimo.transaction.manager.TransactionManagerImpl.commit(TransactionManagerImpl.java:252) [2020-04-08T20:22:33.473Z] at org.nuxeo.runtime.jtajca.NuxeoContainer$UserTransactionImpl.commit(NuxeoContainer.java:538) [2020-04-08T20:22:33.473Z] at org.nuxeo.runtime.transaction.TransactionHelper.commitOrRollbackTransaction(TransactionHelper.java:393) [2020-04-08T20:22:33.473Z] ... 60 more
Not sure how the error in TestSQLBackend.testRollback is related, it happens locally systematically.
This test was historically added for NXP-20211.