Issue #762: Error on commit

I get the following on commit:  (v2.3.7_15) Let me know if you need more info.

Caused by: com.objectdb.o.InternalException
at com.objectdb.o.InternalException.f(InternalException.java:236) [:]
at com.objectdb.o.SPW.aq(SPW.java:109) [:]
at com.objectdb.o.PGW.am(PGW.java:210) [:]
at com.objectdb.o.UPT.C(UPT.java:134) [:]
at com.objectdb.o.UPT.l(UPT.java:110) [:]
at com.objectdb.o.TSK.i(TSK.java:146) [:]
at com.objectdb.o.TSK.f(TSK.java:95) [:]
at com.objectdb.o.UPT.s(UPT.java:157) [:]
at com.objectdb.o.PGT.q(PGT.java:109) [:]
at com.objectdb.o.UPT.C(UPT.java:121) [:]
at com.objectdb.o.URT.l(URT.java:171) [:]
at com.objectdb.o.TSK.i(TSK.java:146) [:]
at com.objectdb.o.TSK.f(TSK.java:95) [:]
at com.objectdb.o.TSM.e(TSM.java:87) [:]
at com.objectdb.o.UTT.z(UTT.java:365) [:]
at com.objectdb.o.UTT.l(UTT.java:218) [:]
at com.objectdb.o.TSK.i(TSK.java:146) [:]
at com.objectdb.o.TSK.f(TSK.java:95) [:]
at com.objectdb.o.TSM.e(TSM.java:87) [:]
at com.objectdb.o.MST.Vb(MST.java:1293) [:]
at com.objectdb.o.WRA.Vb(WRA.java:369) [:]
at com.objectdb.o.WSM.Vb(WSM.java:174) [:]
at com.objectdb.o.STC.v(STC.java:511) [:]
at com.objectdb.o.SHN.an(SHN.java:563) [:]
at com.objectdb.o.SHN.K(SHN.java:170) [:]
at com.objectdb.o.HND.run(HND.java:133) [:]
... 1 more

Please use the ObjectDB Doctor to check the database and post the report.

It repeats the following for every class in the db:

[2012-04-20 13:29:50 #103 type.loader]
java.lang.ClassNotFoundException: com.***.pdm.common.persistence.ObjectState
at java.net.URLClassLoader$1.run(URLClassLoader.java:202)
at java.security.AccessController.doPrivileged(Native Method)
at java.net.URLClassLoader.findClass(URLClassLoader.java:190)
at java.lang.ClassLoader.loadClass(ClassLoader.java:306)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:301)
at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
at com.objectdb.o.RCL.j(RCL.java:299)
at com.objectdb.o.ACL.loadClass(ACL.java:101)
at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
at com.objectdb.o.TYM.ax(TYM.java:1001)
at com.objectdb.o.UTY.initSysType(UTY.java:327)
at com.objectdb.o.TYS.l(TYS.java:163)
at com.objectdb.o.TYM.ad(TYM.java:502)
at com.objectdb.o.TYM.<init>(TYM.java:239)
at com.objectdb.o.MST.aK(MST.java:179)
at com.objectdb.o.DMR.D(DMR.java:251)
at com.objectdb.o.DMR.B(DMR.java:163)
at com.objectdb.Doctor.main(Doctor.java:22)

[2012-04-20 13:29:50 #104 type.loader]
java.lang.ClassNotFoundException: java.lang.com.***.pdm.common.persistence.ObjectState
at java.net.URLClassLoader$1.run(URLClassLoader.java:202)
at java.security.AccessController.doPrivileged(Native Method)
at java.net.URLClassLoader.findClass(URLClassLoader.java:190)
at java.lang.ClassLoader.loadClass(ClassLoader.java:306)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:301)
at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
at com.objectdb.o.RCL.j(RCL.java:329)
at com.objectdb.o.ACL.loadClass(ACL.java:101)
at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
at com.objectdb.o.TYM.ax(TYM.java:1001)
at com.objectdb.o.UTY.initSysType(UTY.java:327)
at com.objectdb.o.TYS.l(TYS.java:163)
at com.objectdb.o.TYM.ad(TYM.java:502)
at com.objectdb.o.TYM.<init>(TYM.java:239)
at com.objectdb.o.MST.aK(MST.java:179)
at com.objectdb.o.DMR.D(DMR.java:251)
at com.objectdb.o.DMR.B(DMR.java:163)
at com.objectdb.Doctor.main(Doctor.java:22)

