[Clustering/JBoss] - JBoss startup delay - jboss-user

Tuesday, 16 June 2009

Hello

I am using JBoss 4.2.2 GA on a RedHat linux (Linux 2.6.18-53.el5 #1 SMP Wed Oct 10
16:34:19 EDT 2007 x86_64 x86_64 x86_64 GNU/Linux). Java version is 1.6.0_05.

I am experiencing random delays in JBoss startup time. Normally it would take 1' to
start, but quite often it appears to hang for three minutes, one or two times. The result
is that it starts in either 4' or 7' and that's quite annoying.

This instance is part of a two-instance JBoss Cluster. The other instance shows the same
problem.

I can't figure out the reason for this delay. I am attaching the log at DEBUG level,
hoping to get some hints. The first stop is at 17:59:24,520 , the second is at
18:02:51,601.

Thanks
Pierangelo

-------------------------- server.log -----------------------------
2009-06-16 17:59:03,188 DEBUG [org.jboss.logging.Log4jService] Installed System.out
adapter
2009-06-16 17:59:03,189 DEBUG [org.jboss.logging.Log4jService] Installed System.err
adapter
2009-06-16 17:59:03,191 DEBUG [org.jboss.logging.Log4jService] Added ThrowableListener:
org.jboss.logging.Log4jService$ThrowableListenerLoggingAdapter@37722456
2009-06-16 17:59:03,192 DEBUG [org.jboss.logging.Log4jService] Created
jboss.system:type=Log4jService,service=Logging
2009-06-16 17:59:03,192 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.system:type=Log4jService,service=Logging dependents are: []
2009-06-16 17:59:03,192 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.rmi:type=RMIClassLoader
2009-06-16 17:59:03,193 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.rmi:type=RMIClassLoader dependents are: []
2009-06-16 17:59:03,193 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=WebService
2009-06-16 17:59:03,193 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss:service=WebService
2009-06-16 17:59:03,193 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=NamingBeanImpl
2009-06-16 17:59:03,193 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=NamingBeanImpl dependents are: [ObjectName:
jboss:service=Naming
  State: CONFIGURED
  I Depend On:
    jboss.system:service=ThreadPool
    jboss:service=NamingBeanImpl
]
2009-06-16 17:59:03,194 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=Naming
2009-06-16 17:59:03,194 DEBUG [org.jboss.naming.NamingService] Creating
jboss:service=Naming
2009-06-16 17:59:03,194 DEBUG [org.jboss.naming.NamingService] Created
jboss:service=Naming
2009-06-16 17:59:03,213 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=Naming dependents are: []
2009-06-16 17:59:03,213 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=Naming
2009-06-16 17:59:03,213 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss:service=Naming
2009-06-16 17:59:03,213 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=JNDIView
2009-06-16 17:59:03,213 DEBUG [org.jboss.naming.JNDIView] Creating jboss:service=JNDIView
2009-06-16 17:59:03,214 DEBUG [org.jboss.naming.JNDIView] Created jboss:service=JNDIView
2009-06-16 17:59:03,214 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=JNDIView dependents are: []
2009-06-16 17:59:03,214 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.security:service=SecurityConfig
2009-06-16 17:59:03,214 DEBUG [org.jboss.security.plugins.SecurityConfig] Creating
jboss.security:service=SecurityConfig
2009-06-16 17:59:03,214 DEBUG [org.jboss.security.plugins.SecurityConfig] Created
jboss.security:service=SecurityConfig
2009-06-16 17:59:03,214 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.security:service=SecurityConfig dependents are: []
2009-06-16 17:59:03,214 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.security:service=XMLLoginConfig
2009-06-16 17:59:03,214 DEBUG [org.jboss.security.auth.login.XMLLoginConfig] Creating
jboss.security:service=XMLLoginConfig
2009-06-16 17:59:03,214 DEBUG [org.jboss.security.auth.login.XMLLoginConfig] Created
jboss.security:service=XMLLoginConfig
2009-06-16 17:59:03,215 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.security:service=XMLLoginConfig dependents are: []
2009-06-16 17:59:03,215 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.security:service=JaasSecurityManager
2009-06-16 17:59:03,215 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
Creating jboss.security:service=JaasSecurityManager
2009-06-16 17:59:03,215 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
Created jboss.security:service=JaasSecurityManager
2009-06-16 17:59:03,215 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.security:service=JaasSecurityManager dependents are: []
2009-06-16 17:59:03,217 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=XidFactory
2009-06-16 17:59:03,218 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=XidFactory dependents are: []
2009-06-16 17:59:03,218 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=TransactionManager
2009-06-16 17:59:03,218 DEBUG [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
Creating jboss:service=TransactionManager
2009-06-16 17:59:03,218 DEBUG [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
Created jboss:service=TransactionManager
2009-06-16 17:59:03,227 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=TransactionManager dependents are: [ObjectName:
jboss:service=invoker,type=unified
  State: CONFIGURED
  I Depend On:
    jboss:service=TransactionManager
    jboss.remoting:service=Connector,transport=socket
, ObjectName: jboss:service=invoker,type=jrmp
  State: CONFIGURED
  I Depend On:
    jboss:service=TransactionManager
  Depends On Me:
    jboss:service=proxyFactory,target=ClientUserTransactionFactory
    jboss:service=proxyFactory,target=ClientUserTransaction
, ObjectName: jboss:service=invoker,type=local
  State: CONFIGURED
  I Depend On:
    jboss:service=TransactionManager
, ObjectName: jboss:service=invoker,type=pooled
  State: CONFIGURED
  I Depend On:
    jboss:service=TransactionManager
]
2009-06-16 17:59:03,227 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=unified
2009-06-16 17:59:03,227 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss:service=invoker,type=unified waiting on
jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:03,227 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=jrmp
2009-06-16 17:59:03,228 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] Creating
jboss:service=invoker,type=jrmp
2009-06-16 17:59:03,228 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] Created
jboss:service=invoker,type=jrmp
2009-06-16 17:59:03,228 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=invoker,type=jrmp dependents are: [ObjectName:
jboss:service=proxyFactory,target=ClientUserTransactionFactory
  State: CONFIGURED
  I Depend On:
    jboss:service=invoker,type=jrmp
  Depends On Me:
    jboss:service=ClientUserTransaction
, ObjectName: jboss:service=proxyFactory,target=ClientUserTransaction
  State: CONFIGURED
  I Depend On:
    jboss:service=invoker,type=jrmp
  Depends On Me:
    jboss:service=ClientUserTransaction
]
2009-06-16 17:59:03,228 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:03,229 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Creating
jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:03,229 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Created
jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:03,230 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=proxyFactory,target=ClientUserTransactionFactory dependents
are: [ObjectName: jboss:service=ClientUserTransaction
  State: CONFIGURED
  I Depend On:
    jboss:service=proxyFactory,target=ClientUserTransactionFactory
    jboss:service=proxyFactory,target=ClientUserTransaction
]
2009-06-16 17:59:03,230 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=ClientUserTransaction
2009-06-16 17:59:03,231 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss:service=ClientUserTransaction waiting on
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:03,231 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:03,231 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Creating
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:03,231 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Created
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:03,231 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=proxyFactory,target=ClientUserTransaction dependents are:
[ObjectName: jboss:service=ClientUserTransaction
  State: CONFIGURED
  I Depend On:
    jboss:service=proxyFactory,target=ClientUserTransactionFactory
    jboss:service=proxyFactory,target=ClientUserTransaction
]
2009-06-16 17:59:03,231 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=ClientUserTransaction
2009-06-16 17:59:03,231 DEBUG [org.jboss.tm.usertx.server.ClientUserTransactionService]
Creating jboss:service=ClientUserTransaction
2009-06-16 17:59:03,232 DEBUG [org.jboss.tm.usertx.server.ClientUserTransactionService]
Created jboss:service=ClientUserTransaction
2009-06-16 17:59:03,236 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=ClientUserTransaction dependents are: []
2009-06-16 17:59:03,236 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=local
2009-06-16 17:59:03,236 DEBUG [org.jboss.invocation.local.LocalInvoker] Creating
jboss:service=invoker,type=local
2009-06-16 17:59:03,261 DEBUG [org.jboss.invocation.local.LocalInvoker] Created
jboss:service=invoker,type=local
2009-06-16 17:59:03,262 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=invoker,type=local dependents are: []
2009-06-16 17:59:03,262 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=pooled
2009-06-16 17:59:03,262 DEBUG [org.jboss.invocation.pooled.server.PooledInvoker] Creating
jboss:service=invoker,type=pooled
2009-06-16 17:59:03,262 DEBUG [org.jboss.invocation.pooled.server.PooledInvoker] Created
jboss:service=invoker,type=pooled
2009-06-16 17:59:03,262 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=invoker,type=pooled dependents are: []
2009-06-16 17:59:03,262 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=ClientUserTransaction
2009-06-16 17:59:03,262 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss:service=ClientUserTransaction
2009-06-16 17:59:03,262 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:03,262 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=unified
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss:service=invoker,type=unified waiting on
jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=jrmp
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss:service=invoker,type=jrmp
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=local
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss:service=invoker,type=local
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=pooled
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss:service=invoker,type=pooled
2009-06-16 17:59:03,263 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.remoting:service=NetworkRegistry
2009-06-16 17:59:03,264 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.remoting:service=NetworkRegistry dependents are: [ObjectName:
jboss.remoting:service=Connector,transport=socket
  State: CONFIGURED
  I Depend On:
    jboss.remoting:service=NetworkRegistry
  Depends On Me:
    jboss:service=invoker,type=unified
]
2009-06-16 17:59:03,264 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:03,333 DEBUG [org.jboss.remoting.ServerInvoker]
SocketServerInvoker[UNINITIALIZED] did not find server socket factory configuration as
mbean service or classname. Creating default server socket factory.
2009-06-16 17:59:03,333 DEBUG [org.jboss.remoting.ServerInvoker]
SocketServerInvoker[UNINITIALIZED] created server socket factory
javax.net.DefaultServerSocketFactory@6b9cd75a
2009-06-16 17:59:03,354 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.remoting:service=Connector,transport=socket dependents are:
[ObjectName: jboss:service=invoker,type=unified
  State: CONFIGURED
  I Depend On:
    jboss:service=TransactionManager
    jboss.remoting:service=Connector,transport=socket
]
2009-06-16 17:59:03,354 DEBUG [org.jboss.system.ServiceController] Creating service
jboss:service=invoker,type=unified
2009-06-16 17:59:03,354 DEBUG [org.jboss.invocation.unified.server.UnifiedInvoker]
Creating jboss:service=invoker,type=unified
2009-06-16 17:59:03,354 DEBUG [org.jboss.invocation.unified.server.UnifiedInvoker] Created
jboss:service=invoker,type=unified
2009-06-16 17:59:03,354 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss:service=invoker,type=unified dependents are: []
2009-06-16 17:59:03,354 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:03,354 DEBUG [org.jboss.system.ServiceController] Ignoring create request
for service: jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:03,354 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.jdbc:service=metadata
2009-06-16 17:59:03,355 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
Creating jboss.jdbc:service=metadata
2009-06-16 17:59:03,355 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
Created jboss.jdbc:service=metadata
2009-06-16 17:59:03,355 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.jdbc:service=metadata dependents are: []
2009-06-16 17:59:03,355 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.deployment:type=DeploymentScanner,flavor=URL
2009-06-16 17:59:03,355 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Creating
jboss.deployment:type=DeploymentScanner,flavor=URL
2009-06-16 17:59:03,368 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Scanner
thread started
2009-06-16 17:59:03,368 DEBUG
[org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread] Running
2009-06-16 17:59:03,368 DEBUG
[org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread] Disabled, waiting
for notification
2009-06-16 17:59:03,369 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Created
jboss.deployment:type=DeploymentScanner,flavor=URL
2009-06-16 17:59:03,369 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.deployment:type=DeploymentScanner,flavor=URL dependents are: []
2009-06-16 17:59:03,369 DEBUG [org.jboss.deployment.MainDeployer] Done with create step of
deploying jboss-service.xml
2009-06-16 17:59:03,369 DEBUG [org.jboss.deployment.MainDeployer] Begin deployment start
file:/usr/local/jboss-4.2.2.GA/server/all/conf/jboss-service.xml
2009-06-16 17:59:03,369 DEBUG [org.jboss.deployment.SARDeployer] Deploying SAR, start
step: url file:/usr/local/jboss-4.2.2.GA/server/all/conf/jboss-service.xml
2009-06-16 17:59:03,369 DEBUG [org.jboss.system.ServiceController] starting service
jboss.management.local:j2eeType=J2EEDomain,name=Manager
2009-06-16 17:59:03,369 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.management.local:j2eeType=J2EEDomain,name=Manager dependent
components: []
2009-06-16 17:59:03,369 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=AttributePersistenceService
2009-06-16 17:59:03,370 DEBUG [org.jboss.system.pm.AttributePersistenceService] Starting
jboss:service=AttributePersistenceService
2009-06-16 17:59:03,374 DEBUG [org.jboss.system.pm.XMLAttributePersistenceManager]
Constructed
2009-06-16 17:59:03,374 DEBUG [org.jboss.system.pm.XMLAttributePersistenceManager] Using
data directory: /usr/local/jboss-4.2.2.GA/server/all/data/xmbean-attrs
2009-06-16 17:59:03,375 DEBUG [org.jboss.system.pm.AttributePersistenceService] Started
jboss:service=AttributePersistenceService
2009-06-16 17:59:03,375 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=AttributePersistenceService dependent components: []
2009-06-16 17:59:03,375 DEBUG [org.jboss.system.ServiceController] starting service
jboss.system:service=ThreadPool
2009-06-16 17:59:03,375 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.system:service=ThreadPool dependent components: [ObjectName:
jboss:service=WebService
  State: CREATED
  I Depend On:
    jboss.system:service=ThreadPool
, ObjectName: jboss:service=Naming
  State: CREATED
  I Depend On:
    jboss.system:service=ThreadPool
    jboss:service=NamingBeanImpl
]
2009-06-16 17:59:03,375 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=WebService
2009-06-16 17:59:03,375 DEBUG [org.jboss.web.WebService] Starting
jboss:service=WebService
2009-06-16 17:59:03,378 DEBUG [org.jboss.web.WebServer] Started server:
ServerSocket[addr=rllsirfpas01b.local.sirfarma.it/10.145.9.3,port=0,localport=8083]
2009-06-16 17:59:03,381 DEBUG [org.jboss.web.WebService] Started WebServer with address:
rllsirfpas01b.local.sirfarma.it/10.145.9.3:8083
2009-06-16 17:59:03,381 DEBUG [org.jboss.web.WebService] Started jboss:service=WebService
2009-06-16 17:59:03,381 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=WebService dependent components: []
2009-06-16 17:59:03,381 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=Naming
2009-06-16 17:59:03,381 DEBUG [org.jboss.system.ServiceController] waiting in start
jboss:service=Naming on jboss:service=NamingBeanImpl
2009-06-16 17:59:03,381 DEBUG [org.jboss.system.ServiceController] starting service
jboss.system:type=Log4jService,service=Logging
2009-06-16 17:59:03,382 DEBUG [org.jboss.logging.Log4jService] Starting
jboss.system:type=Log4jService,service=Logging
2009-06-16 17:59:03,382 DEBUG [org.jboss.logging.Log4jService] Started
jboss.system:type=Log4jService,service=Logging
2009-06-16 17:59:03,382 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.system:type=Log4jService,service=Logging dependent components: []
2009-06-16 17:59:03,382 DEBUG [org.jboss.system.ServiceController] starting service
jboss.rmi:type=RMIClassLoader
2009-06-16 17:59:03,382 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.rmi:type=RMIClassLoader dependent components: []
2009-06-16 17:59:03,382 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=WebService
2009-06-16 17:59:03,382 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss:service=WebService
2009-06-16 17:59:03,382 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=NamingBeanImpl
2009-06-16 17:59:03,397 DEBUG [org.jnp.server.NamingBeanImpl] Using NamingServer:
org.jnp.server.NamingServer@3ef07355
2009-06-16 17:59:03,397 DEBUG [org.jnp.server.NamingBeanImpl] Installed global
NamingServer: org.jnp.server.NamingServer@3ef07355
2009-06-16 17:59:03,402 DEBUG [org.jnp.server.NamingBeanImpl] InitialContext Environment:

