[JIRA] (HSEARCH-4670) Fix flaky test org.hibernate.search.integrationtest.mapper.orm.massindexing.MassIndexingErrorCustomBackgroundFailureHandlerIT(default-default-database-oracle)
by Yoann Rodière (JIRA)
Yoann Rodière ( https://hibernate.atlassian.net/secure/ViewProfile.jspa?accountId=557058%... ) *created* an issue
Hibernate Search ( https://hibernate.atlassian.net/browse/HSEARCH?atlOrigin=eyJpIjoiMTRiZWZm... ) / Task ( https://hibernate.atlassian.net/browse/HSEARCH-4670?atlOrigin=eyJpIjoiMTR... ) HSEARCH-4670 ( https://hibernate.atlassian.net/browse/HSEARCH-4670?atlOrigin=eyJpIjoiMTR... ) Fix flaky test org.hibernate.search.integrationtest.mapper.orm.massindexing.MassIndexingErrorCustomBackgroundFailureHandlerIT(default-default-database-oracle) ( https://hibernate.atlassian.net/browse/HSEARCH-4670?atlOrigin=eyJpIjoiMTR... )
Issue Type: Task Assignee: Unassigned Components: tests Created: 10/Aug/2022 02:59 AM Fix Versions: 6.2-backlog Priority: Major Reporter: Yoann Rodière ( https://hibernate.atlassian.net/secure/ViewProfile.jspa?accountId=557058%... )
See https://ci.hibernate.org/blue/organizations/jenkins/hibernate-search/deta... ( https://ci.hibernate.org/blue/organizations/jenkins/hibernate-search/deta... )
Error
No interactions wanted here:
-> at org.hibernate.search.integrationtest.mapper.orm.massindexing.MassIndexingErrorCustomBackgroundFailureHandlerIT.assertNoFailureHandling(MassIndexingErrorCustomBackgroundFailureHandlerIT.java:46)
But found these interactions on mock 'failureHandler':
-> at org.hibernate.search.engine.reporting.impl.FailSafeFailureHandlerWrapper.handle(FailSafeFailureHandlerWrapper.java:30)
Actually, above is the only interaction with this mock.
Stacktrace
org.mockito.exceptions.verification.NoInteractionsWanted:
No interactions wanted here:
-> at org.hibernate.search.integrationtest.mapper.orm.massindexing.MassIndexingErrorCustomBackgroundFailureHandlerIT.assertNoFailureHandling(MassIndexingErrorCustomBackgroundFailureHandlerIT.java:46)
But found these interactions on mock 'failureHandler':
-> at org.hibernate.search.engine.reporting.impl.FailSafeFailureHandlerWrapper.handle(FailSafeFailureHandlerWrapper.java:30)
Actually, above is the only interaction with this mock.
at org.hibernate.search.integrationtest.mapper.orm.massindexing.MassIndexingErrorCustomBackgroundFailureHandlerIT.assertNoFailureHandling(MassIndexingErrorCustomBackgroundFailureHandlerIT.java:46)
at org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT.entityLoading(AbstractMassIndexingErrorIT.java:122)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:568)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.hibernate.search.util.impl.integrationtest.common.rule.BackendMock$1.evaluate(BackendMock.java:52)
at org.hibernate.search.util.impl.integrationtest.common.rule.MappingSetupHelper$1.evaluate(MappingSetupHelper.java:74)
at org.hibernate.search.util.impl.integrationtest.common.TestConfigurationProvider$1.evaluate(TestConfigurationProvider.java:45)
at org.hibernate.search.util.impl.integrationtest.common.rule.ThreadSpy$1.evaluate(ThreadSpy.java:42)
at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
at org.junit.runners.Suite.runChild(Suite.java:128)
at org.junit.runners.Suite.runChild(Suite.java:27)
at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
at org.apache.maven.surefire.junitcore.JUnitCore.run(JUnitCore.java:55)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:137)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:107)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:83)
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:75)
at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:158)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:456)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:169)
at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:595)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:581)
Standard Output
09:51:13,050 (main) INFO SimpleSessionFactoryBuilder:47 - Not setting the property with key 'hibernate.search.coordination.strategy' because value is null.
09:51:13,050 (main) WARN CachingRegionFactory:48 - org.hibernate.testing.cache.CachingRegionFactory should be only used for testing.
09:51:13,051 (main) WARN pooling:75 - HHH10001002: Using Hibernate built-in connection pool (not for production use!)
09:51:13,051 (main) INFO pooling:119 - HHH10001005: using driver [oracle.jdbc.OracleDriver] at URL [jdbc:oracle:thin:@localhost:1521/XE]
09:51:13,051 (main) INFO pooling:128 - HHH10001001: Connection properties: {password=****, user=SYSTEM}
09:51:13,051 (main) INFO pooling:132 - HHH10001003: Autocommit mode: false
09:51:13,051 (main) INFO DriverManagerConnectionProviderImpl:322 - HHH000115: Hibernate connection pool size: 31 (min=1)
09:51:13,066 (main) INFO Dialect:175 - HHH000400: Using dialect: org.hibernate.dialect.Oracle10gDialect
09:51:13,069 (main) INFO HibernateSearchPreIntegrationService:91 - HSEARCH000034: Hibernate Search version 6.2.0-SNAPSHOT
09:51:13,074 (main) INFO access:48 - HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@1a049419] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
09:51:13,075 (main) WARN ExceptionHandlerLoggedImpl:27 - GenerationTarget encountered exception accepting command : Error executing DDL "drop table Book cascade constraints" via JDBC Statement
org.hibernate.tool.schema.spi.CommandAcceptanceException: Error executing DDL "drop table Book cascade constraints" via JDBC Statement
at org.hibernate.tool.schema.internal.exec.GenerationTargetToDatabase.accept(GenerationTargetToDatabase.java:67) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.tool.schema.internal.SchemaDropperImpl.applySqlString(SchemaDropperImpl.java:387) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.tool.schema.internal.SchemaDropperImpl.applySqlStrings(SchemaDropperImpl.java:371) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.tool.schema.internal.SchemaDropperImpl.dropFromMetadata(SchemaDropperImpl.java:246) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.tool.schema.internal.SchemaDropperImpl.performDrop(SchemaDropperImpl.java:156) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.tool.schema.internal.SchemaDropperImpl.doDrop(SchemaDropperImpl.java:128) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.tool.schema.internal.SchemaDropperImpl.doDrop(SchemaDropperImpl.java:114) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.tool.schema.spi.SchemaManagementToolCoordinator.performDatabaseAction(SchemaManagementToolCoordinator.java:157) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.tool.schema.spi.SchemaManagementToolCoordinator.process(SchemaManagementToolCoordinator.java:85) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.internal.SessionFactoryImpl.<init>(SessionFactoryImpl.java:335) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.boot.internal.SessionFactoryBuilderImpl.build(SessionFactoryBuilderImpl.java:471) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
at org.hibernate.search.util.impl.integrationtest.mapper.orm.SimpleSessionFactoryBuilder.build(SimpleSessionFactoryBuilder.java:124) ~[hibernate-search-util-internal-integrationtest-mapper-orm-6.2.0-SNAPSHOT.jar:?]
at org.hibernate.search.util.impl.integrationtest.mapper.orm.OrmSetupHelper$SetupContext.build(OrmSetupHelper.java:204) ~[hibernate-search-util-internal-integrationtest-mapper-orm-6.2.0-SNAPSHOT.jar:?]
at org.hibernate.search.util.impl.integrationtest.mapper.orm.OrmSetupHelper$SetupContext.build(OrmSetupHelper.java:138) ~[hibernate-search-util-internal-integrationtest-mapper-orm-6.2.0-SNAPSHOT.jar:?]
at org.hibernate.search.util.impl.integrationtest.common.rule.MappingSetupHelper$AbstractSetupContext.setup(MappingSetupHelper.java:174) ~[hibernate-search-util-internal-integrationtest-common-6.2.0-SNAPSHOT.jar:?]
at org.hibernate.search.util.impl.integrationtest.mapper.orm.OrmSetupHelper$SetupContext.setup(OrmSetupHelper.java:194) ~[hibernate-search-util-internal-integrationtest-mapper-orm-6.2.0-SNAPSHOT.jar:?]
at org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT.setup(AbstractMassIndexingErrorIT.java:500) ~[test-classes/:?]
at org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT.entityLoading(AbstractMassIndexingErrorIT.java:93) ~[test-classes/:?]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) ~[?:?]
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?]
at java.lang.reflect.Method.invoke(Method.java:568) ~[?:?]
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59) ~[junit-4.13.2.jar:4.13.2]
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56) ~[junit-4.13.2.jar:4.13.2]
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) ~[junit-4.13.2.jar:4.13.2]
at org.mockito.internal.junit.JUnitSessionStore$1.evaluateSafely(JUnitSessionStore.java:55) ~[mockito-core-4.6.1.jar:?]
at org.mockito.internal.junit.JUnitSessionStore$1.evaluate(JUnitSessionStore.java:43) ~[mockito-core-4.6.1.jar:?]
at org.hibernate.search.util.impl.integrationtest.common.rule.BackendMock$1.evaluate(BackendMock.java:52) ~[hibernate-search-util-internal-integrationtest-common-6.2.0-SNAPSHOT.jar:?]
at org.hibernate.search.util.impl.integrationtest.common.rule.MappingSetupHelper$1.evaluate(MappingSetupHelper.java:74) ~[hibernate-search-util-internal-integrationtest-common-6.2.0-SNAPSHOT.jar:?]
at org.hibernate.search.util.impl.integrationtest.common.TestConfigurationProvider$1.evaluate(TestConfigurationProvider.java:45) ~[hibernate-search-util-internal-integrationtest-common-6.2.0-SNAPSHOT.jar:?]
at org.hibernate.search.util.impl.integrationtest.common.rule.ThreadSpy$1.evaluate(ThreadSpy.java:42) ~[hibernate-search-util-internal-integrationtest-common-6.2.0-SNAPSHOT.jar:?]
at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner.run(ParentRunner.java:413) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.Suite.runChild(Suite.java:128) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.Suite.runChild(Suite.java:27) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) ~[junit-4.13.2.jar:4.13.2]
at org.junit.runners.ParentRunner.run(ParentRunner.java:413) ~[junit-4.13.2.jar:4.13.2]
at org.apache.maven.surefire.junitcore.JUnitCore.run(JUnitCore.java:55) ~[surefire-junit47-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:137) ~[surefire-junit47-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:107) ~[surefire-junit47-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:83) ~[surefire-junit47-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:75) ~[surefire-junit47-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:158) ~[surefire-junit47-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:456) ~[surefire-booter-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:169) ~[surefire-booter-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:595) ~[surefire-booter-3.0.0-M7.jar:3.0.0-M7]
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:581) ~[surefire-booter-3.0.0-M7.jar:3.0.0-M7]
Caused by: java.sql.SQLSyntaxErrorException: ORA-00942: table or view does not exist
at oracle.jdbc.driver.T4CTTIoer11.processError(T4CTTIoer11.java:629) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CTTIoer11.processError(T4CTTIoer11.java:563) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4C8Oall.processError(T4C8Oall.java:1150) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CTTIfun.receive(T4CTTIfun.java:770) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CTTIfun.doRPC(T4CTTIfun.java:298) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4C8Oall.doOALL(T4C8Oall.java:497) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CStatement.doOall8(T4CStatement.java:111) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CStatement.executeForRows(T4CStatement.java:1010) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatement.executeSQLStatement(OracleStatement.java:1530) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1310) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatement.executeInternal(OracleStatement.java:2162) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatement.execute(OracleStatement.java:2117) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatementWrapper.execute(OracleStatementWrapper.java:327) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at org.hibernate.tool.schema.internal.exec.GenerationTargetToDatabase.accept(GenerationTargetToDatabase.java:54) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
... 62 more
Caused by: oracle.jdbc.OracleDatabaseException: ORA-00942: table or view does not exist
at oracle.jdbc.driver.T4CTTIoer11.processError(T4CTTIoer11.java:636) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CTTIoer11.processError(T4CTTIoer11.java:563) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4C8Oall.processError(T4C8Oall.java:1150) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CTTIfun.receive(T4CTTIfun.java:770) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CTTIfun.doRPC(T4CTTIfun.java:298) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4C8Oall.doOALL(T4C8Oall.java:497) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CStatement.doOall8(T4CStatement.java:111) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.T4CStatement.executeForRows(T4CStatement.java:1010) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatement.executeSQLStatement(OracleStatement.java:1530) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1310) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatement.executeInternal(OracleStatement.java:2162) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatement.execute(OracleStatement.java:2117) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at oracle.jdbc.driver.OracleStatementWrapper.execute(OracleStatementWrapper.java:327) ~[ojdbc8-21.6.0.0.1.jar:21.6.0.0.1]
at org.hibernate.tool.schema.internal.exec.GenerationTargetToDatabase.accept(GenerationTargetToDatabase.java:54) ~[hibernate-core-5.6.10.Final.jar:5.6.10.Final]
... 62 more
09:51:13,076 (main) INFO access:48 - HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@4f87b2e0] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
09:51:13,083 (main) INFO JtaPlatformInitiator:52 - HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.JBossStandAloneJtaPlatform]
09:51:13,085 (main) DEBUG PojoMapper:179 - HSEARCH700018: Detected entity types: [HibernateOrmClassRawTypeModel[org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT$Book]], indexed types: [HibernateOrmClassRawTypeModel[org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT$Book]], initial mapped types: [HibernateOrmClassRawTypeModel[org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT$Book]].
09:51:13,085 (main) DEBUG PojoIndexedTypeManagerBuilder:159 - HSEARCH700017: Type manager for indexed type 'org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT$Book':
entityName: Book
typeIdentifier: org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT$Book
indexManager: MappedIndexManagerImpl[implementor=StubIndexManager[Book]]
identifierMapping: PropertyIdentifierMapping[handle=MethodHandleValueReadHandle[public java.lang.Integer org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT$Book.getId()], bridgeHolder=SimpleBeanHolder[instance=DefaultIntegerBridge]]
documentRouter: org.hibernate.search.mapper.pojo.bridge.runtime.impl.NoOpDocumentRouter@5a466dd
processor:
operation: process type
objectFieldsToCreate:
nested:
- operation: process property
handle: MethodHandleValueReadHandle[public java.lang.String org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT$Book.getAuthor()]
nested:
operation: apply value bridge
bridge: SimpleBeanHolder[instance=DefaultStringBridge]
indexField: StubIndexFieldReference[author]
- operation: process property
handle: MethodHandleValueReadHandle[public java.lang.String org.hibernate.search.integrationtest.mapper.orm.massindexing.AbstractMassIndexingErrorIT$Book.getTitle()]
nested:
operation: apply value bridge
bridge: SimpleBeanHolder[instance=DefaultStringBridge]
indexField: StubIndexFieldReference[title]
isEntityType: true
reindexingResolver:
operation: root
dirtyPathsTriggeringSelfReindexing: [author, title]
containingEntitiesResolverRoot:
operation: no op
09:51:13,086 (main) DEBUG ConfiguredAutomaticIndexingStrategy:119 - Hibernate Search event listeners deactivated
09:51:13,568 (Hibernate Search - Mass indexing - Book - ID loading - 0) DEBUG HibernateOrmMassIdentifierLoader:444 - going to fetch 1499 primary keys
09:51:13,571 (Hibernate Search - Mass indexing - Book - ID loading - 0) INFO PojoMassIndexingLoggingMonitor:92 - HSEARCH000027: Mass indexing is going to index 1499 entities.
09:51:13,591 (Hibernate Search - Mass indexing - Workspace - 0) DEBUG CancellableExecutionCompletableFuture:45 - Could not cancel Future java.util.concurrent.FutureTask@8a185d3[Completed normally] (mayInterruptIfRunning = true)
09:51:13,594 (Hibernate Search - Mass indexing - Book - ID loading - 0) WARN SqlExceptionHelper:137 - SQL Error: 17002, SQLState: 08006
09:51:13,594 (Hibernate Search - Mass indexing - Book - ID loading - 0) ERROR SqlExceptionHelper:142 - IO Error: Socket read interrupted
09:51:13,696 (main) INFO SchemaDropperImpl$DelayedDropActionImpl:538 - HHH000477: Starting delayed evictData of schema as part of SessionFactory shut-down'
09:51:13,697 (main) INFO access:48 - HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@4111a657] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
09:51:13,717 (main) INFO pooling:550 - HHH10001008: Cleaning up connection pool [jdbc:oracle:thin:@localhost:1521/XE]
( https://hibernate.atlassian.net/browse/HSEARCH-4670#add-comment?atlOrigin... ) Add Comment ( https://hibernate.atlassian.net/browse/HSEARCH-4670#add-comment?atlOrigin... )
Get Jira notifications on your phone! Download the Jira Cloud app for Android ( https://play.google.com/store/apps/details?id=com.atlassian.android.jira.... ) or iOS ( https://itunes.apple.com/app/apple-store/id1006972087?pt=696495&ct=EmailN... ) This message was sent by Atlassian Jira (v1001.0.0-SNAPSHOT#100204- sha1:2e7ea99 )
1 year, 8 months
[JIRA] (HSEARCH-4669) Provide contextual information about the projection definition when it cannot be applied to an index
by Yoann Rodière (JIRA)
Yoann Rodière ( https://hibernate.atlassian.net/secure/ViewProfile.jspa?accountId=557058%... ) *created* an issue
Hibernate Search ( https://hibernate.atlassian.net/browse/HSEARCH?atlOrigin=eyJpIjoiNGQ2NGM2... ) / Improvement ( https://hibernate.atlassian.net/browse/HSEARCH-4669?atlOrigin=eyJpIjoiNGQ... ) HSEARCH-4669 ( https://hibernate.atlassian.net/browse/HSEARCH-4669?atlOrigin=eyJpIjoiNGQ... ) Provide contextual information about the projection definition when it cannot be applied to an index ( https://hibernate.atlassian.net/browse/HSEARCH-4669?atlOrigin=eyJpIjoiNGQ... )
Issue Type: Improvement Assignee: Unassigned Components: mapper-pojo-base Created: 10/Aug/2022 02:56 AM Fix Versions: 6.2-backlog Priority: Major Reporter: Yoann Rodière ( https://hibernate.atlassian.net/secure/ViewProfile.jspa?accountId=557058%... )
When, in a search query definition, someone calls.select(MyProjectionClass.class) , it’s possible that this class’s @ProjectionConstructor references fields that don’t exist, or are not projectable, and that will lead to an exception being thrown.
That exception includes all the necessary information about the problem to fix (field name, why it cannot be targeted, etc.), but it lacks information about why that problem occurred, i.e. which projection definition could not be applied exactly. That information would be especially useful in the case of nested {{@ProjectionConstructor}}s.
Concretely, this would mean catching SearchException in org.hibernate.search.mapper.pojo.search.definition.impl.PojoConstructorProjectionDefinition#apply and throwing another SearchException with a message such as “Could not apply projection constructor <name>: <message from the cause>”, (of course we’d also use the caught exception as the cause). We may have to tune this a bit to avoid very complicated messages when there are multiple levels of projection constructor nesting.
( https://hibernate.atlassian.net/browse/HSEARCH-4669#add-comment?atlOrigin... ) Add Comment ( https://hibernate.atlassian.net/browse/HSEARCH-4669#add-comment?atlOrigin... )
Get Jira notifications on your phone! Download the Jira Cloud app for Android ( https://play.google.com/store/apps/details?id=com.atlassian.android.jira.... ) or iOS ( https://itunes.apple.com/app/apple-store/id1006972087?pt=696495&ct=EmailN... ) This message was sent by Atlassian Jira (v1001.0.0-SNAPSHOT#100204- sha1:2e7ea99 )
1 year, 8 months
[JIRA] (HSEARCH-4668) Use info level instead of error level when logging compiler/VM version during the build
by Yoann Rodière (JIRA)
Yoann Rodière ( https://hibernate.atlassian.net/secure/ViewProfile.jspa?accountId=557058%... ) *created* an issue
Hibernate Search ( https://hibernate.atlassian.net/browse/HSEARCH?atlOrigin=eyJpIjoiYzRhMzBl... ) / Task ( https://hibernate.atlassian.net/browse/HSEARCH-4668?atlOrigin=eyJpIjoiYzR... ) HSEARCH-4668 ( https://hibernate.atlassian.net/browse/HSEARCH-4668?atlOrigin=eyJpIjoiYzR... ) Use info level instead of error level when logging compiler/VM version during the build ( https://hibernate.atlassian.net/browse/HSEARCH-4668?atlOrigin=eyJpIjoiYzR... )
Issue Type: Task Assignee: Yoann Rodière ( https://hibernate.atlassian.net/secure/ViewProfile.jspa?accountId=557058%... ) Components: build Created: 10/Aug/2022 01:26 AM Fix Versions: 6.2-backlog Priority: Major Reporter: Yoann Rodière ( https://hibernate.atlassian.net/secure/ViewProfile.jspa?accountId=557058%... )
Currently we get things like this:
[INFO] --- exec-maven-plugin:3.1.0:exec (print-java-main-compiler-version) @ hibernate-search-build-config ---
[ERROR] [main] Picked up JAVA_TOOL_OPTIONS: -Dmaven.ext.class.path="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579(a)tmp/withMavenc623f12d/pipeline-maven-spy.jar" -Dorg.jenkinsci.plugins.pipeline.maven.reportsFolder="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579@tmp/withMavenc623f12d"
[INFO] [main] javac 17.0.2
[INFO]
[INFO] --- exec-maven-plugin:3.1.0:exec (print-java-main-compiler-java-version) @ hibernate-search-build-config ---
[ERROR] [main] Picked up JAVA_TOOL_OPTIONS: -Dmaven.ext.class.path="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579(a)tmp/withMavenc623f12d/pipeline-maven-spy.jar" -Dorg.jenkinsci.plugins.pipeline.maven.reportsFolder="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579@tmp/withMavenc623f12d"
[ERROR] [main] openjdk version "17.0.2" 2022-01-18
[ERROR] [main] OpenJDK Runtime Environment Temurin-17.0.2+8 (build 17.0.2+8)
[ERROR] [main] OpenJDK 64-Bit Server VM Temurin-17.0.2+8 (build 17.0.2+8, mixed mode, sharing)
[INFO]
[INFO] --- exec-maven-plugin:3.1.0:exec (print-java-main-release-version) @ hibernate-search-build-config ---
[INFO] [main] Main code compiled with -release 8
[INFO]
[INFO] --- exec-maven-plugin:3.1.0:exec (print-java-test-compiler-version) @ hibernate-search-build-config ---
[ERROR] [main] Picked up JAVA_TOOL_OPTIONS: -Dmaven.ext.class.path="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579(a)tmp/withMavenc623f12d/pipeline-maven-spy.jar" -Dorg.jenkinsci.plugins.pipeline.maven.reportsFolder="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579@tmp/withMavenc623f12d"
[INFO] [main] javac 17.0.2
[INFO]
[INFO] --- exec-maven-plugin:3.1.0:exec (print-java-test-compiler-java-version) @ hibernate-search-build-config ---
[ERROR] [main] Picked up JAVA_TOOL_OPTIONS: -Dmaven.ext.class.path="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579(a)tmp/withMavenc623f12d/pipeline-maven-spy.jar" -Dorg.jenkinsci.plugins.pipeline.maven.reportsFolder="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579@tmp/withMavenc623f12d"
[ERROR] [main] openjdk version "17.0.2" 2022-01-18
[ERROR] [main] OpenJDK Runtime Environment Temurin-17.0.2+8 (build 17.0.2+8)
[ERROR] [main] OpenJDK 64-Bit Server VM Temurin-17.0.2+8 (build 17.0.2+8, mixed mode, sharing)
[INFO]
[INFO] --- exec-maven-plugin:3.1.0:exec (print-java-test-launcher-version) @ hibernate-search-build-config ---
[ERROR] [main] Picked up JAVA_TOOL_OPTIONS: -Dmaven.ext.class.path="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579(a)tmp/withMavenc623f12d/pipeline-maven-spy.jar" -Dorg.jenkinsci.plugins.pipeline.maven.reportsFolder="/var/lib/jenkins/workspace/arch-personal-yoann_HSEARCH-4579@tmp/withMavenc623f12d"
[ERROR] [main] openjdk version "17.0.2" 2022-01-18
[ERROR] [main] OpenJDK Runtime Environment Temurin-17.0.2+8 (build 17.0.2+8)
[ERROR] [main] OpenJDK 64-Bit Server VM Temurin-17.0.2+8 (build 17.0.2+8, mixed mode, sharing)
[INFO]
What we’re logging is obviously not errors, but it’s displayed as such because the version is displayed on stderr.
Maybe we can do something about that, at least for recent JDKs?
( https://hibernate.atlassian.net/browse/HSEARCH-4668#add-comment?atlOrigin... ) Add Comment ( https://hibernate.atlassian.net/browse/HSEARCH-4668#add-comment?atlOrigin... )
Get Jira notifications on your phone! Download the Jira Cloud app for Android ( https://play.google.com/store/apps/details?id=com.atlassian.android.jira.... ) or iOS ( https://itunes.apple.com/app/apple-store/id1006972087?pt=696495&ct=EmailN... ) This message was sent by Atlassian Jira (v1001.0.0-SNAPSHOT#100204- sha1:2e7ea99 )
1 year, 8 months