3 Replies Latest reply on Sep 7, 2011 3:43 AM by hgomez

Error sun.rmi.server.LoaderHandler loadClass

straypet Jan 19, 2011 1:49 PM

Hi,

We have an environment for our customer where we have 1 test server, 1 proof server and 2 production servers. On the proof and production servers we get the following error message over and over and over again. Seems like every 5 seconds...

INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.UnicastRef newCall
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: get connection
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.transport.tcp.TCPChannel createConnection
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: create connection
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.transport.proxy.RMIMasterSocketFactory createSocket
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: host: **.**.**.**, port: 1121
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.transport.tcp.TCPTransport$ConnectionHandler run0
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI TCP Connection(694)-**.**.**.**: accepted socket from [**.**.**.**:3905]
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.transport.tcp.TCPTransport handleMessages
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI TCP Connection(694)-**.**.**.**: (port 1121) op = 80
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI TCP Connection(694)-**.**.**.**: name = "[Ljava.rmi.server.ObjID;", codebase = "http://**.**.**.**:8083/", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI TCP Connection(694)-**.**.**.**: name = "java.rmi.dgc.Lease", codebase = "http://**.**.**.**:8083/", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI TCP Connection(694)-**.**.**.**: name = "java.rmi.dgc.VMID", codebase = "http://**.**.**.**:8083/", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI TCP Connection(694)-**.**.**.**: name = "[B", codebase = "", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI TCP Connection(694)-**.**.**.**: name = "java.rmi.server.UID", codebase = "http://**.**.**.**:8083/", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: name = "java.rmi.dgc.Lease", codebase = "http://**.**.**.**:8083/", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: name = "java.rmi.dgc.VMID", codebase = "http://**.**.**.**:8083/", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: name = "[B", codebase = "", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.LoaderHandler loadClass
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: name = "java.rmi.server.UID", codebase = "http://**.**.**.**:8083/", defaultLoader = sun.misc.Launcher$AppClassLoader@64601bb1
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.server.UnicastRef done
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: free connection (reuse = true)
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.transport.tcp.TCPChannel free
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: reuse connection
INFO   | jvm 1    | 2011/01/19 19:24:45 | 19:24:45,635 ERROR [STDERR] 19.jan.2011 19:24:45 sun.rmi.transport.tcp.TCPChannel free
INFO   | jvm 1    | 2011/01/19 19:24:45 | FINE: RMI RenewClean-[**.**.**.**:1121]: create reaper

Does anybody have any tips on how we can resolve this issue? We have been searching around for ages without any luck.

Best regards,

Petter

1. Error sun.rmi.server.LoaderHandler loadClass

mstruk Jan 19, 2011 4:07 PM (in response to straypet)

There doesn't seem to be anything wrong actually. Appart from the fact that some logging is directed to ERROR logging level probably due to STDERR being used for output. But there's no stacktrace, none of the messages indicates anything is going wrong ...

And you obviously have multiple layers of logging ... Maybe packing log4j + log4j configuration in your .wars?

Actually it looks like you have rmi logging turned on. Check your startup scripts for rmi logging properties:
http://download.oracle.com/javase/1.4.2/docs/guide/rmi/sunrmiproperties.html
Actions
2. Re: Error sun.rmi.server.LoaderHandler loadClass

hgomez Aug 26, 2011 10:06 AM (in response to mstruk)

I'm facing the same problem using Gatein stack.

Did you find a way to remove the log trace ?
Actions
3. Re: Error sun.rmi.server.LoaderHandler loadClass

hgomez Sep 7, 2011 3:43 AM (in response to straypet)

There is a quick fix to the problem :

Edit "server/default/deploy/gatein.ear/02portal.war/WEB-INF/conf/common/logs-configuration.xml" and change FINE by INFO in JDK Logger :


                        <value-param>
                                <name>logger</name>
                                <value>org.exoplatform.services.log.impl.BufferedJdk14Logger</value>
                        </value-param>
                        <value-param>
                                <name>configurator</name>
                                <value>org.exoplatform.services.log.impl.Jdk14Configurator</value>
                        </value-param>
                        <properties-param>
                                <name>properties</name>
                                <description>jdk1.4 Logger properties</description>
                                <property name="handlers" value="java.util.logging.ConsoleHandler"/>
                                <property name=".level" value="FINE"/>
                                <property name="java.util.logging.ConsoleHandler.level" value="FINE"/>
                        </properties-param>
        
Actions

Go to original post