2009-06-16 17:59:03,402 DEBUG [org.jnp.server.NamingBeanImpl]
key=java.naming.factory.initial,
value(java.lang.String)=org.jnp.interfaces.NamingContextFactory
2009-06-16 17:59:03,402 DEBUG [org.jnp.server.NamingBeanImpl]
key=java.naming.factory.url.pkgs,
value(java.lang.String)=org.jboss.naming:org.jnp.interfaces
2009-06-16 17:59:03,407 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=NamingBeanImpl dependent components: [ObjectName:
jboss:service=Naming
  State: CREATED
  I Depend On:
    jboss.system:service=ThreadPool
    jboss:service=NamingBeanImpl
]
2009-06-16 17:59:03,407 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=Naming
2009-06-16 17:59:03,408 DEBUG [org.jboss.naming.NamingService] Starting
jboss:service=Naming
2009-06-16 17:59:03,408 DEBUG [org.jboss.naming.NamingService] System.setProperty,
key=java.naming.factory.initial, value=org.jnp.interfaces.NamingContextFactory
2009-06-16 17:59:03,408 DEBUG [org.jboss.naming.NamingService] System.setProperty,
key=java.naming.factory.url.pkgs, value=org.jboss.naming:org.jnp.interfaces
2009-06-16 17:59:03,409 DEBUG [org.jboss.naming.Naming] Creating NamingServer stub,
theServer=MBeanProxyExt[jboss:service=NamingBeanImpl],rmiPort=1098,clientSocketFactory=null,serverSocketFactory=org.jboss.net.sockets.DefaultSocketFactory@41cb2704[bindAddress=rllsirfpas01b.local.sirfarma.it/10.145.9.3]
2009-06-16 17:59:03,581 DEBUG [org.jboss.naming.Naming] NamingServer stub:
NamingServer_Stub[UnicastRef2 [liveRef:
[endpoint:[rllsirfpas01b.local.sirfarma.it:1098,org.jboss.net.sockets.DefaultSocketFactory@41cb2704[bindAddress=rllsirfpas01b.local.sirfarma.it/10.145.9.3]](local),objID:[-3079be79:121e9cafef2:-7fff,
-6987809006595528208]]]]
2009-06-16 17:59:03,594 DEBUG [org.jboss.naming.Naming] JNDI bootstrap
JNP=rllsirfpas01b.local.sirfarma.it/10.145.9.3:1099,
RMI=rllsirfpas01b.local.sirfarma.it/10.145.9.3:1098, backlog=50, no client SocketFactory,
Server
SocketFactory=org.jboss.net.sockets.DefaultSocketFactory(a)41cb2704[bindAddress=rllsirfpas01b.local.sirfarma.it/10.145.9.3]
2009-06-16 17:59:03,603 DEBUG [org.jboss.naming.NamingService] Started
jboss:service=Naming
2009-06-16 17:59:03,603 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=Naming dependent components: []
2009-06-16 17:59:03,603 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=Naming
2009-06-16 17:59:03,603 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss:service=Naming
2009-06-16 17:59:03,603 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=JNDIView
2009-06-16 17:59:03,603 DEBUG [org.jboss.naming.JNDIView] Starting jboss:service=JNDIView
2009-06-16 17:59:03,603 DEBUG [org.jboss.naming.JNDIView] Started jboss:service=JNDIView
2009-06-16 17:59:03,604 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=JNDIView dependent components: []
2009-06-16 17:59:03,604 DEBUG [org.jboss.system.ServiceController] starting service
jboss.security:service=SecurityConfig
2009-06-16 17:59:03,604 DEBUG [org.jboss.security.plugins.SecurityConfig] Starting
jboss.security:service=SecurityConfig
2009-06-16 17:59:03,605 DEBUG [org.jboss.security.plugins.SecurityConfig] Installed JAAS
Configuration service=jboss.security:service=XMLLoginConfig,
config=org.jboss.security.auth.login.XMLLoginConfigImpl@6b9fe451
2009-06-16 17:59:03,605 DEBUG [org.jboss.security.plugins.SecurityConfig] Started
jboss.security:service=SecurityConfig
2009-06-16 17:59:03,605 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.security:service=SecurityConfig dependent components: []
2009-06-16 17:59:03,605 DEBUG [org.jboss.system.ServiceController] starting service
jboss.security:service=XMLLoginConfig
2009-06-16 17:59:03,605 DEBUG [org.jboss.security.auth.login.XMLLoginConfig] Starting
jboss.security:service=XMLLoginConfig
2009-06-16 17:59:03,606 DEBUG [org.jboss.security.auth.login.XMLLoginConfigImpl] Try
loading config as XML,
url=file:/usr/local/jboss-4.2.2.GA/server/all/conf/login-config.xml
2009-06-16 17:59:03,655 DEBUG [org.jboss.security.auth.login.XMLLoginConfig] Started
jboss.security:service=XMLLoginConfig
2009-06-16 17:59:03,655 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.security:service=XMLLoginConfig dependent components: []
2009-06-16 17:59:03,655 DEBUG [org.jboss.system.ServiceController] starting service
jboss.security:service=JaasSecurityManager
2009-06-16 17:59:03,655 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
Starting jboss.security:service=JaasSecurityManager
2009-06-16 17:59:03,664 DEBUG [org.jboss.security.SecurityAssociation] Using ThreadLocal:
false
2009-06-16 17:59:03,673 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
securityMgrCtxPath=java:/jaas
2009-06-16 17:59:03,674 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
cachePolicyCtxPath=java:/timedCacheFactory
2009-06-16 17:59:03,677 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
SecurityProxyFactory=org.jboss.security.SubjectSecurityProxyFactory@6f18278a
2009-06-16 17:59:03,679 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
Registered PrincipalEditor, SecurityDomainEditor
2009-06-16 17:59:03,679 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
ServerMode=true
2009-06-16 17:59:03,679 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
SecurityMgrClass=class org.jboss.security.plugins.JaasSecurityManager
2009-06-16 17:59:03,679 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
CallbackHandlerClass=class org.jboss.security.auth.callback.SecurityAssociationHandler
2009-06-16 17:59:03,679 DEBUG [org.jboss.security.plugins.JaasSecurityManagerService]
Started jboss.security:service=JaasSecurityManager
2009-06-16 17:59:03,679 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.security:service=JaasSecurityManager dependent components: []
2009-06-16 17:59:03,680 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=XidFactory
2009-06-16 17:59:03,680 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=XidFactory dependent components: []
2009-06-16 17:59:03,680 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=TransactionManager
2009-06-16 17:59:03,680 DEBUG [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
Starting jboss:service=TransactionManager
2009-06-16 17:59:03,680 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
JBossTS Transaction Service (JTA version) - JBoss Inc.
2009-06-16 17:59:03,680 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
Setting up property manager MBean and JMX layer
2009-06-16 17:59:03,820 DEBUG [com.arjuna.ats.arjuna.logging.arjLoggerI18N]
[com.arjuna.ats.arjuna.recovery.TransactionStatusManager_1] - Starting service
com.arjuna.ats.arjuna.recovery.ActionStatusService on port 56056
2009-06-16 17:59:03,825 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger]
TransactionStatusManagerItem - host: 10.145.9.3 port: 56056
2009-06-16 17:59:03,832 DEBUG [com.arjuna.ats.arjuna.logging.arjLoggerI18N]
[com.arjuna.ats.arjuna.recovery.TransactionStatusManager_3] - TransactionStatusManager
started on port 56056 with service com.arjuna.ats.arjuna.recovery.ActionStatusService
2009-06-16 17:59:03,842 DEBUG [com.arjuna.ats.tsmx.logging.tsmxLogger] Registering mbean
for module 'arjuna'
2009-06-16 17:59:03,846 DEBUG [com.arjuna.ats.tsmx.logging.tsmxLogger] Initialising JMX
agent com.arjuna.ats.internal.jbossatx.agent.LocalJBossAgentImpl
2009-06-16 17:59:03,851 DEBUG [com.arjuna.ats.tsmx.logging.tsmxLogger] Registering mbean
for module 'jta'
2009-06-16 17:59:03,853 DEBUG [com.arjuna.ats.tsmx.logging.tsmxLogger] Registering mbean
for module 'txoj'
2009-06-16 17:59:03,872 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
Starting recovery manager
2009-06-16 17:59:03,878 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] 
  --- Start RecoveryActivators 