[2012-04-20 13:29:50 #105 type.loader]
Building a synthetic Class for com.***.pdm.common.persistence.ObjectState

Then I get the following:

Scanning the database file...
.................................................. 100MB
.................................................. 200MB
.................................................. 300MB
.................................................. 400MB
.................................................. 500MB
.................................................. 600MB
.................................................. 700MB
............................................ 790MB (total)

Analyzing database structure...
10% 20% 30% 40% 50% 60% 70% 80% 90% 100%

-------------------------
No errors have been found
-------------------------

The database seems to be healthy. These stack traces are normal when using DEBUG level logging.

As the result of the exception in #1 you should have in the log file lines such as:

BTree ID:
BTree Name:
BTree Page:
Request code:
...

Please post them.

I re-ran to get a clean log file and the doctor must have fixed it. (possible index issue?)

This is from the original odbYYYYMMDD.log file:

(*** = Employer public forum policy)

[2012-04-20 11:56:07 #200 store]
*** Attempt to remove a non existing index entry:

[2012-04-20 11:56:07 #201 store]
BTree ID: -108

[2012-04-20 11:56:07 #202 store]
BTree Name: com.***.***.***.***.businessObjects.***[m_***Number]

[2012-04-20 11:56:07 #203 store]
BTree Page: 402548

[2012-04-20 11:56:07 #204 store]
Request code: 4

[2012-04-20 11:56:07 #205 store]
Request Key: 6142

[2012-04-20 11:56:07 #206 store]
Request Key Code: -11

[2012-04-20 11:56:07 #207 store]
Request Real Key: 6142

[2012-04-20 11:56:07 #208 store]
Request Real Key Code: -11

[2012-04-20 11:56:07 #209 store]
Request Small Key: 6142

[2012-04-20 11:56:07 #210 store]
Request Small Key Code: -11

[2012-04-20 11:56:07 #211 store]
Request Value: 25:1411611

[2012-04-20 11:56:07 #212 server]
[ObjectDB 2.3.7_15] Unexpected exception (Error 990)
  Generated by Java HotSpot(TM) 64-Bit Server VM 1.6.0_26 (on Windows XP 5.2).
Please report this error on http://www.objectdb.com/database/issue/new
com.objectdb.o.InternalException: null
com.objectdb.o.InternalException
at com.objectdb.o.InternalException.f(InternalException.java:236)
at com.objectdb.o.SPW.aq(SPW.java:109)
at com.objectdb.o.PGW.am(PGW.java:210)
at com.objectdb.o.UPT.C(UPT.java:134)
at com.objectdb.o.UPT.l(UPT.java:110)
at com.objectdb.o.TSK.i(TSK.java:146)
at com.objectdb.o.TSK.f(TSK.java:95)
at com.objectdb.o.UPT.s(UPT.java:157)
at com.objectdb.o.PGT.q(PGT.java:109)
at com.objectdb.o.UPT.C(UPT.java:121)
at com.objectdb.o.URT.l(URT.java:171)
at com.objectdb.o.TSK.i(TSK.java:146)
at com.objectdb.o.TSK.f(TSK.java:95)
at com.objectdb.o.TSM.e(TSM.java:87)
at com.objectdb.o.UTT.z(UTT.java:365)
at com.objectdb.o.UTT.l(UTT.java:218)
at com.objectdb.o.TSK.i(TSK.java:146)
at com.objectdb.o.TSK.f(TSK.java:95)
at com.objectdb.o.TSM.e(TSM.java:87)
at com.objectdb.o.MST.Vb(MST.java:1293)
at com.objectdb.o.WRA.Vb(WRA.java:369)
at com.objectdb.o.WSM.Vb(WSM.java:174)
at com.objectdb.o.STC.v(STC.java:511)
at com.objectdb.o.SHN.an(SHN.java:563)
at com.objectdb.o.SHN.K(SHN.java:170)
at com.objectdb.o.HND.run(HND.java:133)
at java.lang.Thread.run(Thread.java:662)

----------------------------------------------------------------

The stack trace indicates an index problem and that problem may be solved by running the Doctor in fix mode, but not by running it in diagnosis mode.

Anyway, since the problem is solved and there is no way to reproduce it now I will close the issue. Please reopen it if you get that exception again.