5 Replies Latest reply on May 14, 2007 5:44 PM by Higi TW

    Issue with JBoss IDE 2.0 Beta with Eclipse 3.2.1

    Manoj P Newbie

      Operating system : OpenSuse 10.2 X86_64
      Java version: JDK 1.5 (1.5.0_10-b03) 64 Bit
      Eclipse version: 3.2.1+ Webtools 1.5.1
      JBoss-IDE version : 2.0 Beta
      JBoss Sever version : jboss-4.0.5.GA

      I setup the Server runtime using the JBoss Inc entry for Jboss 4.0 server. I enabled the Server view to display the JBoss Inc. Server view in Eclipse. I configure it to point to my local JBoss server directory. Then right click and start the server. Server start ups (console displays Server started message)
      but it takes a long time (more than 5-8 mins) for the status to change to Started (says starting) in the server view. Is this normal ? Once the status change to started, right click on sever and say stop and I get the following stack trace message in the console. I have included the server startup log below the stack trace .

      Exception in thread "main" java.lang.SecurityException: Failed to authenticate principal=null, securityDomain=jmx-console
      at org.jboss.jmx.connector.invoker.AuthenticationInterceptor.invoke(AuthenticationInterceptor.java:97)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)
      at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)
      at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)
      at org.jboss.invocation.jrmp.server.JRMPProxyFactory.invoke(JRMPProxyFactory.java:179)
      at sun.reflect.GeneratedMethodAccessor84.invoke(Unknown Source)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:155)
      at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:86)
      at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)
      at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)
      at org.jboss.invocation.jrmp.server.JRMPInvoker$MBeanServerAction.invoke(JRMPInvoker.java:819)
      at org.jboss.invocation.jrmp.server.JRMPInvoker.invoke(JRMPInvoker.java:420)
      at sun.reflect.GeneratedMethodAccessor83.invoke(Unknown Source)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:294)
      at sun.rmi.transport.Transport$1.run(Transport.java:153)
      at java.security.AccessController.doPrivileged(Native Method)
      at sun.rmi.transport.Transport.serviceCall(Transport.java:149)
      at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:466)
      at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:707)
      at java.lang.Thread.run(Thread.java:595)
      at sun.rmi.transport.StreamRemoteCall.exceptionReceivedFromServer(StreamRemoteCall.java:247)
      at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:223)
      at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:126)
      at org.jboss.invocation.jrmp.server.JRMPInvoker_Stub.invoke(Unknown Source)
      at org.jboss.invocation.jrmp.interfaces.JRMPInvokerProxy.invoke(JRMPInvokerProxy.java:133)
      at org.jboss.invocation.InvokerInterceptor.invokeInvoker(InvokerInterceptor.java:365)
      at org.jboss.invocation.InvokerInterceptor.invoke(InvokerInterceptor.java:197)
      at org.jboss.jmx.connector.invoker.client.InvokerAdaptorClientInterceptor.invoke(InvokerAdaptorClientInterceptor.java:66)
      at org.jboss.proxy.SecurityInterceptor.invoke(SecurityInterceptor.java:70)
      at org.jboss.proxy.ClientMethodInterceptor.invoke(ClientMethodInterceptor.java:74)
      at org.jboss.proxy.ClientContainer.invoke(ClientContainer.java:100)
      at $Proxy0.invoke(Unknown Source)
      at org.jboss.Shutdown$ServerProxyHandler.invoke(Shutdown.java:266)
      at $Proxy1.shutdown(Unknown Source)
      at org.jboss.Shutdown.main(Shutdown.java:237)


      JBoss Server Startup log shown in eclipse console follows :

      22:30:06,382 INFO [Server] Starting JBoss (MX MicroKernel)...
      22:30:06,388 INFO [Server] Release ID: JBoss [Zion] 4.0.5.GA (build: CVSTag=Branch_4_0 date=200610162339)
      22:30:06,389 INFO [Server] Home Dir: /work/java-dev/jboss-4.0.5.GA
      22:30:06,389 INFO [Server] Home URL: file:/work/java-dev/jboss-4.0.5.GA/
      22:30:06,390 INFO [Server] Patch URL: null
      22:30:06,391 INFO [Server] Server Name: default
      22:30:06,391 INFO [Server] Server Home Dir: /work/java-dev/jboss-4.0.5.GA/server/default
      22:30:06,391 INFO [Server] Server Home URL: file:/work/java-dev/jboss-4.0.5.GA/server/default/
      22:30:06,424 INFO [Server] Server Log Dir: /work/java-dev/jboss-4.0.5.GA/server/default/log
      22:30:06,425 INFO [Server] Server Temp Dir: /work/java-dev/jboss-4.0.5.GA/server/default/tmp
      22:30:06,454 INFO [Server] Root Deployment Filename: jboss-service.xml
      22:30:08,506 INFO [ServerInfo] Java version: 1.5.0_10,Sun Microsystems Inc.
      22:30:08,507 INFO [ServerInfo] Java VM: Java HotSpot(TM) 64-Bit Server VM 1.5.0_10-b03,Sun Microsystems Inc.
      22:30:08,508 INFO [ServerInfo] OS-System: Linux 2.6.18.2-34-default,amd64
      22:30:11,179 INFO [Server] Core system initialized
      22:30:17,609 INFO [WebService] Using RMI server codebase: http://localhost:8083/
      22:30:17,631 INFO [Log4jService$URLWatchTimerTask] Configuring from URL: resource:log4j.xml
      22:30:27,168 INFO [SocketServerInvoker] Invoker started for locator: InvokerLocator [socket://127.0.0.1:3873/]
      22:30:40,861 INFO [ServiceEndpointManager] WebServices: jbossws-1.0.3.SP1 (date=200609291417)
      22:30:43,073 INFO [SnmpAgentService] SNMP agent going active
      22:30:48,600 INFO [CorbaNamingService] Naming: [IOR:000000000000002B49444C3A6F6D672E6F72672F436F734E616D696E672F4E616D696E67436F6E746578744578743A312E3000000000000200000000000000E0000102000000000A3132372E302E302E31000DC8000000114A426F73732F4E616D696E672F726F6F74000000000000050000000000000008000000004A414300000000010000001C00000000000100010000000105010001000101090000000105010001000000210000005C000000000000000100000000000000240000001C0000007E00000000000000010000000A3132372E302E302E32000DC900400000000000000000001004010008060667810201010100000000000000000000000000000000000000000000002000000004000000000000001F0000000400000003000000010000002000000000000000020000002000000004000000000000001F0000000400000003]
      22:30:49,320 INFO [CorbaTransactionService] TransactionFactory: [IOR:000000000000003049444C3A6F72672F6A626F73732F746D2F69696F702F5472616E73616374696F6E466163746F72794578743A312E30000000000200000000000000E0000102000000000A3132372E302E302E31000DC8000000144A426F73732F5472616E73616374696F6E732F46000000050000000000000008000000004A414300000000010000001C00000000000100010000000105010001000101090000000105010001000000210000005C000000000000000100000000000000240000001C0000007E00000000000000010000000A3132372E302E302E32000DC900400000000000000000001004010008060667810201010100000000000000000000000000000000000000000000002000000004000000000000001F0000000400000003000000010000002000000000000000020000002000000004000000000000001F0000000400000003]
      22:30:53,064 INFO [Embedded] Catalina naming disabled
      22:30:53,124 INFO [ClusterRuleSetFactory] Unable to find a cluster rule set in the classpath. Will load the default rule set.
      22:30:53,127 INFO [ClusterRuleSetFactory] Unable to find a cluster rule set in the classpath. Will load the default rule set.
      22:30:54,729 INFO [Http11BaseProtocol] Initializing Coyote HTTP/1.1 on http-localhost%2F127.0.0.1-8080
      22:30:54,734 INFO [Catalina] Initialization processed in 1606 ms
      22:30:54,735 INFO [StandardService] Starting service jboss.web
      22:30:54,738 INFO [StandardEngine] Starting Servlet Engine: Apache Tomcat/5.5.20
      22:30:54,773 INFO [StandardHost] XML validation disabled
      22:30:54,825 INFO [Catalina] Server startup in 91 ms
      22:30:55,233 INFO [TomcatDeployer] deploy, ctxPath=/invoker, warUrl=.../deploy/http-invoker.sar/invoker.war/
      22:30:55,667 INFO [WebappLoader] Dual registration of jndi stream handler: factory already defined
      22:30:57,953 INFO [TomcatDeployer] deploy, ctxPath=/, warUrl=.../deploy/jbossweb-tomcat55.sar/ROOT.war/
      22:30:59,940 INFO [TomcatDeployer] deploy, ctxPath=/jbossws, warUrl=.../tmp/deploy/tmp12020jbossws-context-exp.war/
      22:31:00,916 INFO [TomcatDeployer] deploy, ctxPath=/jbossmq-httpil, warUrl=.../deploy/jms/jbossmq-httpil.sar/jbossmq-httpil.war/
      22:31:06,775 INFO [TomcatDeployer] deploy, ctxPath=/web-console, warUrl=.../deploy/management/console-mgr.sar/web-console.war/
      22:31:09,677 INFO [MailService] Mail Service bound to java:/Mail
      22:31:11,534 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-local-jdbc.rar
      22:31:11,685 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-xa-jdbc.rar
      22:31:11,710 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-local-jdbc.rar
      22:31:11,895 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-xa-jdbc.rar
      22:31:12,866 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jms/jms-ra.rar
      22:31:13,785 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/mail-ra.rar
      22:31:13,901 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/quartz-ra.rar
      22:31:13,910 INFO [QuartzResourceAdapter] start quartz!!!
      22:31:13,974 INFO [SimpleThreadPool] Job execution threads will use class loader of thread: main
      22:31:14,024 INFO [QuartzScheduler] Quartz Scheduler v.1.5.2 created.
      22:31:14,041 INFO [RAMJobStore] RAMJobStore initialized.
      22:31:14,043 INFO [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
      22:31:14,043 INFO [StdSchedulerFactory] Quartz scheduler version: 1.5.2
      22:31:14,044 INFO [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
      22:31:18,593 INFO [WrapperDataSourceService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS'
      22:31:19,809 INFO [A] Bound to JNDI name: queue/A
      22:31:19,812 INFO [B] Bound to JNDI name: queue/B
      22:31:19,814 INFO [C] Bound to JNDI name: queue/C
      22:31:19,817 INFO [D] Bound to JNDI name: queue/D
      22:31:19,819 INFO [ex] Bound to JNDI name: queue/ex
      22:31:19,841 INFO [testTopic] Bound to JNDI name: topic/testTopic
      22:31:19,844 INFO [securedTopic] Bound to JNDI name: topic/securedTopic
      22:31:19,847 INFO [testDurableTopic] Bound to JNDI name: topic/testDurableTopic
      22:31:19,852 INFO [testQueue] Bound to JNDI name: queue/testQueue
      22:31:20,321 INFO [UILServerILService] JBossMQ UIL service available at : localhost/127.0.0.1:8093
      22:31:21,032 INFO [DLQ] Bound to JNDI name: queue/DLQ
      22:31:21,660 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
      22:31:23,758 INFO [TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/
      22:31:26,895 INFO [Http11BaseProtocol] Starting Coyote HTTP/1.1 on http-localhost%2F127.0.0.1-8080
      22:31:27,907 INFO [ChannelSocket] JK: ajp13 listening on localhost/127.0.0.1:8009
      22:31:28,152 INFO [JkMain] Jk running ID=0 time=0/262 config=null
      22:31:28,270 INFO [Server] JBoss (MX MicroKernel) [4.0.5.GA (build: CVSTag=Branch_4_0 date=200610162339)] Started in 1m:21s:814ms