2009-06-16 17:59:03,887 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] 
  --- ExpiredEntryMonitor ----Tue, 16 Jun 2009 17:59:03----
2009-06-16 17:59:03,978 DEBUG [com.arjuna.ats.jta.logging.loggerI18N]
[com.arjuna.ats.internal.jta.recovery.noxanodes] No XA recovery nodes specified. Will only
recover saved states.
2009-06-16 17:59:03,982 DEBUG [com.arjuna.ats.arjuna.logging.arjLoggerI18N]
[com.arjuna.ats.internal.arjuna.recovery.ready] RecoveryManagerImple is ready on port
33,975
2009-06-16 17:59:03,983 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
Recovery manager started
2009-06-16 17:59:03,983 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
Binding TransactionManager JNDI Reference
2009-06-16 17:59:03,995 DEBUG [com.arjuna.ats.jbossatx.jta.TransactionManagerService]
Started jboss:service=TransactionManager
2009-06-16 17:59:03,996 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=TransactionManager dependent components: [ObjectName:
jboss:service=invoker,type=unified
  State: CREATED
  I Depend On:
    jboss:service=TransactionManager
    jboss.remoting:service=Connector,transport=socket
, ObjectName: jboss:service=invoker,type=jrmp
  State: CREATED
  I Depend On:
    jboss:service=TransactionManager
  Depends On Me:
    jboss:service=proxyFactory,target=ClientUserTransactionFactory
    jboss:service=proxyFactory,target=ClientUserTransaction
, ObjectName: jboss:service=invoker,type=local
  State: CREATED
  I Depend On:
    jboss:service=TransactionManager
, ObjectName: jboss:service=invoker,type=pooled
  State: CREATED
  I Depend On:
    jboss:service=TransactionManager
]
2009-06-16 17:59:03,996 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=unified
2009-06-16 17:59:03,996 DEBUG [org.jboss.system.ServiceController] waiting in start
jboss:service=invoker,type=unified on jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:03,996 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=jrmp
2009-06-16 17:59:03,996 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] Starting
jboss:service=invoker,type=jrmp
2009-06-16 17:59:04,001 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] RMI
Port='4444'
2009-06-16 17:59:04,001 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] Client
SocketFactory='Default'
2009-06-16 17:59:04,001 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] Server
SocketFactory=&#39;org.jboss.net.sockets.DefaultSocketFactory(a)41cb2704[bindAddress=rllsirfpas01b.local.sirfarma.it/10.145.9.3]&#39;
2009-06-16 17:59:04,001 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] Server
SocketAddr='rllsirfpas01b.local.sirfarma.it'
2009-06-16 17:59:04,001 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker]
SecurityDomain='Default'
2009-06-16 17:59:04,016 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] Bound JRMP
invoker for JMX node
2009-06-16 17:59:04,016 DEBUG [org.jboss.invocation.jrmp.server.JRMPInvoker] Started
jboss:service=invoker,type=jrmp
2009-06-16 17:59:04,016 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=invoker,type=jrmp dependent components: [ObjectName:
jboss:service=proxyFactory,target=ClientUserTransactionFactory
  State: CREATED
  I Depend On:
    jboss:service=invoker,type=jrmp
  Depends On Me:
    jboss:service=ClientUserTransaction
, ObjectName: jboss:service=proxyFactory,target=ClientUserTransaction
  State: CREATED
  I Depend On:
    jboss:service=invoker,type=jrmp
  Depends On Me:
    jboss:service=ClientUserTransaction
]
2009-06-16 17:59:04,016 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:04,016 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Starting
jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:04,025 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Created
JRMPPRoxy for service=jboss:service=ClientUserTransaction, nameHash=-2097396599,
invoker=jboss:service=invoker,type=jrmp
2009-06-16 17:59:04,045 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Bound
proxy under jndiName=UserTransactionSessionFactory
2009-06-16 17:59:04,045 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Started
jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:04,046 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=proxyFactory,target=ClientUserTransactionFactory dependent
components: [ObjectName: jboss:service=ClientUserTransaction
  State: CREATED
  I Depend On:
    jboss:service=proxyFactory,target=ClientUserTransactionFactory
    jboss:service=proxyFactory,target=ClientUserTransaction
]
2009-06-16 17:59:04,046 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=ClientUserTransaction
2009-06-16 17:59:04,046 DEBUG [org.jboss.system.ServiceController] waiting in start
jboss:service=ClientUserTransaction on
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:04,046 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:04,046 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Starting
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:04,049 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Created
JRMPPRoxy for service=jboss:service=ClientUserTransaction, nameHash=2024786241,
invoker=jboss:service=invoker,type=jrmp
2009-06-16 17:59:04,051 DEBUG [org.jboss.invocation.jrmp.server.JRMPProxyFactory] Started
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:04,051 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=proxyFactory,target=ClientUserTransaction dependent
components: [ObjectName: jboss:service=ClientUserTransaction
  State: CREATED
  I Depend On:
    jboss:service=proxyFactory,target=ClientUserTransactionFactory
    jboss:service=proxyFactory,target=ClientUserTransaction
]
2009-06-16 17:59:04,051 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=ClientUserTransaction
2009-06-16 17:59:04,052 DEBUG [org.jboss.tm.usertx.server.ClientUserTransactionService]
Starting jboss:service=ClientUserTransaction
2009-06-16 17:59:04,055 DEBUG [org.jboss.tm.usertx.server.ClientUserTransactionService]
Started jboss:service=ClientUserTransaction
2009-06-16 17:59:04,055 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=ClientUserTransaction dependent components: []
2009-06-16 17:59:04,055 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=local
2009-06-16 17:59:04,055 DEBUG [org.jboss.invocation.local.LocalInvoker] Starting
jboss:service=invoker,type=local
2009-06-16 17:59:04,058 DEBUG [org.jboss.invocation.local.LocalInvoker] Local invoker for
JMX node started
2009-06-16 17:59:04,058 DEBUG [org.jboss.invocation.local.LocalInvoker] Started
jboss:service=invoker,type=local
2009-06-16 17:59:04,058 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=invoker,type=local dependent components: []
2009-06-16 17:59:04,058 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=pooled
2009-06-16 17:59:04,058 DEBUG [org.jboss.invocation.pooled.server.PooledInvoker] Starting
jboss:service=invoker,type=pooled
2009-06-16 17:59:04,067 DEBUG [org.jboss.invocation.pooled.server.PooledInvoker] Bound
invoker for JMX node
2009-06-16 17:59:04,067 DEBUG [org.jboss.invocation.pooled.server.PooledInvoker] Started
jboss:service=invoker,type=pooled
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=invoker,type=pooled dependent components: []
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=ClientUserTransaction
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss:service=ClientUserTransaction
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss:service=proxyFactory,target=ClientUserTransactionFactory
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss:service=proxyFactory,target=ClientUserTransaction
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=unified
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] waiting in start
jboss:service=invoker,type=unified on jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=jrmp
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss:service=invoker,type=jrmp
2009-06-16 17:59:04,068 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=local
2009-06-16 17:59:04,069 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss:service=invoker,type=local
2009-06-16 17:59:04,069 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=pooled
2009-06-16 17:59:04,069 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss:service=invoker,type=pooled
2009-06-16 17:59:04,069 DEBUG [org.jboss.system.ServiceController] starting service
jboss.remoting:service=NetworkRegistry
2009-06-16 17:59:04,069 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.remoting:service=NetworkRegistry dependent components: [ObjectName:
jboss.remoting:service=Connector,transport=socket
  State: CREATED
  I Depend On:
    jboss.remoting:service=NetworkRegistry
  Depends On Me:
    jboss:service=invoker,type=unified
]
2009-06-16 17:59:04,069 DEBUG [org.jboss.system.ServiceController] starting service
jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:04,073 DEBUG [org.jboss.remoting.ServerInvoker]
SocketServerInvoker[UNINITIALIZED] added
org.jboss.invocation.unified.server.UnifiedInvoker@44aea710 for subsystem
'invoker'
2009-06-16 17:59:04,073 DEBUG [org.jboss.remoting.transport.socket.SocketServerInvoker]
SocketServerInvoker[UNINITIALIZED] starting
2009-06-16 17:59:04,075 DEBUG [org.jboss.remoting.ServerInvoker]
SocketServerInvoker[10.145.9.3:4446] started for locator InvokerLocator
[socket://rllsirfpas01b.local.sirfarma.it:4446/?dataType=invocation&enableTcpNoDelay=true&marshaller=org.jboss.invocation.unified.marshall.InvocationMarshaller&socketTimeout=600000&unmarshaller=org.jboss.invocation.unified.marshall.InvocationUnMarshaller]
2009-06-16 17:59:04,075 DEBUG [org.jboss.remoting.transport.socket.SocketServerInvoker]
SocketServerInvoker[10.145.9.3:4446] started
2009-06-16 17:59:04,075 DEBUG [org.jboss.remoting.transport.Connector]
org.jboss.remoting.transport.Connector@524c71d2 started
2009-06-16 17:59:04,075 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.remoting:service=Connector,transport=socket dependent components:
[ObjectName: jboss:service=invoker,type=unified
  State: CREATED
  I Depend On:
    jboss:service=TransactionManager
    jboss.remoting:service=Connector,transport=socket
]
2009-06-16 17:59:04,075 DEBUG [org.jboss.system.ServiceController] starting service
jboss:service=invoker,type=unified
2009-06-16 17:59:04,076 DEBUG [org.jboss.invocation.unified.server.UnifiedInvoker]
Starting jboss:service=invoker,type=unified
2009-06-16 17:59:04,076 DEBUG [org.jboss.invocation.unified.server.UnifiedInvoker]
Starting unified invoker service.
2009-06-16 17:59:04,087 DEBUG [org.jboss.invocation.unified.server.UnifiedInvoker] Started
jboss:service=invoker,type=unified
2009-06-16 17:59:04,087 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss:service=invoker,type=unified dependent components: []
2009-06-16 17:59:04,087 DEBUG [org.jboss.system.ServiceController] starting service
jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:04,087 DEBUG [org.jboss.system.ServiceController] Ignoring start request
for service: jboss.remoting:service=Connector,transport=socket
2009-06-16 17:59:04,087 DEBUG [org.jboss.system.ServiceController] starting service
jboss.jdbc:service=metadata
2009-06-16 17:59:04,087 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
Starting jboss.jdbc:service=metadata
2009-06-16 17:59:04,088 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
Loading standardjbosscmp-jdbc.xml :
file:/usr/local/jboss-4.2.2.GA/server/all/conf/standardjbosscmp-jdbc.xml
2009-06-16 17:59:04,210 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: FirstSQL/J
2009-06-16 17:59:04,217 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Ingres
2009-06-16 17:59:04,225 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: McKoi
2009-06-16 17:59:04,234 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Firebird
2009-06-16 17:59:04,243 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: InterBase
2009-06-16 17:59:04,252 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: DB2
2009-06-16 17:59:04,264 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Derby
2009-06-16 17:59:04,276 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Oracle9i
2009-06-16 17:59:04,289 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Oracle8
2009-06-16 17:59:04,302 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Oracle7
2009-06-16 17:59:04,312 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Sybase
2009-06-16 17:59:04,326 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: PostgreSQL
2009-06-16 17:59:04,342 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: PostgreSQL 8.0
2009-06-16 17:59:04,359 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: PostgreSQL 7.2
2009-06-16 17:59:04,376 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Hypersonic SQL
2009-06-16 17:59:04,388 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: PointBase
2009-06-16 17:59:04,396 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: SOLID
2009-06-16 17:59:04,406 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: mySQL
2009-06-16 17:59:04,414 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: MS SQLSERVER
2009-06-16 17:59:04,419 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: MS SQLSERVER2000
2009-06-16 17:59:04,423 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: DB2/400
2009-06-16 17:59:04,427 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: SapDB
2009-06-16 17:59:04,431 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: MaxDB
2009-06-16 17:59:04,435 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Cloudscape
2009-06-16 17:59:04,439 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: InformixDB
2009-06-16 17:59:04,442 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
added type-mapping: Mimer SQL
2009-06-16 17:59:04,442 DEBUG [org.jboss.ejb.plugins.cmp.jdbc.metadata.MetaDataLibrary]
Started jboss.jdbc:service=metadata
2009-06-16 17:59:04,443 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.jdbc:service=metadata dependent components: []
2009-06-16 17:59:04,443 DEBUG [org.jboss.system.ServiceController] starting service
jboss.deployment:type=DeploymentScanner,flavor=URL
2009-06-16 17:59:04,443 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Starting
jboss.deployment:type=DeploymentScanner,flavor=URL
2009-06-16 17:59:04,451 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment of
package: file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,451 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment
(init step) of package at:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,451 DEBUG [org.jboss.deployment.MainDeployer] using deployer
org.jboss.deployment.SARDeployer@4a53fb57
2009-06-16 17:59:04,453 DEBUG [org.jboss.deployment.SARDeployer] Updated watch URL to:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/META-INF/jboss-service.xml
2009-06-16 17:59:04,460 DEBUG [org.jboss.deployment.SARDeployer] about to copy 0 local
directories
2009-06-16 17:59:04,461 DEBUG [org.jboss.deployment.SARDeployer] looking for nested
deployments in : file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,461 DEBUG [org.jboss.deployment.SARDeployer] nested deployment:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-annotations-ejb3.jar
2009-06-16 17:59:04,462 DEBUG [org.jboss.deployment.SARDeployer] nested deployment:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-ejb3.jar
2009-06-16 17:59:04,462 DEBUG [org.jboss.deployment.DeploymentInfo] createLoaderRepository
from config: LoaderRepositoryConfig(repositoryName:
JMImplementation:service=LoaderRepository,name=Default, repositoryClassName: null,
configParserClassName: null, repositoryConfig: null)
2009-06-16 17:59:04,462 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository,
repository=org.jboss.mx.loading.UnifiedLoaderRepository3@1d10c424,
cl=org.jboss.mx.loading.UnifiedClassLoader3@6d66f9b9{
url=file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/ ,addedOrder=0}
2009-06-16 17:59:04,462 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository,
repository=org.jboss.mx.loading.UnifiedLoaderRepository3@1d10c424,
cl=org.jboss.mx.loading.UnifiedClassLoader3@6d66f9b9{
url=file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/ ,addedOrder=0}
2009-06-16 17:59:04,463 DEBUG [org.jboss.mx.loading.UnifiedLoaderRepository3] Adding
org.jboss.mx.loading.UnifiedClassLoader3@6d66f9b9{
url=file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/ ,addedOrder=0}
2009-06-16 17:59:04,463 DEBUG [org.jboss.mx.loading.ClassLoaderUtils] Multiple class
loaders found for pkg: 
2009-06-16 17:59:04,464 DEBUG [org.jboss.deployment.MainDeployer] found 2 subpackages of
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,464 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment
(init step) of package at:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-annotations-ejb3.jar
2009-06-16 17:59:04,464 DEBUG [org.jboss.deployment.MainDeployer] Copying
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-annotations-ejb3.jar
-> /usr/local/jboss-4.2.2.GA/server/all/tmp/deploy/tmp27638jboss-annotations-ejb3.jar
2009-06-16 17:59:04,467 DEBUG [org.jboss.deployment.JARDeployer] No xml files found
2009-06-16 17:59:04,467 DEBUG [org.jboss.deployment.MainDeployer] using deployer
org.jboss.deployment.JARDeployer@671ff436
2009-06-16 17:59:04,467 DEBUG [org.jboss.deployment.JARDeployer] looking for nested
deployments in :
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-annotations-ejb3.jar
2009-06-16 17:59:04,482 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] Added url:
file:/usr/local/jboss-4.2.2.GA/server/all/tmp/deploy/tmp27638jboss-annotations-ejb3.jar,
to ucl: org.jboss.mx.loading.UnifiedClassLoader3@6d66f9b9{
url=file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/ ,addedOrder=3}
2009-06-16 17:59:04,483 DEBUG [org.jboss.deployment.MainDeployer] found 0 subpackages of
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-annotations-ejb3.jar
2009-06-16 17:59:04,483 DEBUG [org.jboss.deployment.MainDeployer] Watching new file:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-annotations-ejb3.jar
2009-06-16 17:59:04,483 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment
(init step) of package at:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-ejb3.jar
2009-06-16 17:59:04,484 DEBUG [org.jboss.deployment.MainDeployer] Copying
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-ejb3.jar ->
/usr/local/jboss-4.2.2.GA/server/all/tmp/deploy/tmp27639jboss-ejb3.jar
2009-06-16 17:59:04,495 DEBUG [org.jboss.deployment.JARDeployer] No xml files found
2009-06-16 17:59:04,495 DEBUG [org.jboss.deployment.MainDeployer] using deployer
org.jboss.deployment.JARDeployer@671ff436
2009-06-16 17:59:04,495 DEBUG [org.jboss.deployment.JARDeployer] looking for nested
deployments in :
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-ejb3.jar
2009-06-16 17:59:04,559 DEBUG [org.jboss.mx.loading.ClassLoaderUtils] Multiple class
loaders found for pkg: org.jboss.ejb
2009-06-16 17:59:04,602 DEBUG [org.jboss.mx.loading.ClassLoaderUtils] Multiple class
loaders found for pkg: schema
2009-06-16 17:59:04,607 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] Added url:
file:/usr/local/jboss-4.2.2.GA/server/all/tmp/deploy/tmp27639jboss-ejb3.jar, to ucl:
org.jboss.mx.loading.UnifiedClassLoader3@6d66f9b9{
url=file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/ ,addedOrder=3}
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.MainDeployer] found 0 subpackages of
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-ejb3.jar
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.MainDeployer] Watching new file:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-ejb3.jar
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.MainDeployer] Watching new file:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.MainDeployer] create step for
deployment file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.MainDeployer] create step for
deployment
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-annotations-ejb3.jar
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.MainDeployer] Done with create step of
deploying jboss-annotations-ejb3.jar
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.MainDeployer] create step for
deployment file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-ejb3.jar
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.MainDeployer] Done with create step of
deploying jboss-ejb3.jar
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.SARDeployer] Deploying SAR, create
step: url file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,608 DEBUG [org.jboss.deployment.SARDeployer] Registering service
UCL=jmx.loading:UCL=6d66f9b9
2009-06-16 17:59:04,610 DEBUG [org.jboss.system.ServiceCreator] About to create bean:
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3 with code:
org.jboss.remoting.transport.Connector
2009-06-16 17:59:04,613 DEBUG [org.jboss.system.ServiceCreator] Created bean:
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3
2009-06-16 17:59:04,614 DEBUG [org.jboss.system.ServiceController] recording that
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3 depends on
jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,614 DEBUG [org.jboss.system.ServiceConfigurator] considering  with
object name jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,615 DEBUG [org.jboss.system.ServiceConfigurator] InvokerLocator set to
socket://rllsirfpas01b.local.sirfarma.it:3873 in
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3
2009-06-16 17:59:04,618 DEBUG [org.jboss.system.ServiceConfigurator] Configuration set to
[handlers: null] in jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3
2009-06-16 17:59:04,619 DEBUG [org.jboss.system.ServiceCreator] About to create bean:
jboss.ejb3:service=JarsIgnoredForScanning with code:
org.jboss.ejb3.JarsIgnoredForScanning
2009-06-16 17:59:04,624 DEBUG [org.jboss.system.ServiceCreator] Created bean:
jboss.ejb3:service=JarsIgnoredForScanning
2009-06-16 17:59:04,625 DEBUG [org.jboss.system.ServiceConfigurator] IgnoredJars set to
[Ljava.lang.String;@6e5dfaf1 in jboss.ejb3:service=JarsIgnoredForScanning
2009-06-16 17:59:04,626 DEBUG [org.jboss.system.ServiceCreator] About to create xmbean
object: jboss.ejb3:service=EJB3Deployer with code: org.jboss.ejb3.EJB3Deployer with
embedded descriptor
2009-06-16 17:59:04,651 DEBUG [org.jboss.system.ServiceCreator] Created bean:
jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,652 DEBUG [org.jboss.system.ServiceConfigurator]
DeployEjb3ExtensionOnly set to false in jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,652 DEBUG [org.jboss.system.ServiceController] recording that
jboss.ejb3:service=EJB3Deployer depends on jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,652 DEBUG [org.jboss.system.ServiceConfigurator] considering  with
object name jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,652 DEBUG [org.jboss.system.ServiceController] recording that
jboss.ejb3:service=EJB3Deployer depends on jboss.ejb:service=EJBDeployer
2009-06-16 17:59:04,652 DEBUG [org.jboss.system.ServiceConfigurator] considering  with
object name jboss.ejb:service=EJBDeployer
2009-06-16 17:59:04,652 DEBUG [org.jboss.system.ServiceController] recording that
jboss.ejb3:service=EJB3Deployer depends on jboss.ejb3:service=JarsIgnoredForScanning
2009-06-16 17:59:04,652 DEBUG [org.jboss.system.ServiceConfigurator] considering
JarsIgnoredForScanning with object name jboss.ejb3:service=JarsIgnoredForScanning
2009-06-16 17:59:04,656 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3
2009-06-16 17:59:04,656 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3 waiting on
jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,656 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.ejb3:service=JarsIgnoredForScanning
2009-06-16 17:59:04,656 DEBUG [org.jboss.system.ServiceController] Creating dependent
components for: jboss.ejb3:service=JarsIgnoredForScanning dependents are: [ObjectName:
jboss.ejb3:service=EJB3Deployer
  State: CONFIGURED
  I Depend On:
    jboss.aop:service=AspectDeployer
    jboss.ejb:service=EJBDeployer
    jboss.ejb3:service=JarsIgnoredForScanning
]
2009-06-16 17:59:04,656 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,656 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss.ejb3:service=EJB3Deployer waiting on jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,656 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,656 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss.ejb3:service=EJB3Deployer waiting on jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,656 DEBUG [org.jboss.deployment.MainDeployer] Done with create step of
deploying ejb3.deployer
2009-06-16 17:59:04,657 DEBUG [org.jboss.deployment.MainDeployer] Begin deployment start
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,657 DEBUG [org.jboss.deployment.MainDeployer] Begin deployment start
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-annotations-ejb3.jar
2009-06-16 17:59:04,657 DEBUG [org.jboss.deployment.MainDeployer] End deployment start on
package: jboss-annotations-ejb3.jar
2009-06-16 17:59:04,657 DEBUG [org.jboss.deployment.MainDeployer] Begin deployment start
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/jboss-ejb3.jar
2009-06-16 17:59:04,657 DEBUG [org.jboss.deployment.MainDeployer] End deployment start on
package: jboss-ejb3.jar
2009-06-16 17:59:04,657 DEBUG [org.jboss.deployment.SARDeployer] Deploying SAR, start
step: url file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,657 DEBUG [org.jboss.system.ServiceController] starting service
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3
2009-06-16 17:59:04,657 DEBUG [org.jboss.system.ServiceController] Start requested before
create, calling create now for service:
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3
2009-06-16 17:59:04,657 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3
2009-06-16 17:59:04,657 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3 waiting on
jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] waiting in start
jboss.remoting:type=Connector,name=DefaultEjb3Connector,handler=ejb3 on
jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] starting service
jboss.ejb3:service=JarsIgnoredForScanning
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] Starting dependent
components for: jboss.ejb3:service=JarsIgnoredForScanning dependent components:
[ObjectName: jboss.ejb3:service=EJB3Deployer
  State: CONFIGURED
  I Depend On:
    jboss.aop:service=AspectDeployer
    jboss.ejb:service=EJBDeployer
    jboss.ejb3:service=JarsIgnoredForScanning
]
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] starting service
jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] Start requested before
create, calling create now for service: jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss.ejb3:service=EJB3Deployer waiting on jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] waiting in start
jboss.ejb3:service=EJB3Deployer on jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] starting service
jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] Start requested before
create, calling create now for service: jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] Creating service
jboss.ejb3:service=EJB3Deployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] waiting in create of
jboss.ejb3:service=EJB3Deployer waiting on jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,658 DEBUG [org.jboss.system.ServiceController] waiting in start
jboss.ejb3:service=EJB3Deployer on jboss.aop:service=AspectDeployer
2009-06-16 17:59:04,685 DEBUG [org.jboss.deployment.MainDeployer] End deployment start on
package: ejb3.deployer
2009-06-16 17:59:04,685 DEBUG [org.jboss.deployment.MainDeployer] Deployed package:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/
2009-06-16 17:59:04,687 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Watch
URL for: file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/ ->
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/ejb3.deployer/META-INF/jboss-service.xml
2009-06-16 17:59:04,688 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment of
package: file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/
2009-06-16 17:59:04,688 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment
(init step) of package at:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/
2009-06-16 17:59:04,688 DEBUG [org.jboss.deployment.MainDeployer] using deployer
org.jboss.deployment.SARDeployer@4a53fb57
2009-06-16 17:59:04,689 DEBUG [org.jboss.deployment.SARDeployer] Updated watch URL to:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/META-INF/jboss-service.xml
2009-06-16 17:59:04,691 DEBUG [org.jboss.deployment.SARDeployer] about to copy 0 local
directories
2009-06-16 17:59:04,691 DEBUG [org.jboss.deployment.SARDeployer] looking for nested
deployments in :
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/
2009-06-16 17:59:04,691 DEBUG [org.jboss.deployment.SARDeployer] nested deployment:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/jboss-aop-jdk50.jar
2009-06-16 17:59:04,692 DEBUG [org.jboss.deployment.SARDeployer] nested deployment:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/trove.jar
2009-06-16 17:59:04,692 DEBUG [org.jboss.deployment.SARDeployer] nested deployment:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/jboss-aspect-library-jdk50.jar
2009-06-16 17:59:04,693 DEBUG [org.jboss.deployment.DeploymentInfo] createLoaderRepository
from config: LoaderRepositoryConfig(repositoryName:
JMImplementation:service=LoaderRepository,name=Default, repositoryClassName: null,
configParserClassName: null, repositoryConfig: null)
2009-06-16 17:59:04,693 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository,
repository=org.jboss.mx.loading.UnifiedLoaderRepository3@1d10c424,
cl=org.jboss.mx.loading.UnifiedClassLoader3@39320a41{
url=file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/
,addedOrder=0}
2009-06-16 17:59:04,693 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository,
repository=org.jboss.mx.loading.UnifiedLoaderRepository3@1d10c424,
cl=org.jboss.mx.loading.UnifiedClassLoader3@39320a41{
url=file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/
,addedOrder=0}
2009-06-16 17:59:04,693 DEBUG [org.jboss.mx.loading.UnifiedLoaderRepository3] Adding
org.jboss.mx.loading.UnifiedClassLoader3@39320a41{
url=file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/
,addedOrder=0}
2009-06-16 17:59:04,693 DEBUG [org.jboss.mx.loading.ClassLoaderUtils] Multiple class
loaders found for pkg: 
2009-06-16 17:59:04,694 DEBUG [org.jboss.deployment.MainDeployer] found 3 subpackages of
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/
2009-06-16 17:59:04,694 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment
(init step) of package at:
file:/usr/local/jboss-4.2.2.GA/server/all/deploy/jboss-aop-jdk50.deployer/jb

View the original post :
http://www.jboss.org/index.html?module=bb&op=viewtopic&p=4238001#...

Reply to the post :
http://www.jboss.org/index.html?module=bb&op=posting&mode=reply&a...

2026

2025

2024

2023

2022

2021

2020

2019

2018

2017

2016

2015

2014

2013

2012

2011

2010

2009

2008

2007

2006

[Clustering/JBoss] - JBoss startup delay