C:\Programme\JBoss_404\bin>run -c vfm
Could not locate C:\Programmierung\JDK_1506\jre\lib\tools.jar. Unexpected results may occur.
Make sure that JAVA_HOME points to a JDK and not a JRE.
===============================================================================
.
JBoss Bootstrap Environment
.
JBOSS_HOME: C:\Programme\JBoss_404\bin\\..
.
JAVA: C:\Programmierung\JDK_1506\jre\bin\java
.
JAVA_OPTS: -Dprogram.name=run.bat -Xms128m -Xmx512m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000
.
CLASSPATH: C:\Programmierung\JDK_1506\jre\lib\tools.jar;C:\Programme\JBoss_404\bin\\run.jar
.
===============================================================================
.
14:35:46,415 INFO [Server] Starting JBoss (MX MicroKernel)...
14:35:46,415 INFO [Server] Release ID: JBoss [Zion] 4.0.4.GA (build: CVSTag=JBoss_4_0_4_GA date=200605151000)
14:35:46,425 INFO [Server] Home Dir: C:\Programme\JBoss_404
14:35:46,425 INFO [Server] Home URL: file:/C:/Programme/JBoss_404/
14:35:46,425 INFO [Server] Patch URL: null
14:35:46,425 INFO [Server] Server Name: vfm
14:35:46,425 INFO [Server] Server Home Dir: C:\Programme\JBoss_404\server\vfm
14:35:46,425 INFO [Server] Server Home URL: file:/C:/Programme/JBoss_404/server/vfm/
14:35:46,425 INFO [Server] Server Log Dir: C:\Programme\JBoss_404\server\vfm\log
14:35:46,425 INFO [Server] Server Temp Dir: C:\Programme\JBoss_404\server\vfm\tmp
14:35:46,425 INFO [Server] Root Deployment Filename: jboss-service.xml
14:35:47,006 INFO [ServerInfo] Java version: 1.5.0_06,Sun Microsystems Inc.
14:35:47,006 INFO [ServerInfo] Java VM: Java HotSpot(TM) Client VM 1.5.0_06-b05,Sun Microsystems Inc.
14:35:47,006 INFO [ServerInfo] OS-System: Windows XP 5.1,x86
14:35:47,607 INFO [Server] Core system initialized
14:35:49,920 INFO [Log4jService$URLWatchTimerTask] Configuring from URL: resource:log4j.xml
14:35:58,793 INFO [SnmpAgentService] SNMP agent going active
14:36:01,066 INFO [AspectDeployer] Deployed AOP: file:/C:/Programme/JBoss_404/server/vfm/deploy/tc5-cluster.sar/tc5-cluster.aop
14:36:01,317 INFO [TreeCache] setting cluster properties from xml to: UDP(down_thread=false;enable_bundling=true;ip_ttl=2;loopback=fal
se;max_bundle_size=64000;max_bundle_timeout=30;mcast_addr=230.1.2.7;mcast_port=45577;mcast_recv_buf_size=25000000;mcast_send_buf_size=6
40000;ucast_recv_buf_size=20000000;ucast_send_buf_size=640000;up_thread=false;use_incoming_packet_handler=true;use_outgoing_packet_hand
ler=true):PING(down_thread=false;num_initial_members=3;timeout=2000;up_thread=false):MERGE2(down_thread=false;max_interval=100000;min_i
nterval=20000;up_thread=false):FD(down_thread=false;max_tries=5;shun=true;timeout=2500;up_thread=false):VERIFY_SUSPECT(down_thread=fals
e;timeout=1500;up_thread=false):pbcast.NAKACK(discard_delivered_msgs=true;down_thread=false;gc_lag=50;max_xmit_size=60000;retransmit_ti
meout=100,200,300,600,1200,2400,4800;up_thread=false;use_mcast_xmit=false):UNICAST(down_thread=false;timeout=300,600,1200,2400,3600;up_
thread=false):pbcast.STABLE(desired_avg_gossip=50000;down_thread=false;max_bytes=2100000;stability_delay=1000;up_thread=false):pbcast.G
MS(down_thread=false;join_retry_timeout=2000;join_timeout=3000;print_local_addr=true;shun=true;up_thread=false):FC(down_thread=false;ma
x_credits=10000000;min_threshold=0.20;up_thread=false):FRAG2(down_thread=false;frag_size=60000;up_thread=false):pbcast.STATE_TRANSFER(d
own_thread=false;up_thread=false)
14:36:02,548 INFO [WebService] Using RMI server codebase: http://joeslaptop:8083/
14:36:08,126 INFO [MailService] Mail Service bound to java:/Mail
14:36:08,837 INFO [DefaultPartition] Initializing
14:36:09,128 INFO [TreeCache] interceptor chain is:
class org.jboss.cache.interceptors.CallInterceptor
class org.jboss.cache.interceptors.PessimisticLockInterceptor
class org.jboss.cache.interceptors.UnlockInterceptor
class org.jboss.cache.interceptors.ReplicationInterceptor
14:36:09,128 INFO [TreeCache] cache mode is REPL_ASYNC
14:36:09,879 INFO [NamingService] JNDI bootstrap JNP=/0.0.0.0:1099, RMI=/0.0.0.0:1098, backlog=50, no client SocketFactory, Server Soc
ketFactory=class org.jboss.net.sockets.DefaultSocketFactory
14:36:09,969 INFO [SubscriptionManager] Bound event dispatcher to java:/EventDispatcher
14:36:10,089 INFO [STDOUT]
-------------------------------------------------------
GMS: address is joeslaptop:2111 (additional data: 18 bytes)
-------------------------------------------------------
14:36:12,112 INFO [DefaultPartition] Number of cluster members: 1
14:36:12,112 INFO [DefaultPartition] Other members: 0
14:36:12,122 INFO [DefaultPartition] New cluster view for partition DefaultPartition (id: 0, delta: 0) : [192.168.2.100:1099]
14:36:12,132 INFO [DefaultPartition] Fetching state (will wait for 30000 milliseconds):
14:36:12,162 INFO [DefaultPartition] I am (192.168.2.100:1099) received membershipChanged event:
14:36:12,162 INFO [DefaultPartition] Dead members: 0 ([])
14:36:12,162 INFO [DefaultPartition] New Members : 0 ([])
14:36:12,162 INFO [DefaultPartition] All Members : 1 ([192.168.2.100:1099])
14:36:12,242 INFO [HANamingService] Started ha-jndi bootstrap jnpPort=1100, backlog=50, bindAddress=/0.0.0.0
14:36:12,252 INFO [DetachedHANamingService$AutomaticDiscovery] Listening on /0.0.0.0:1102, group=230.0.0.4, HA-JNDI address=192.168.2.
100:1100
14:36:12,553 ERROR [STDERR] [ jacorb.home unset! Will use '.' ]
14:36:12,553 ERROR [STDERR] [ File .\jacorb.properties for configuration jacorb not found ]
14:36:12,553 INFO [STDOUT] [ configuration jacorb loaded from classpath]
14:36:13,184 INFO [interceptors] InterceptorManager started with 2 SIs, 2 CIs and 4 IORIs
14:36:13,444 INFO [orb] ORB run
14:36:13,504 INFO [poa] oid:
72 6F 6F 74 root
object is activated
14:36:14,095 INFO [CorbaNamingService] Naming: [IOR:000000000000002B49444C3A6F6D672E6F72672F436F734E616D696E672F4E616D696E67436F6E7465
78744578743A312E3000000000000200000000000000D8000102000000000E3139322E3136382E322E313030000DC8000000114A426F73732F4E616D696E672F726F6F7
4000000000000050000000000000008000000004A414300000000010000001C000000000001000100000001050100010001010900000001050100010000002100000050
00000000000000010000000000000024000000200000007E00000000000000010000000E3139322E3136382E322E313030000DC90000000000000000000000000000000
00000000000000000000000000000002000000004000000000000001F000000040000000300000001000000200000000000000002000000200000000400000000000000
1F0000000400000003]
14:36:14,395 INFO [STDOUT]
-------------------------------------------------------
GMS: address is joeslaptop:2113
-------------------------------------------------------
14:36:16,408 INFO [TreeCache] viewAccepted(): [joeslaptop:2113|0] [joeslaptop:2113]
14:36:16,418 INFO [TreeCache] my local address is joeslaptop:2113
14:36:16,418 INFO [TreeCache] state could not be retrieved (must be first member in group)
14:36:16,418 INFO [TreeCache] Cache is started!!
14:36:16,428 INFO [TreeCache] new cache is null (may be first member in cluster)
14:36:16,548 INFO [giop] ClientConnectionManager: created new ClientGIOPConnection to 192.168.2.100:3528 (10ab78a)
14:36:16,639 INFO [iiop] Connected to 192.168.2.100:3528 from local port 2115
14:36:16,649 INFO [iiop] Opened new server-side TCP/IP transport to 192.168.2.100:2115
14:36:16,719 INFO [naming] re-Bound name: TransactionService
14:36:16,719 INFO [CorbaTransactionService] TransactionFactory: [IOR:000000000000003049444C3A6F72672F6A626F73732F746D2F69696F702F54726
16E73616374696F6E466163746F72794578743A312E30000000000200000000000000D8000102000000000E3139322E3136382E322E313030000DC8000000144A426F73
732F5472616E73616374696F6E732F46000000050000000000000008000000004A414300000000010000001C00000000000100010000000105010001000101090000000
105010001000000210000005000000000000000010000000000000024000000200000007E00000000000000010000000E3139322E3136382E322E313030000DC9000000
000000000000000000000000000000000000000000000000000000002000000004000000000000001F00000004000000030000000100000020000000000000000200000
02000000004000000000000001F0000000400000003]
14:36:16,729 INFO [naming] re-Bound name: UserTransaction
14:36:18,001 INFO [Embedded] Catalina naming disabled
14:36:18,081 INFO [ClusterRuleSetFactory] Unable to find a cluster rule set in the classpath. Will load the default rule set.
14:36:18,081 INFO [ClusterRuleSetFactory] Unable to find a cluster rule set in the classpath. Will load the default rule set.
14:36:18,531 INFO [Http11BaseProtocol] Initializing Coyote HTTP/1.1 on http-0.0.0.0-8080
14:36:18,531 INFO [Catalina] Initialization processed in 450 ms
14:36:18,531 INFO [StandardService] Starting service jboss.web
14:36:18,541 INFO [StandardEngine] Starting Servlet Engine: Apache Tomcat/5.5.17
14:36:18,601 INFO [StandardHost] XML validation disabled
14:36:18,621 INFO [Catalina] Server startup in 90 ms
14:36:19,022 INFO [TomcatDeployer] deploy, ctxPath=/invoker, warUrl=.../deploy/http-invoker.sar/invoker.war/
14:36:19,513 INFO [WebappLoader] Dual registration of jndi stream handler: factory already defined
14:36:20,594 INFO [TomcatDeployer] deploy, ctxPath=/, warUrl=.../deploy/jbossweb-tomcat55.sar/ROOT.war/
14:36:20,925 INFO [TomcatDeployer] deploy, ctxPath=/jbossws, warUrl=.../tmp/deploy/tmp14131jbossws-exp.war/
14:36:21,275 INFO [TomcatDeployer] deploy, ctxPath=/jbossmq-httpil, warUrl=.../deploy/jms/jbossmq-httpil.sar/jbossmq-httpil.war/
14:36:21,706 INFO [TomcatDeployer] deploy, ctxPath=/web-console, warUrl=.../deploy/management/console-mgr.sar/web-console.war/
14:36:23,188 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-local-jdbc.rar
14:36:23,288 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-xa-jdbc.rar
14:36:23,408 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-local-jdbc.rar
14:36:23,539 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-xa-jdbc.rar
14:36:23,659 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jms/jms-ra.rar
14:36:23,759 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/mail-ra.rar
14:36:25,011 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JN
DI name 'java:DefaultDS'
14:36:25,431 INFO [A] Bound to JNDI name: queue/A
14:36:25,441 INFO [B] Bound to JNDI name: queue/B
14:36:25,451 INFO [C] Bound to JNDI name: queue/C
14:36:25,461 INFO [D] Bound to JNDI name: queue/D
14:36:25,471 INFO [ex] Bound to JNDI name: queue/ex
14:36:25,521 INFO [testTopic] Bound to JNDI name: topic/testTopic
14:36:25,531 INFO [securedTopic] Bound to JNDI name: topic/securedTopic
14:36:25,541 INFO [testDurableTopic] Bound to JNDI name: topic/testDurableTopic
14:36:25,551 INFO [testQueue] Bound to JNDI name: queue/testQueue
14:36:26,082 INFO [UILServerILService] JBossMQ UIL service available at : /0.0.0.0:8093
14:36:26,172 INFO [DLQ] Bound to JNDI name: queue/DLQ
14:36:26,543 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to
JNDI name 'java:JmsXA'
14:36:26,843 INFO [EjbModule] Deploying VFMSession
14:36:27,024 INFO [EjbModule] Deploying VFMController
14:36:28,766 INFO [giop] ClientConnectionManager: created new ClientGIOPConnection to 192.168.2.100:3528 (69b25f)
14:36:28,816 INFO [vfmcontroller/VFMSession] EJBHome reference for vfmcontroller/VFMSession:
IOR:000000000000003D524D493A76666D636F6E74726F6C6C65722E76666D73657373696F6E2E56464D53657373696F6E486F6D653A303030303030303030303030303
03030000000000000000200000000000000E4000102000000000E3139322E3136382E322E313030000DC80000002E4A426F73732F454A42486F6D65262576666D636F6E
74726F6C6C6572262556464D53657373696F6E2FACED0005700000000000050000000000000008000000004A414300000000010000001C0000000000010001000000010
501000100010109000000010501000100000019000000400000000000000038687474703A2F2F6A6F65736C6170746F703A383038332F576562434C5B76666D636F6E74
726F6C6C65722F56464D53657373696F6E5D2F000000002000000004000000000000001F000000040000000300000001000000680000000000000003000000190000004
00000000000000038687474703A2F2F6A6F65736C6170746F703A383038332F576562434C5B76666D636F6E74726F6C6C65722F56464D53657373696F6E5D2F00000000
2000000004000000000000001F0000000400000003
14:36:28,816 INFO [vfmcontroller/VFMSession] Home IOR for VFMSession bound to vfmcontroller/VFMSession in JNP naming service
14:36:28,866 INFO [poa] oid:
72 6F 6F 74 2F 63 74 78 31 root/ctx1
object is activated
14:36:28,866 INFO [naming] Bound context: vfmcontroller
14:36:28,876 INFO [giop] ClientConnectionManager: found ClientGIOPConnection to 192.168.2.100:3528 (10ab78a)
14:36:28,886 INFO [naming] re-Bound name: VFMSession
14:36:28,886 INFO [vfmcontroller/VFMSession] Home IOR for VFMSession bound to vfmcontroller/VFMSession in CORBA naming service
14:36:28,946 INFO [giop] ClientConnectionManager: found ClientGIOPConnection to 192.168.2.100:3528 (69b25f)
14:36:28,956 INFO [vfmcontroller/VFMController] EJBHome reference for vfmcontroller/VFMController:
IOR:0000000000000035524D493A76666D636F6E74726F6C6C65722E56464D436F6E74726F6C6C6572486F6D653A3030303030303030303030303030303000000000000
0000200000000000000EC000102000000000E3139322E3136382E322E313030000DC8000000314A426F73732F454A42486F6D65262576666D636F6E74726F6C6C657226
2556464D436F6E74726F6C6C65722FACED000570000000000000050000000000000008000000004A414300000000010000001C000000000001000100000001050100010
001010900000001050100010000001900000043000000000000003B687474703A2F2F6A6F65736C6170746F703A383038332F576562434C5B76666D636F6E74726F6C6C
65722F56464D436F6E74726F6C6C65725D2F00000000002000000004000000000000001F0000000400000003000000010000006C0000000000000003000000190000004
3000000000000003B687474703A2F2F6A6F65736C6170746F703A383038332F576562434C5B76666D636F6E74726F6C6C65722F56464D436F6E74726F6C6C65725D2F00
000000002000000004000000000000001F0000000400000003
14:36:28,956 INFO [vfmcontroller/VFMController] Home IOR for VFMController bound to vfmcontroller/VFMController in JNP naming service
14:36:28,976 INFO [giop] ClientConnectionManager: found ClientGIOPConnection to 192.168.2.100:3528 (10ab78a)
14:36:28,976 INFO [giop] ClientConnectionManager: found ClientGIOPConnection to 192.168.2.100:3528 (10ab78a)
14:36:28,986 INFO [naming] re-Bound name: VFMController
14:36:28,996 INFO [vfmcontroller/VFMController] Home IOR for VFMController bound to vfmcontroller/VFMController in CORBA naming service
14:36:29,016 INFO [EJBDeployer] Deployed: file:/C:/Programme/JBoss_404/server/vfm/deploy/VFMController-ejb.jar
14:36:30,218 INFO [TomcatDeployer] deploy, ctxPath=/VFMController, warUrl=.../tmp/deploy/tmp14177VFMController-war-exp.war/
14:36:30,739 INFO [TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/
14:36:31,420 INFO [Http11BaseProtocol] Starting Coyote HTTP/1.1 on http-0.0.0.0-8080
14:36:31,570 INFO [ChannelSocket] JK: ajp13 listening on /0.0.0.0:8009
14:36:31,600 INFO [JkMain] Jk running ID=0 time=0/90 config=null
14:36:31,610 INFO [Server] JBoss (MX MicroKernel) [4.0.4.GA (build: CVSTag=JBoss_4_0_4_GA date=200605151000)] Started in 45s:175ms
///////////////////////////////////////////////////////////////////
// JBOSS STARTET GANZ NORMAL - OHNE WEITERE FEHLERMELDUNGEN //
///////////////////////////////////////////////////////////////////
///////////////////////////////////////////////////////////////////
// AUFRUF DES SERVLETS http://localhost:8080/VFMController/Test //
// FÜHRT ZU FOLGENDEM STACKTRACE: //
///////////////////////////////////////////////////////////////////
14:36:54,824 ERROR [STDERR] [ jacorb.home unset! Will use '.' ]
14:36:54,824 ERROR [STDERR] [ File .\jacorb.properties for configuration jacorb not found ]
14:36:54,834 INFO [STDOUT] [ configuration jacorb loaded from classpath]
14:36:54,834 INFO [interceptors] InterceptorManager started with 0 SIs, 0 CIs and 1 IORIs
14:36:54,834 WARN [listener] Address already in use: JVM_Bind
14:36:54,844 WARN [ORBFactory] Unable to activate POA
org.omg.CORBA.INITIALIZE: Could not create server socket vmcid: 0x0 minor code: 0 completed: No
at org.jacorb.orb.iiop.IIOPListener$Acceptor.createServerSocket(IIOPListener.java:466)
at org.jacorb.orb.iiop.IIOPListener$Acceptor.init(IIOPListener.java:378)
at org.jacorb.orb.iiop.IIOPListener.configure(IIOPListener.java:166)
at org.jacorb.orb.etf.FactoriesBase.create_listener(FactoriesBase.java:101)
at org.jacorb.orb.BasicAdapter.configure(BasicAdapter.java:147)
at org.jacorb.orb.ORB.getRootPOA(ORB.java:885)
at org.jacorb.orb.ORB.resolve_initial_references(ORB.java:1167)
at org.jboss.corba.ORBFactory.getORB(ORBFactory.java:82)
at org.jboss.iiop.CorbaORB.getInstance(CorbaORB.java:87)
at org.jboss.proxy.ejb.IIOPHomeFactory.getObjectInstance(IIOPHomeFactory.java:69)
at javax.naming.spi.NamingManager.getObjectInstance(NamingManager.java:304)
at org.jnp.interfaces.NamingContext.getObjectInstance(NamingContext.java:1125)
at org.jnp.interfaces.NamingContext.getObjectInstanceWrapFailure(NamingContext.java:1142)
at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:705)
at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:587)
at javax.naming.InitialContext.lookup(InitialContext.java:351)
at servlet.Test.processRequest(Test.java:31)
at servlet.Test.doGet(Test.java:48)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:697)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:810)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:175)
at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:74)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:869)
at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:664)
at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:527)
at org.apache.tomcat.util.net.MasterSlaveWorkerThread.run(MasterSlaveWorkerThread.java:112)
at java.lang.Thread.run(Thread.java:595)
14:36:54,844 INFO [giop] ClientConnectionManager: created new ClientGIOPConnection to 192.168.2.100:3528 (c5c32e)
14:39:11,710 INFO [iiop] Client-side TCP transport to null closed.