JBossDeveloper External client hangs when looking up bean
msebi Mar 31, 2018 1:31 AMI'm running an external client that fails to lookup a bean and hangs. I'm using JBoss Developer Studio 11 (installed using jdk1.8.0_121 (x64) running on Win 10) and deployed on JBoss AS 6.x, JBoss AS 71 and Wildfly 11. All server runtimes have been downloaded
through Dev Studio. The code for the client is (the credentials are admin:admin for JBoss AS 6.0.0 (defaults) and admin:test123 for JBoss AS 7 and Wildfly 11):
StreamingClient.java
import java.util.Properties;
import javax.naming.Context;
import javax.naming.InitialContext;
import javax.naming.NamingException;
import src.StreamingEJB;
public class StreamingClient {
private Properties getRemoteProperties() {
Properties jndiProperties = new Properties();
// jndiProperties.put(Context.INITIAL_CONTEXT_FACTORY, "org.wildfly.naming.client.WildFlyInitialContextFactory");
jndiProperties.put(Context.INITIAL_CONTEXT_FACTORY, "org.jboss.naming.remote.client.InitialContextFactory");
// jndiProperties.put(Context.PROVIDER_URL, "http-remoting://localhost:8080");
jndiProperties.put(Context.PROVIDER_URL, "remote+http://localhost:8080");
// username
jndiProperties.put(Context.SECURITY_PRINCIPAL, "admin");
// password
jndiProperties.put(Context.SECURITY_CREDENTIALS, "admin");
return jndiProperties;
}
//java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory
//java.naming.factory.url.pkgs=org.jboss.naming.client
//java.naming.factory.provider.url=localhost:8080
private Properties getLocalProperties() {
Properties jndiProperties = new Properties();
// jndiProperties.put(Context.INITIAL_CONTEXT_FACTORY, "org.wildfly.naming.client.WildFlyInitialContextFactory");
// Taken from https://stackoverflow.com/questions/41574751/standalone-jboss-ejb-client-application-how-to-get-jndi-connection-distinct
jndiProperties.put(Context.URL_PKG_PREFIXES, "org.jboss.ejb.client.naming");
jndiProperties.put(Context.PROVIDER_URL, "localhost:8080");
jndiProperties.put(Context.INITIAL_CONTEXT_FACTORY, "org.jnp.interfaces.NamingContextFactory");
return jndiProperties;
}
public static void main(String[] args) throws NamingException {
System.out.println("Some line to breakpoint");
EJBClient ejbClient = new EJBClient();
InitialContext ctx = new InitialContext(ejbClient.getRemoteProperties());
System.out.println("Looking up bean StreamingEJB");
StreamingEJB= (StreamingEJB) ctx.lookup("StreamingBean");
callerInstance.startStreaming("REST Streaming API");
callerInstance.stopStreaming("REST Streaming API");
}
}
The code for the bean is:
StreamingEJB.java
package src;
import javax.ejb.LocalBean;
import javax.ejb.Remote;
import javax.ejb.Stateless;
import org.jboss.logging.Logger;
/**
* Session Bean implementation class StreamingBean
*/
@Stateless(mappedName = "StreamingBean")
@Remote(StreamingEJBRemote.class)
public class StreamingEJB implements StreamingEJBRemote {
/**
* Default constructor.
*/
public FirstEJB() {
// TODO Auto-generated constructor stub
}
private static final Logger LOGGER = Logger.getLogger(StreamingEJB.class);
/**
* Default constructor.
*/
@Override
public String startStreaming(String channel) {
LOGGER.info("In method startStreaming(String) in class " + this.getClass().getSimpleName());
System.out.println("Starting streaming on channel " + channel);
System.out.println("Started streaming on channel " + channel);
LOGGER.info("Starting streaming on channel " + channel);
LOGGER.info("Started streaming on channel " + channel);
return "Started Streaming!!!";
}
@Override
public String stopStreaming(String channel) {
LOGGER.info("In method stopStreaming(String) in class " + this.getClass().getSimpleName());
System.out.println("Stopping streaming on channel " + channel);
System.out.println("Stopped streaming on channel " + channel);
LOGGER.info("Stopping streaming on channel " + channel);
LOGGER.info("Stopped streaming on channel " + channel);
return "Stopped Streaming!!!";
}
}
StreamingEJBRemote.java
package src;
import javax.ejb.Remote;
@Remote
public interface StreamingEJBRemote {
public String startStreaming(String channel);
public String stopStreaming(String channel);
}
Runs were made using jdk 1.7. Deploying on JBoss AS 6.0.0 seems to run fine:
14:47:35,634 INFO [AbstractJBossASServerBase] Server Configuration:
JBOSS_HOME URL: file:/D:/Tools/jboss-6.0.0.Final/
Bootstrap: $JBOSS_HOME\server/default/conf/bootstrap.xml
Common Base: $JBOSS_HOME\common/
Common Library: $JBOSS_HOME\common/lib/
Server Name: default
Server Base: $JBOSS_HOME\server/
Server Library: $JBOSS_HOME\server/default/lib/
Server Config: $JBOSS_HOME\server/default/conf/
Server Home: $JBOSS_HOME\server/default/
Server Data: $JBOSS_HOME\server/default/data/
Server Log: $JBOSS_HOME\server/default/log/
Server Temp: $JBOSS_HOME\server/default/tmp/
14:47:35,636 INFO [AbstractServer] Starting: JBossAS [6.0.0.Final "Neo"]
14:47:36,926 INFO [ServerInfo] Java version: 1.7.0_11,Oracle Corporation
14:47:36,926 INFO [ServerInfo] Java Runtime: Java(TM) SE Runtime Environment (build 1.7.0_11-b21)
14:47:36,926 INFO [ServerInfo] Java VM: Java HotSpot(TM) 64-Bit Server VM 23.6-b04,Oracle Corporation
14:47:36,926 INFO [ServerInfo] OS-System: Windows 8 6.2,amd64
14:47:36,926 INFO [ServerInfo] VM arguments: -Dprogram.name=JBossTools: JBoss AS 6.x -Djava.awt.headless=true -Xms256m -Xmx768m -XX:MaxPermSize=256m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Djava.endorsed.dirs=D:\Tools\jboss-6.0.0.Final\lib\endorsed -Djava.library.path=D:/Tools/jboss-6.0.0.Final/bin/native -Dfile.encoding=Cp1252
14:47:36,956 INFO [JMXKernel] Legacy JMX core initialized
14:47:46,545 INFO [AbstractServerConfig] JBoss Web Services - Stack CXF Server 3.4.1.GA
14:47:46,944 INFO [JSFImplManagementDeployer] Initialized 3 JSF configurations: [Mojarra-1.2, MyFaces-2.0, Mojarra-2.0]
14:47:50,148 WARNING [FileConfigurationParser] AIO wasn't located on this platform, it will fall back to using pure Java NIO. If your platform is Linux, install LibAIO to enable the AIO journal
14:47:52,127 WARNING [FileConfigurationParser] AIO wasn't located on this platform, it will fall back to using pure Java NIO. If your platform is Linux, install LibAIO to enable the AIO journal
14:47:52,320 INFO [JMXConnector] starting JMXConnector on host localhost:1090
14:47:52,431 INFO [MailService] Mail Service bound to java:/Mail
14:47:53,169 INFO [HornetQServerImpl] live server is starting..
14:47:53,228 INFO [JournalStorageManager] Using NIO Journal
14:47:53,249 WARNING [HornetQServerImpl] Security risk! It has been detected that the cluster admin user and password have not been changed from the installation default. Please see the HornetQ user guide, cluster chapter, for instructions on how to do this.
14:47:53,867 INFO [NettyAcceptor] Started Netty Acceptor version 3.2.1.Final-r2319 localhost:5455 for CORE protocol
14:47:53,868 INFO [NettyAcceptor] Started Netty Acceptor version 3.2.1.Final-r2319 localhost:5445 for CORE protocol
14:47:53,871 INFO [HornetQServerImpl] HornetQ Server version 2.1.2.Final (Colmeia, 120) started
14:47:53,908 INFO [WebService] Using RMI server codebase: http://localhost:8083/
14:47:54,030 INFO [jbossatx] ARJUNA-32010 JBossTS Recovery Service (tag: JBOSSTS_4_14_0_Final) - JBoss Inc.
14:47:54,035 INFO [arjuna] ARJUNA-12324 Start RecoveryActivators
14:47:54,049 INFO [arjuna] ARJUNA-12296 ExpiredEntryMonitor running at Thu, 29 Mar 2018 14:47:54
14:47:54,100 INFO [arjuna] ARJUNA-12310 Recovery manager listening on endpoint 127.0.0.1:4712
14:47:54,101 INFO [arjuna] ARJUNA-12344 RecoveryManagerImple is ready on port 4712
14:47:54,101 INFO [jbossatx] ARJUNA-32013 Starting transaction recovery manager
14:47:54,113 INFO [arjuna] ARJUNA-12163 Starting service com.arjuna.ats.arjuna.recovery.ActionStatusService on port 4713
14:47:54,113 INFO [arjuna] ARJUNA-12337 TransactionStatusManagerItem host: 127.0.0.1 port: 4713
14:47:54,170 INFO [arjuna] ARJUNA-12170 TransactionStatusManager started on port 4713 and host 127.0.0.1 with service com.arjuna.ats.arjuna.recovery.ActionStatusService
14:47:54,201 INFO [jbossatx] ARJUNA-32017 JBossTS Transaction Service (JTA version - tag: JBOSSTS_4_14_0_Final) - JBoss Inc.
14:47:54,225 INFO [arjuna] ARJUNA-12202 registering bean jboss.jta:type=ObjectStore.
14:47:54,410 INFO [AprLifecycleListener] The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: D:/Tools/jboss-6.0.0.Final/bin/native
14:47:54,510 INFO [TomcatDeployment] deploy, ctxPath=/invoker
14:47:54,737 INFO [ModClusterService] Initializing mod_cluster 1.1.0.Final
14:47:54,773 INFO [RARDeployment] Required license terms exist, view vfs:/D:/Tools/jboss-6.0.0.Final/server/default/deploy/jboss-local-jdbc.rar/META-INF/ra.xml
14:47:54,783 INFO [RARDeployment] Required license terms exist, view vfs:/D:/Tools/jboss-6.0.0.Final/server/default/deploy/jboss-xa-jdbc.rar/META-INF/ra.xml
14:47:54,790 INFO [RARDeployment] Required license terms exist, view vfs:/D:/Tools/jboss-6.0.0.Final/server/default/deploy/jms-ra.rar/META-INF/ra.xml
14:47:54,828 INFO [HornetQResourceAdapter] HornetQ resource adaptor started
14:47:54,835 INFO [RARDeployment] Required license terms exist, view vfs:/D:/Tools/jboss-6.0.0.Final/server/default/deploy/mail-ra.rar/META-INF/ra.xml
14:47:54,847 INFO [RARDeployment] Required license terms exist, view vfs:/D:/Tools/jboss-6.0.0.Final/server/default/deploy/quartz-ra.rar/META-INF/ra.xml
14:47:54,952 INFO [SimpleThreadPool] Job execution threads will use class loader of thread: Thread-2
14:47:54,984 INFO [SchedulerSignalerImpl] Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
14:47:54,984 INFO [QuartzScheduler] Quartz Scheduler v.1.8.3 created.
14:47:54,987 INFO [RAMJobStore] RAMJobStore initialized.
14:47:54,989 INFO [QuartzScheduler] Scheduler meta-data: Quartz Scheduler (v1.8.3) 'JBossQuartzScheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 10 threads.
Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.
14:47:54,990 INFO [StdSchedulerFactory] Quartz scheduler 'JBossQuartzScheduler' initialized from an externally opened InputStream.
14:47:54,990 INFO [StdSchedulerFactory] Quartz scheduler version: 1.8.3
14:47:54,990 INFO [QuartzScheduler] Scheduler JBossQuartzScheduler_$_NON_CLUSTERED started.
14:47:55,286 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS'
14:47:55,446 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
14:47:55,568 INFO [xnio] XNIO Version 2.1.0.CR2
14:47:55,575 INFO [nio] XNIO NIO Implementation Version 2.1.0.CR2
14:47:55,745 INFO [remoting] JBoss Remoting version 3.1.0.Beta2
14:47:55,825 INFO [TomcatDeployment] deploy, ctxPath=/
14:47:55,854 INFO [service] Removing bootstrap log handlers
14:47:55,906 INFO [org.apache.coyote.http11.Http11Protocol] Starting Coyote HTTP/1.1 on http-localhost%2F127.0.0.1-8080
14:47:55,911 INFO [org.apache.coyote.ajp.AjpProtocol] Starting Coyote AJP/1.3 on ajp-localhost%2F127.0.0.1-8009
14:47:55,912 INFO [org.jboss.bootstrap.impl.base.server.AbstractServer] JBossAS [6.0.0.Final "Neo"] Started in 20s:272ms
14:47:56,306 INFO [org.jboss.jpa.mcint.beans.metadata.plugins.PersistenceUnitValueMetaData] iDependOn persistence.unit:unitName=jboss-ejb3-timerservice-mk2.jar#timerdb
14:47:56,314 INFO [org.jboss.jpa.deployment.PersistenceUnitDeployment] Starting persistence unit persistence.unit:unitName=jboss-ejb3-timerservice-mk2.jar#timerdb
14:47:56,532 INFO [org.hibernate.annotations.common.Version] Hibernate Commons Annotations 3.2.0.Final
14:47:56,542 INFO [org.hibernate.cfg.Environment] Hibernate 3.6.0.Final
14:47:56,545 INFO [org.hibernate.cfg.Environment] hibernate.properties not found
14:47:56,549 INFO [org.hibernate.cfg.Environment] Bytecode provider name : javassist
14:47:56,554 INFO [org.hibernate.cfg.Environment] using JDK 1.4 java.sql.Timestamp handling
14:47:56,660 INFO [org.hibernate.ejb.Version] Hibernate EntityManager 3.6.0.Final
14:47:56,687 INFO [org.hibernate.ejb.Ejb3Configuration] Processing PersistenceUnitInfo [
name: timerdb
...]
14:47:56,706 WARN [org.hibernate.ejb.Ejb3Configuration] Persistence provider caller does not implement the EJB3 spec correctly.PersistenceUnitInfo.getNewTempClassLoader() is null.
14:47:56,799 INFO [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.jboss.ejb3.timerservice.mk2.persistence.TimerEntity
14:47:56,873 INFO [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.jboss.ejb3.timerservice.mk2.persistence.TimerEntity on table timer
14:47:56,950 INFO [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.jboss.ejb3.timerservice.mk2.persistence.TimeoutMethod
14:47:56,957 INFO [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.jboss.ejb3.timerservice.mk2.persistence.TimeoutMethod on table timeout_method
14:47:57,001 INFO [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.jboss.ejb3.timerservice.mk2.persistence.CalendarTimerEntity
14:47:57,003 INFO [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.jboss.ejb3.timerservice.mk2.persistence.CalendarTimerEntity on table calendar_timer
14:47:57,058 INFO [org.hibernate.validator.Version] Hibernate Validator 3.1.0.GA
14:47:57,109 INFO [org.hibernate.validator.util.Version] Hibernate Validator 4.1.0.Final
14:47:57,125 INFO [org.hibernate.validator.engine.resolver.DefaultTraversableResolver] Instantiated an instance of org.hibernate.validator.engine.resolver.JPATraversableResolver.
14:47:57,266 INFO [org.hibernate.validator.engine.resolver.DefaultTraversableResolver] Instantiated an instance of org.hibernate.validator.engine.resolver.JPATraversableResolver.
14:47:57,272 INFO [org.hibernate.validator.engine.resolver.DefaultTraversableResolver] Instantiated an instance of org.hibernate.validator.engine.resolver.JPATraversableResolver.
14:47:57,280 INFO [org.hibernate.cfg.search.HibernateSearchEventListenerRegister] Unable to find org.hibernate.search.event.FullTextIndexEventListener on the classpath. Hibernate Search is not enabled.
14:47:57,294 INFO [org.hibernate.connection.ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
14:47:57,303 INFO [org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider] Using provided datasource
14:47:57,307 INFO [org.hibernate.cfg.SettingsFactory] Database ->
name : HSQL Database Engine
version : 1.8.0
major : 1
minor : 8
14:47:57,307 INFO [org.hibernate.cfg.SettingsFactory] Driver ->
name : HSQL Database Engine Driver
version : 1.8.0
major : 1
minor : 8
14:47:57,342 INFO [org.hibernate.dialect.Dialect] Using dialect: org.hibernate.dialect.HSQLDialect
14:47:57,365 INFO [org.hibernate.engine.jdbc.JdbcSupportLoader] Disabling contextual LOB creation as JDBC driver reported JDBC version [3] less than 4
14:47:57,367 INFO [org.hibernate.transaction.TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
14:47:57,371 INFO [org.hibernate.transaction.TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
14:47:57,374 INFO [org.hibernate.transaction.TransactionManagerLookupFactory] instantiated TransactionManagerLookup
14:47:57,375 INFO [org.hibernate.cfg.SettingsFactory] Automatic flush during beforeCompletion(): disabled
14:47:57,375 INFO [org.hibernate.cfg.SettingsFactory] Automatic session close at end of transaction: disabled
14:47:57,375 INFO [org.hibernate.cfg.SettingsFactory] JDBC batch size: 15
14:47:57,375 INFO [org.hibernate.cfg.SettingsFactory] JDBC batch updates for versioned data: disabled
14:47:57,376 INFO [org.hibernate.cfg.SettingsFactory] Scrollable result sets: enabled
14:47:57,377 INFO [org.hibernate.cfg.SettingsFactory] JDBC3 getGeneratedKeys(): disabled
14:47:57,377 INFO [org.hibernate.cfg.SettingsFactory] Connection release mode: auto
14:47:57,378 INFO [org.hibernate.cfg.SettingsFactory] Default batch fetch size: 1
14:47:57,378 INFO [org.hibernate.cfg.SettingsFactory] Generate SQL with comments: disabled
14:47:57,378 INFO [org.hibernate.cfg.SettingsFactory] Order SQL updates by primary key: disabled
14:47:57,379 INFO [org.hibernate.cfg.SettingsFactory] Order SQL inserts for batching: disabled
14:47:57,379 INFO [org.hibernate.cfg.SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
14:47:57,382 INFO [org.hibernate.hql.ast.ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
14:47:57,382 INFO [org.hibernate.cfg.SettingsFactory] Query language substitutions: {}
14:47:57,382 INFO [org.hibernate.cfg.SettingsFactory] JPA-QL strict compliance: enabled
14:47:57,382 INFO [org.hibernate.cfg.SettingsFactory] Second-level cache: enabled
14:47:57,383 INFO [org.hibernate.cfg.SettingsFactory] Query cache: disabled
14:47:57,384 INFO [org.hibernate.cfg.SettingsFactory] Cache region factory : org.hibernate.cache.impl.bridge.RegionFactoryCacheProviderBridge
14:47:57,392 INFO [org.hibernate.cache.impl.bridge.RegionFactoryCacheProviderBridge] Cache provider: org.hibernate.cache.HashtableCacheProvider
14:47:57,394 INFO [org.hibernate.cfg.SettingsFactory] Optimize cache for minimal puts: disabled
14:47:57,394 INFO [org.hibernate.cfg.SettingsFactory] Cache region prefix: persistence.unit:unitName=jboss-ejb3-timerservice-mk2.jar#timerdb
14:47:57,394 INFO [org.hibernate.cfg.SettingsFactory] Structured second-level cache entries: disabled
14:47:57,405 INFO [org.hibernate.cfg.SettingsFactory] Statistics: disabled
14:47:57,405 INFO [org.hibernate.cfg.SettingsFactory] Deleted entity synthetic identifier rollback: disabled
14:47:57,406 INFO [org.hibernate.cfg.SettingsFactory] Default entity-mode: pojo
14:47:57,406 INFO [org.hibernate.cfg.SettingsFactory] Named query checking : enabled
14:47:57,406 INFO [org.hibernate.cfg.SettingsFactory] Check Nullability in Core (should be disabled when Bean Validation is on): disabled
14:47:57,443 INFO [org.hibernate.impl.SessionFactoryImpl] building session factory
14:47:57,686 INFO [org.hibernate.impl.SessionFactoryObjectFactory] Factory name: persistence.unit:unitName=jboss-ejb3-timerservice-mk2.jar#timerdb
14:47:57,688 INFO [org.hibernate.util.NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
14:47:57,691 INFO [org.hibernate.impl.SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.unit:unitName=jboss-ejb3-timerservice-mk2.jar#timerdb
14:47:57,691 WARN [org.hibernate.impl.SessionFactoryObjectFactory] InitialContext did not implement EventContext
14:47:57,699 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] Running hbm2ddl schema update
14:47:57,700 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] fetching database metadata
14:47:57,701 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] updating schema
14:47:57,703 INFO [org.hibernate.validator.engine.resolver.DefaultTraversableResolver] Instantiated an instance of org.hibernate.validator.engine.resolver.JPATraversableResolver.
14:47:57,728 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] table found: PUBLIC.TIMEOUTMETHOD_METHODPARAMS
14:47:57,729 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [methodparams, timeoutmethod_id]
14:47:57,729 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] foreign keys: [fkf294c964b7de2d8a]
14:47:57,729 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] indexes: [sys_idx_55]
14:47:57,738 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] table found: PUBLIC.CALENDAR_TIMER
14:47:57,738 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [id, scheduleexprdayofmonth, scheduleexprenddate, scheduleexprtimezone, scheduleexprsecond, autotimer, scheduleexprmonth, scheduleexprstartdate, scheduleexprminute, scheduleexprdayofweek, scheduleexpryear, scheduleexprhour, timeoutmethod_id]
14:47:57,738 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] foreign keys: [fk2b697f04b7de2d8a, fk2b697f04e6e6ef93]
14:47:57,739 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] indexes: [sys_idx_57, sys_idx_49, sys_idx_59]
14:47:57,746 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] table found: PUBLIC.TIMEOUT_METHOD
14:47:57,746 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [id, methodname, declaringclass]
14:47:57,746 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] foreign keys: []
14:47:57,746 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] indexes: [sys_idx_51]
14:47:57,759 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] table found: PUBLIC.TIMER
14:47:57,759 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [id, previousrun, initialdate, repeatinterval, timedobjectid, timerstate, nextdate, info]
14:47:57,759 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] foreign keys: []
14:47:57,759 INFO [org.hibernate.tool.hbm2ddl.TableMetadata] indexes: [sys_idx_53]
14:47:57,761 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] schema update complete
14:47:57,766 INFO [org.hibernate.util.NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
14:47:57,869 INFO [org.jboss.ejb3.deployers.Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@1141435756{vfs:///C:/Users/admin/Desktop/Work/Skyvva/EJBWorkSpace2/.metadata/.plugins/org.jboss.ide.eclipse.as.core/JBoss_AS_6.x1522312172779/deploy/EJBProject.jar}
14:47:57,870 INFO [org.jboss.ejb3.deployers.Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@1141435756{vfs:///C:/Users/admin/Desktop/Work/Skyvva/EJBWorkSpace2/.metadata/.plugins/org.jboss.ide.eclipse.as.core/JBoss_AS_6.x1522312172779/deploy/EJBProject.jar}
14:47:57,890 INFO [org.jboss.ejb3.instantiator.deployer.BeanInstantiatorDeployerBase] Installed org.jboss.ejb3.instantiator.impl.Ejb31SpecBeanInstantiator@58c58c2b into MC at org.jboss.ejb.bean.instantiator/EJBProject/EJBProject/StreamingEJB
14:47:57,899 WARN [org.jboss.ejb3.interceptor.InterceptorInfoRepository] EJBTHREE-1852: InterceptorInfoRepository is deprecated
14:47:58,204 INFO [org.jboss.ejb3.deployers.JBossASKernel] Created KernelDeployment for: EJBProject.jar
14:47:58,207 INFO [org.jboss.ejb3.deployers.JBossASKernel] installing bean: jboss.j2ee:jar=EJBProject.jar,name=StreamingEJB,service=EJB3
14:47:58,207 INFO [org.jboss.ejb3.deployers.JBossASKernel] with dependencies:
14:47:58,207 INFO [org.jboss.ejb3.deployers.JBossASKernel] and demands:
14:47:58,207 INFO [org.jboss.ejb3.deployers.JBossASKernel] jboss.ejb:service=EJBTimerService; Required: Described
14:47:58,207 INFO [org.jboss.ejb3.deployers.JBossASKernel] jboss-switchboard:appName=EJBProject,module=EJBProject,name=StreamingEJB; Required: Create
14:47:58,208 INFO [org.jboss.ejb3.deployers.JBossASKernel] and supplies:
14:47:58,208 INFO [org.jboss.ejb3.deployers.JBossASKernel] Class:src.StreamingEJBRemote
14:47:58,208 INFO [org.jboss.ejb3.deployers.JBossASKernel] jndi:StreamingBean
14:47:58,208 INFO [org.jboss.ejb3.deployers.JBossASKernel] jndi:StreamingEJB/remote-src.StreamingEJBRemote
14:47:58,212 INFO [org.jboss.ejb3.deployers.JBossASKernel] Added bean(jboss.j2ee:jar=EJBProject.jar,name=StreamingEJB,service=EJB3) to KernelDeployment of: EJBProject.jar
14:47:58,259 INFO [org.jboss.ejb3.session.SessionSpecContainer] Starting jboss.j2ee:jar=EJBProject.jar,name=StreamingEJB,service=EJB3
14:47:58,264 INFO [org.jboss.ejb3.EJBContainer] STARTED EJB: src.StreamingEJB ejbName: StreamingEJB
14:47:58,294 INFO [org.jboss.ejb3.proxy.impl.jndiregistrar.JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:
StreamingBean - EJB3.x Default Remote Business Interface
StreamingEJB/remote-src.StreamingEJBRemote - EJB3.x Remote Business Interface
14:47:58,295 WARN [org.jboss.ejb3.TimerServiceContainer] EJBTHREE-2193: using deprecated TimerServiceFactory for restoring timers
When running the client, the context lookup hangs:
Some line to breakpoint Mar 29, 2018 2:54:12 PM org.jboss.naming.remote.client.InitialContextFactory INFO: WFNAM00025: org.jboss.naming.remote.client.InitialContextFactory is deprecated; new applications should use org.wildfly.naming.client.WildFlyInitialContextFactory instead Mar 29, 2018 2:54:13 PM org.wildfly.naming.client.Version INFO: WildFly Naming version 1.0.7.Final Mar 29, 2018 2:54:15 PM org.wildfly.security.Version INFO: ELY00001: WildFly Elytron version 1.1.6.Final Looking up bean CallerBean Mar 29, 2018 2:54:17 PM org.xnio.Xnio INFO: XNIO version 3.5.4.Final Mar 29, 2018 2:54:18 PM org.xnio.nio.NioXnio INFO: XNIO NIO Implementation Version 3.5.4.Final Mar 29, 2018 2:54:20 PM org.jboss.remoting3.EndpointImpl INFO: JBoss Remoting version 5.0.5.Final
This behavior persists when running using either jdk 1.7 and 1.8 and across all server instances. JBoss AS 7.1 and Wild 11.0 both have preconfigured management users and deploy successfully but the client fails to lookup the bean. Why?