3 Replies Latest reply on Sep 25, 2012 3:28 AM by caraldel

    Problems with Clustering: 2 standalone on different PCs but in same network

    caraldel

      Hi everybody,

       

      I have this issue when I'm trying to connect to the other node of the cluster:

       

      16:05:56,655 INFO  [org.jboss.modules] JBoss Modules version 1.1.1.GA

      16:05:56,771 INFO  [org.jboss.msc] JBoss MSC version 1.0.2.GA

      16:05:56,804 INFO  [org.jboss.as] JBAS015899: JBoss AS 7.1.1.Final "Brontes" starting

      16:05:57,530 INFO  [org.xnio] XNIO Version 3.0.3.GA

      16:05:57,531 INFO  [org.jboss.as.server] JBAS015888: Creating http management service using socket-binding (management-http)

      16:05:57,537 INFO  [org.xnio.nio] XNIO NIO Implementation Version 3.0.3.GA

      16:05:57,542 INFO  [org.jboss.remoting] JBoss Remoting version 3.2.3.GA

      16:05:57,552 INFO  [org.jboss.as.logging] JBAS011502: Removing bootstrap log handlers

      16:05:57,553 INFO  [org.jboss.as.configadmin] (ServerService Thread Pool -- 34) JBAS016200: Activating ConfigAdmin Subsystem

      16:05:57,559 INFO  [org.jboss.as.jacorb] (ServerService Thread Pool -- 40) JBAS016300: Activating JacORB Subsystem

      16:05:57,587 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 39) JBAS010280: Activating Infinispan subsystem.

      16:05:57,589 INFO  [org.jboss.as.osgi] (ServerService Thread Pool -- 53) JBAS011940: Activating OSGi Subsystem

      16:05:57,596 INFO  [org.jboss.as.clustering.jgroups] (ServerService Thread Pool -- 45) JBAS010260: Activating JGroups subsystem.

      16:05:57,603 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 58) JBAS013101: Activating Security Subsystem

      16:05:57,625 INFO  [org.jboss.as.webservices] (ServerService Thread Pool -- 62) JBAS015537: Activating WebServices Extension

      16:05:57,662 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 35) JBAS010403: Deploying JDBC-compliant driver class oracle.jdbc.OracleDriver (version 11.1)

      16:05:57,687 INFO  [org.jboss.as.connector] (MSC service thread 1-1) JBAS010408: Starting JCA Subsystem (JBoss IronJacamar 1.0.9.Final)

      16:05:57,709 INFO  [org.jboss.as.security] (MSC service thread 1-6) JBAS013100: Current PicketBox version=4.0.7.Final

      16:05:57,711 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 52) JBAS011800: Activating Naming Subsystem

      16:05:57,738 INFO  [org.jboss.as.naming] (MSC service thread 1-6) JBAS011802: Starting Naming Service

      16:05:57,742 INFO  [org.jboss.jaxr] (MSC service thread 1-6) JBAS014000: Started JAXR subsystem, binding JAXR connection factory into JNDI as: java:jboss/jaxr/ConnectionFactory

      16:05:57,748 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-6) JBAS015400: Bound mail session [java:jboss/mail/Default]

      16:05:57,764 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (ServerService Thread Pool -- 39) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      16:05:57,771 INFO  [org.jboss.ws.common.management.AbstractServerConfig] (MSC service thread 1-5) JBoss Web Services - Stack CXF Server 4.0.2.GA

      16:05:57,773 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (ServerService Thread Pool -- 39) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      16:05:57,889 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-6) Arrancando Coyote HTTP/1.1 en puerto http--0.0.0.0-8080

      16:05:57,890 INFO  [org.apache.coyote.ajp.AjpProtocol] (MSC service thread 1-1) Arrancando Coyote AJP/1.3 en ajp--0.0.0.0-8009

      16:05:57,929 INFO  [org.jboss.modcluster.ModClusterService] (MSC service thread 1-7) Initializing mod_cluster 1.2.0.Final

      16:05:57,938 INFO  [org.jboss.modcluster.advertise.impl.AdvertiseListenerImpl] (MSC service thread 1-7) Listening to proxy advertisements on 224.0.1.105:23364

      ...

      16:05:58,052 INFO  [org.jboss.as.remoting] (MSC service thread 1-5) JBAS017100: Listening on /127.0.0.1:9999

      16:05:58,052 INFO  [org.jboss.as.remoting] (MSC service thread 1-2) JBAS017100: Listening on 0.0.0.0/0.0.0.0:4447

      16:05:58,063 INFO  [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-5) live server is starting with configuration HornetQ Configuration (clustered=true,backup=false,sharedStore=true,journalDirectory=C:\jboss-as-7.1.1.Final\standalone\data\messagingjournal,bindingsDirectory=C:\jboss-as-7.1.1.Final\standalone\data\messagingbindings,largeMessagesDirectory=C:\jboss-as-7.1.1.Final\standalone\data\messaginglargemessages,pagingDirectory=C:\jboss-as-7.1.1.Final\standalone\data\messagingpaging)

      16:05:58,067 INFO  [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-5) Waiting to obtain live lock

      ...

      16:05:58,225 INFO  [org.hornetq.core.persistence.impl.journal.JournalStorageManager] (MSC service thread 1-5) Using NIO Journal

      16:05:58,247 INFO  [org.jboss.as.jacorb] (MSC service thread 1-2) JBAS016328: CORBA Naming Service started

      ...

      16:05:58,592 INFO  [org.hornetq.core.server.impl.FileLockNodeManager] (MSC service thread 1-5) Waiting to obtain live lock

      16:05:58,593 INFO  [org.hornetq.core.server.impl.FileLockNodeManager] (MSC service thread 1-5) Live Server Obtained live lock

      16:05:58,778 WARN  [org.hornetq.core.server.cluster.impl.BroadcastGroupImpl] (MSC service thread 1-5) local-bind-address specified for broadcast group but no local-bind-port specified so socket will NOT be bound to a local address/port

      16:05:58,807 INFO  [org.hornetq.core.remoting.impl.netty.NettyAcceptor] (MSC service thread 1-5) Started Netty Acceptor version 3.2.5.Final-a96d88c 0.0.0.0:5445 for CORE protocol

      16:05:58,809 INFO  [org.hornetq.core.remoting.impl.netty.NettyAcceptor] (MSC service thread 1-5) Started Netty Acceptor version 3.2.5.Final-a96d88c 0.0.0.0:5455 for CORE protocol

      16:05:58,811 INFO  [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-5) Server is now live

      16:05:58,812 INFO  [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-5) HornetQ Server version 2.2.13.Final (HQ_2_2_13_FINAL_AS7, 122) [0f934aa3-0334-11e2-980a-306f20524153]) started

      ...

      16:05:58,853 INFO  [org.jboss.as.deployment.connector] (MSC service thread 1-6) JBAS010406: Registered connection factory java:/JmsXA

      16:05:58,860 INFO  [org.hornetq.ra.HornetQResourceAdapter] (MSC service thread 1-6) HornetQ resource adaptor started

      16:05:58,861 INFO  [org.jboss.as.connector.services.ResourceAdapterActivatorService$ResourceAdapterActivator] (MSC service thread 1-6) IJ020002: Deployed: file://RaActivatorhornetq-ra

      16:05:58,864 INFO  [org.jboss.as.deployment.connector] (MSC service thread 1-2) JBAS010401: Bound JCA ConnectionFactory [java:/JmsXA]

      ...

      16:05:58,972 ERROR [org.jboss.remoting.remote.connection] (Remoting "cordon1" read-1) JBREM000200: Remote connection failed: javax.security.sasl.SaslException: Authentication failed: all available authentication mechanisms failed

      ...

      16:05:59,204 INFO  [stdout] (pool-12-thread-1)

      16:05:59,204 INFO  [stdout] (pool-12-thread-1) -------------------------------------------------------------------

      16:05:59,205 INFO  [stdout] (pool-12-thread-1) GMS: address=cordon1/web, cluster=web, physical address=0.0.0.0:55200

      16:05:59,206 INFO  [stdout] (pool-12-thread-1) -------------------------------------------------------------------

       

       

      16:05:59,210 GRAVE [org.jgroups.protocols.UDP] (OOB-1,null) failed sending message to cordon1/web (100 bytes): java.lang.Exception: dest=0.0.0.0/0.0.0.0:55200 (103 bytes), cause: java.net.BindException: Cannot assign requested address: Datagram send failed

      16:06:00,703 INFO  [org.hornetq.core.server.cluster.impl.BridgeImpl] (Thread-13 (HornetQ-server-HornetQServerImpl::serverUUID=0f934aa3-0334-11e2-980a-306f20524153-1651241)) Bridge ClusterConnectionBridge@85ce5a [name=sf.my-cluster.b1cd7606-032d-11e2-a94d-c8600098ea6e, queue=QueueImpl[name=sf.my-cluster.b1cd7606-032d-11e2-a94d-c8600098ea6e, postOffice=PostOfficeImpl [server=HornetQServerImpl::serverUUID=0f934aa3-0334-11e2-980a-306f20524153]]@ae8764 targetConnector=ServerLocatorImpl (identity=(Cluster-connection-bridge::ClusterConnectionBridge@85ce5a [name=sf.my-cluster.b1cd7606-032d-11e2-a94d-c8600098ea6e, queue=QueueImpl[name=sf.my-cluster.b1cd7606-032d-11e2-a94d-c8600098ea6e, postOffice=PostOfficeImpl [server=HornetQServerImpl::serverUUID=0f934aa3-0334-11e2-980a-306f20524153]]@ae8764 targetConnector=ServerLocatorImpl [initialConnectors=[org-hornetq-core-remoting-impl-netty-NettyConnectorFactory?port=5445&host=0-0-0-0], discoveryGroupConfiguration=null]]::ClusterConnectionImpl@23990545[nodeUUID=0f934aa3-0334-11e2-980a-306f20524153, connector=org-hornetq-core-remoting-impl-netty-NettyConnectorFactory?port=5445&host=0-0-0-0, address=jms, server=HornetQServerImpl::serverUUID=0f934aa3-0334-11e2-980a-306f20524153])) [initialConnectors=[org-hornetq-core-remoting-impl-netty-NettyConnectorFactory?port=5445&host=0-0-0-0], discoveryGroupConfiguration=null]] is connected

      16:06:01,344 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (MSC service thread 1-8) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      16:06:01,344 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (MSC service thread 1-4) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      16:06:01,379 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (pool-14-thread-1) ISPN000078: Starting JGroups Channel

      16:06:01,383 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (pool-14-thread-1) ISPN000094: Received new cluster view: [cordon1/web|0] [cordon1/web]

      16:06:01,385 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (pool-14-thread-1) ISPN000079: Cache local address is cordon1/web, physical addresses are [0.0.0.0:55200]

      16:06:01,388 INFO  [org.infinispan.factories.GlobalComponentRegistry] (pool-14-thread-1) ISPN000128: Infinispan version: Infinispan 'Brahma' 5.1.2.FINAL

      16:06:01,390 INFO  [org.infinispan.config.ConfigurationValidatingVisitor] (pool-14-thread-1) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      16:06:01,454 INFO  [org.infinispan.jmx.CacheJmxRegistration] (pool-14-thread-1) ISPN000031: MBeans were successfully registered to the platform mbean server.

      16:06:01,465 INFO  [org.jboss.as.clustering.infinispan] (pool-14-thread-1) JBAS010281: Started repl cache from web container

      16:06:01,472 INFO  [org.jboss.as.clustering.impl.CoreGroupCommunicationService.web] (MSC service thread 1-4) JBAS010206: Number of cluster members: 1

      16:06:01,490 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (MSC service thread 1-8) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      16:06:01,493 INFO  [org.infinispan.config.ConfigurationValidatingVisitor] (MSC service thread 1-8) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      16:06:01,506 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-8) ISPN000031: MBeans were successfully registered to the platform mbean server.

      16:06:01,508 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-8) JBAS010281: Started //default-host//MiddlewareWEB cache from web container

      16:06:01,515 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (MSC service thread 1-8) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      16:06:01,517 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (MSC service thread 1-8) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be pasivated.

      ...

      16:06:01,616 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin console listening on http://127.0.0.1:9990

      16:06:01,617 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss AS 7.1.1.Final "Brontes" started in 5111ms - Started 611 of 771 services (156 services are passive or on-demand)

      16:06:02,002 INFO  [org.jboss.as.server.deployment.scanner] (MSC service thread 1-1) JBAS015012: Started FileSystemDeploymentService for directory C:\Users\Carlos\workspaceIn\.metadata\.plugins\org.jboss.ide.eclipse.as.core\JBoss_7.1_Runtime_Server1348153198701\deploy

      16:06:03,621 ADVERTENCIA [org.jgroups.protocols.pbcast.NAKACK] (OOB-3,null) cordon1/web: dropped message 13 from 4a0a8551-56d4-0fa6-9642-5988e4a61cff (sender not in table [cordon1/web]), view=[cordon1/web|0] [cordon1/web]

      16:06:04,546 ADVERTENCIA [org.jgroups.protocols.pbcast.NAKACK] (OOB-4,null) cordon1/web: dropped message 14 from 4a0a8551-56d4-0fa6-9642-5988e4a61cff (sender not in table [cordon1/web]), view=[cordon1/web|0] [cordon1/web]

      16:06:10,411 GRAVE [org.jgroups.protocols.UDP] (OOB-12,null) failed sending message to cordon1/web (118 bytes): java.lang.Exception: dest=0.0.0.0/0.0.0.0:55200 (121 bytes), cause: java.net.BindException: Cannot assign requested address: Datagram send failed

      16:06:13,058 GRAVE [org.jgroups.protocols.UDP] (OOB-14,null) failed sending message to cordon1/web (118 bytes): java.lang.Exception: dest=0.0.0.0/0.0.0.0:55200 (121 bytes), cause: java.net.BindException: Cannot assign requested address: Datagram send failed

      16:06:15,373 GRAVE [org.jgroups.protocols.UDP] (OOB-16,null) failed sending message to cordon1/web (118 bytes): java.lang.Exception: dest=0.0.0.0/0.0.0.0:55200 (121 bytes), cause: java.net.BindException: Cannot assign requested address: Datagram send failed

      16:06:16,373 ADVERTENCIA [org.jgroups.protocols.UDP] (OOB-11,null) null: no physical address for 4a0a8551-56d4-0fa6-9642-5988e4a61cff, dropping message

      16:06:17,274 GRAVE [org.jgroups.protocols.UDP] (OOB-19,null) failed sending message to cordon1/web (118 bytes): java.lang.Exception: dest=0.0.0.0/0.0.0.0:55200 (121 bytes), cause: java.net.BindException: Cannot assign requested address: Datagram send failed

      16:06:19,749 GRAVE [org.jgroups.protocols.UDP] (OOB-19,null) failed sending message to cordon1/web (118 bytes): java.lang.Exception: dest=0.0.0.0/0.0.0.0:55200 (121 bytes), cause: java.net.BindException: Cannot assign requested address: Datagram send failed

      16:06:22,091 GRAVE [org.jgroups.protocols.UDP] (OOB-19,null) failed sending message to cordon1/web (118 bytes): java.lang.Exception: dest=0.0.0.0/0.0.0.0:55200 (121 bytes), cause: java.net.BindException: Cannot assign requested address: Datagram send failed

      16:06:23,091 ADVERTENCIA [org.jgroups.protocols.UDP] (OOB-18,null) null: no physical address for 4a0a8551-56d4-0fa6-9642-5988e4a61cff, dropping message

       

      and the same to eternety. What is happening? I use the file standalone-full-ha.xml configuration because I need clustering and datasources with JMS.

       

      Thank you in advance !