Issue #2403: Unexpected not reproducable exception during commit

Hello,

do you know why we get the following exception?

best regards

BTC

2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION: com.btc.ep.profilemigration.application.services.ProfileMigrationException: Migration fails!
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.btc.ep.profilemigration.application.internal.services.ProfileMigrationImpl.do_migrateProfile(ProfileMigrationImpl.java:223)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.btc.ep.profilemigration.application.internal.services.ProfileMigrationImpl.migrateProfile(ProfileMigrationImpl.java:142)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.btc.ep.profilemigration.application.internal.ProfileMigrationApplication.commandMigration(ProfileMigrationApplication.java:208)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.btc.ep.profilemigration.application.internal.ProfileMigrationApplication.start(ProfileMigrationApplication.java:135)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:196)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:134)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:104)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:388)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:243)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at java.lang.reflect.Method.invoke(Method.java:498)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:653)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at org.eclipse.equinox.launcher.Main.basicRun(Main.java:590)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at org.eclipse.equinox.launcher.Main.run(Main.java:1499)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION: Caused by: com.objectdb.o._RollbackException: Failed to commit transaction:
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.JPE.d(JPE.java:91)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.ERR.h(ERR.java:56)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.OBC.onObjectDBError(OBC.java:1582)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.jpa.EMImpl.commit(EMImpl.java:289)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.btc.ep.profilemigration.migrators.architecture.ArchitectureInterfaceMigrator.migrate(ArchitectureInterfaceMigrator.java:182)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.btc.ep.profilemigration.application.internal.services.ProfileMigrationImpl.callMigrators(ProfileMigrationImpl.java:239)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.btc.ep.profilemigration.application.internal.services.ProfileMigrationImpl.do_migrateProfile(ProfileMigrationImpl.java:212)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     ... 15 more
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION: Caused by: com.objectdb.o.InternalException
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.InternalException.f(InternalException.java:235)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.SPW.ad(SPW.java:174)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.PGW.ak(PGW.java:212)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.UPT.s(UPT.java:135)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.URT.g(URT.java:173)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.TSK.b(TSK.java:146)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.TSK.c(TSK.java:96)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.TSM.a(TSM.java:88)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.UTT.r(UTT.java:377)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.UTT.g(UTT.java:225)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.TSK.b(TSK.java:146)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.TSK.c(TSK.java:96)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.TSM.a(TSM.java:88)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.MST.Y4(MST.java:1421)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.WRA.Y4(WRA.java:398)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.WSM.Y4(WSM.java:186)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.OBM.aP(OBM.java:959)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.OBM.aS(OBM.java:859)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.o.OBM.aG(OBM.java:759)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     at com.objectdb.jpa.EMImpl.commit(EMImpl.java:286)
2019-02-07 04:22:53 - [main] ERROR com.btc.ep.base.dal.MigrationUtility - PROFILE MIGRATION:     ... 18 more

An unexpected internal ObjectDB exception was thrown during commit:

com.objectdb.o.InternalException
at com.objectdb.o.InternalException.f(InternalException.java:235)
at com.objectdb.o.SPW.ad(SPW.java:174)
at com.objectdb.o.PGW.ak(PGW.java:212)
at com.objectdb.o.UPT.s(UPT.java:135)
at com.objectdb.o.URT.g(URT.java:173)
at com.objectdb.o.TSK.b(TSK.java:146)
at com.objectdb.o.TSK.c(TSK.java:96)
at com.objectdb.o.TSM.a(TSM.java:88)
at com.objectdb.o.UTT.r(UTT.java:377)
at com.objectdb.o.UTT.g(UTT.java:225)
at com.objectdb.o.TSK.b(TSK.java:146)
at com.objectdb.o.TSK.c(TSK.java:96)
at com.objectdb.o.TSM.a(TSM.java:88)
at com.objectdb.o.MST.Y4(MST.java:1421)
at com.objectdb.o.WRA.Y4(WRA.java:398)
at com.objectdb.o.WSM.Y4(WSM.java:186)
at com.objectdb.o.OBM.aP(OBM.java:959)
at com.objectdb.o.OBM.aS(OBM.java:859)
at com.objectdb.o.OBM.aG(OBM.java:759)
at com.objectdb.jpa.EMImpl.commit(EMImpl.java:286)

The exact cause is unclear, but it happens during index update when an attempt to insert a new (key,value) to the index finds that pair of (key,value) already in the index, and it is considered to be an unexpected state.

If you can provide more information about this error it could help. If you can repeat the error we can release a new build that will log relevant information to the log when this exception is thrown, for further diagnosis.

Hello,

unfortunately we cannot reproduce this issue.

Thank you for the hints.

best regards

BTC

We can release a new build that will log relevant information to the log when this exception is thrown, for further diagnosis, if it happens again.

Build 2.7.6_02 was released with additional logging for this case. If this exception is thrown again you should be able to find more information in the log file. Thank you for this report.