Uploaded image for project: 'JBoss Enterprise Application Platform'
  1. JBoss Enterprise Application Platform
  2. JBEAP-1982

Unable to announce backup in dedicated topology with shared store

XMLWordPrintable

    • Icon: Bug Bug
    • Resolution: Done
    • Icon: Blocker Blocker
    • 7.0.0.ER4
    • 7.0.0.ER1
    • ActiveMQ
    • Regression
      1. Start master and slave
      2. Stop master
      3. Start master

      The "Unable to announce backup, retrying" message occurs after failback.

      Slave's log after failback
      15:05:33,463 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (Incoming-13,ee,dhcp-10-40-4-101) ISPN000094: Received new cluster view for channel server: [dhcp-10-40-4-101|3] (2) [dhcp-10-40-4-101, dhcp-10-40-4-101]
      15:05:33,463 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (Incoming-13,ee,dhcp-10-40-4-101) ISPN000094: Received new cluster view for channel web: [dhcp-10-40-4-101|3] (2) [dhcp-10-40-4-101, dhcp-10-40-4-101]
      15:05:33,465 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (Incoming-13,ee,dhcp-10-40-4-101) ISPN000094: Received new cluster view for channel ejb: [dhcp-10-40-4-101|3] (2) [dhcp-10-40-4-101, dhcp-10-40-4-101]
      15:05:33,469 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (Incoming-13,ee,dhcp-10-40-4-101) ISPN000094: Received new cluster view for channel hibernate: [dhcp-10-40-4-101|3] (2) [dhcp-10-40-4-101, dhcp-10-40-4-101]
      15:05:35,338 INFO  [org.apache.activemq.artemis.core.server] (Thread-4 (ActiveMQ-scheduled-threads-676226487)) AMQ221008: live server wants to restart, restarting server in backup
      15:05:35,352 WARN  [org.apache.activemq.artemis.core.client] (Thread-1 (ActiveMQ-client-global-threads-1881194069)) AMQ212037: Connection failure has been detected: AMQ119015: The connection was disconnected because of server shutdown [code=DISCONNECTED]
      15:05:35,354 WARN  [org.jboss.activemq.artemis.wildfly.integration.recovery] (Thread-1 (ActiveMQ-client-global-threads-1881194069)) being disconnected for server shutdown: ActiveMQDisconnectedException[errorType=DISCONNECTED message=AMQ119015: The connection was disconnected because of server shutdown]
      	at org.apache.activemq.artemis.core.client.impl.ClientSessionFactoryImpl$CloseRunnable.run(ClientSessionFactoryImpl.java:972) [artemis-core-client-1.1.0.redhat-2.jar:1.1.0.redhat-2]
      	at org.apache.activemq.artemis.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:94) [artemis-core-client-1.1.0.redhat-2.jar:1.1.0.redhat-2]
      	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_65]
      	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_65]
      	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_65]
      
      15:05:35,362 INFO  [org.wildfly.extension.messaging-activemq] (MSC service thread 1-2) WFLYMSGAMQ0006: Unbound messaging object to jndi name java:jboss/DefaultJMSConnectionFactory
      15:05:35,362 INFO  [org.jboss.as.connector.deployment] (MSC service thread 1-1) WFLYJCA0011: Unbound JCA ConnectionFactory [java:/JmsXA]
      15:05:35,369 INFO  [org.wildfly.extension.messaging-activemq] (Thread-114) WFLYMSGAMQ0006: Unbound messaging object to jndi name java:/ConnectionFactory
      15:05:35,376 INFO  [org.wildfly.extension.messaging-activemq] (Thread-114) WFLYMSGAMQ0006: Unbound messaging object to jndi name java:jboss/exported/jms/RemoteConnectionFactory
      15:05:35,378 INFO  [org.apache.activemq.artemis.ra] (ServerService Thread Pool -- 20) AMQ151003: resource adaptor stopped
      15:05:35,380 WARN  [org.wildfly.extension.messaging-activemq] (ServerService Thread Pool -- 12) WFLYMSGAMQ0004: Failed to destroy queue: divertedQueue: java.lang.IllegalStateException: Cannot access JMS Server, core server is not yet active
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.checkInitialised(JMSServerManagerImpl.java:1363)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.access$1100(JMSServerManagerImpl.java:101)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl$3.runException(JMSServerManagerImpl.java:660)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.runAfterActive(JMSServerManagerImpl.java:1526)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.removeQueueFromBindingRegistry(JMSServerManagerImpl.java:652)
      	at org.wildfly.extension.messaging.activemq.jms.JMSQueueService$2.run(JMSQueueService.java:101)
      	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_65]
      	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_65]
      	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_65]
      	at org.jboss.threads.JBossThread.run(JBossThread.java:320) [jboss-threads-2.2.1.Final-redhat-1.jar:2.2.1.Final-redhat-1]
      
      15:05:35,380 WARN  [org.wildfly.extension.messaging-activemq] (ServerService Thread Pool -- 3) WFLYMSGAMQ0004: Failed to destroy jms topic: testTopic0: java.lang.IllegalStateException: Cannot access JMS Server, core server is not yet active
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.checkInitialised(JMSServerManagerImpl.java:1363)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.access$1100(JMSServerManagerImpl.java:101)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl$4.runException(JMSServerManagerImpl.java:700)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.runAfterActive(JMSServerManagerImpl.java:1526)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.removeTopicFromBindingRegistry(JMSServerManagerImpl.java:692)
      	at org.wildfly.extension.messaging.activemq.jms.JMSTopicService$2.run(JMSTopicService.java:95)
      	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_65]
      	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_65]
      	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_65]
      	at org.jboss.threads.JBossThread.run(JBossThread.java:320) [jboss-threads-2.2.1.Final-redhat-1.jar:2.2.1.Final-redhat-1]
      
      15:05:35,380 WARN  [org.wildfly.extension.messaging-activemq] (ServerService Thread Pool -- 28) WFLYMSGAMQ0004: Failed to destroy queue: DLQ: java.lang.IllegalStateException: Cannot access JMS Server, core server is not yet active
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.checkInitialised(JMSServerManagerImpl.java:1363)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.access$1100(JMSServerManagerImpl.java:101)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl$3.runException(JMSServerManagerImpl.java:660)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.runAfterActive(JMSServerManagerImpl.java:1526)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.removeQueueFromBindingRegistry(JMSServerManagerImpl.java:652)
      	at org.wildfly.extension.messaging.activemq.jms.JMSQueueService$2.run(JMSQueueService.java:101)
      	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_65]
      	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_65]
      	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_65]
      	at org.jboss.threads.JBossThread.run(JBossThread.java:320) [jboss-threads-2.2.1.Final-redhat-1.jar:2.2.1.Final-redhat-1]
      
      15:05:35,381 WARN  [org.wildfly.extension.messaging-activemq] (ServerService Thread Pool -- 71) WFLYMSGAMQ0004: Failed to destroy queue: testQueue0: java.lang.IllegalStateException: Cannot access JMS Server, core server is not yet active
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.checkInitialised(JMSServerManagerImpl.java:1363)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.access$1100(JMSServerManagerImpl.java:101)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl$3.runException(JMSServerManagerImpl.java:660)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.runAfterActive(JMSServerManagerImpl.java:1526)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.removeQueueFromBindingRegistry(JMSServerManagerImpl.java:652)
      	at org.wildfly.extension.messaging.activemq.jms.JMSQueueService$2.run(JMSQueueService.java:101)
      	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_65]
      	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_65]
      	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_65]
      	at org.jboss.threads.JBossThread.run(JBossThread.java:320) [jboss-threads-2.2.1.Final-redhat-1.jar:2.2.1.Final-redhat-1]
      
      15:05:35,382 WARN  [org.wildfly.extension.messaging-activemq] (ServerService Thread Pool -- 19) WFLYMSGAMQ0004: Failed to destroy queue: ExpiryQueue: java.lang.IllegalStateException: Cannot access JMS Server, core server is not yet active
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.checkInitialised(JMSServerManagerImpl.java:1363)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.access$1100(JMSServerManagerImpl.java:101)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl$3.runException(JMSServerManagerImpl.java:660)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.runAfterActive(JMSServerManagerImpl.java:1526)
      	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.removeQueueFromBindingRegistry(JMSServerManagerImpl.java:652)
      	at org.wildfly.extension.messaging.activemq.jms.JMSQueueService$2.run(JMSQueueService.java:101)
      	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_65]
      	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_65]
      	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_65]
      	at org.jboss.threads.JBossThread.run(JBossThread.java:320) [jboss-threads-2.2.1.Final-redhat-1.jar:2.2.1.Final-redhat-1]
      
      15:05:35,384 INFO  [org.apache.activemq.artemis.jms.server] (ServerService Thread Pool -- 14) AMQ121004: JMS Server Manager Caching command for destroyConnectionFactory for InVmConnectionFactory since the JMS Server is not active yet
      15:05:35,384 INFO  [org.apache.activemq.artemis.jms.server] (ServerService Thread Pool -- 29) AMQ121004: JMS Server Manager Caching command for destroyConnectionFactory for RemoteConnectionFactory since the JMS Server is not active yet
      15:05:35,427 INFO  [org.apache.activemq.artemis.core.server] (Thread-114) AMQ221002: Apache ActiveMQ Artemis Message Broker version 1.1.0.redhat-2 [a44fd193-91e9-11e5-b30b-336bc6c3e5d1] stopped
      15:05:37,429 INFO  [org.apache.activemq.artemis.core.server] (Thread-114) AMQ221000: backup Message Broker is starting with configuration Broker Configuration (clustered=true,journalDirectory=/home/eduda/Projects/eap-tests-hornetq/journal-A/journal,bindingsDirectory=/home/eduda/Projects/eap-tests-hornetq/journal-A/bindings,largeMessagesDirectory=/home/eduda/Projects/eap-tests-hornetq/journal-A/largemessages,pagingDirectory=/home/eduda/Projects/eap-tests-hornetq/journal-A/paging)
      15:05:37,429 INFO  [org.apache.activemq.artemis.core.server] (AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=a44fd193-91e9-11e5-b30b-336bc6c3e5d1) AMQ221032: Waiting to become backup node
      15:05:37,430 INFO  [org.apache.activemq.artemis.core.server] (AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=a44fd193-91e9-11e5-b30b-336bc6c3e5d1) AMQ221033: ** got backup lock
      15:05:37,430 INFO  [org.apache.activemq.artemis.core.server] (AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=a44fd193-91e9-11e5-b30b-336bc6c3e5d1) AMQ221012: Using AIO Journal
      15:05:37,434 INFO  [org.apache.activemq.artemis.core.server] (AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=a44fd193-91e9-11e5-b30b-336bc6c3e5d1) AMQ221043: Protocol module found: [artemis-server]. Adding protocol support for: CORE
      15:05:37,435 INFO  [org.apache.activemq.artemis.core.server] (AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=a44fd193-91e9-11e5-b30b-336bc6c3e5d1) AMQ221043: Protocol module found: [artemis-hornetq-protocol]. Adding protocol support for: HORNETQ
      15:05:37,438 INFO  [org.apache.activemq.artemis.core.server] (AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=a44fd193-91e9-11e5-b30b-336bc6c3e5d1) AMQ221109: Apache ActiveMQ Artemis Backup Server version 1.1.0.redhat-2 [a44fd193-91e9-11e5-b30b-336bc6c3e5d1] started, waiting live to fail before it gets active
      15:05:47,440 WARN  [org.apache.activemq.artemis.core.server] (Thread-1 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$2@7f88a925-1901021348)) AMQ222137: Unable to announce backup, retrying
      15:05:57,942 WARN  [org.apache.activemq.artemis.core.server] (Thread-2 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$2@7f88a925-1901021348)) AMQ222137: Unable to announce backup, retrying
      15:06:08,443 WARN  [org.apache.activemq.artemis.core.server] (Thread-3 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$2@7f88a925-1901021348)) AMQ222137: Unable to announce backup, retrying
      15:06:18,945 WARN  [org.apache.activemq.artemis.core.server] (Thread-4 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$2@7f88a925-1901021348)) AMQ222137: Unable to announce backup, retrying
      15:06:29,446 WARN  [org.apache.activemq.artemis.core.server] (Thread-5 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$2@7f88a925-1901021348)) AMQ222137: Unable to announce backup, retrying
      15:06:39,947 WARN  [org.apache.activemq.artemis.core.server] (Thread-6 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$2@7f88a925-1901021348)) AMQ222137: Unable to announce backup, retrying
      15:06:50,448 WARN  [org.apache.activemq.artemis.core.server] (Thread-7 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$2@7f88a925-1901021348)) AMQ222137: Unable to announce backup, retrying
      

        1. master.xml
          28 kB
        2. slave.xml
          28 kB

              rh-ee-ataylor Andy Taylor
              eduda_jira Erich Duda (Inactive)
              Votes:
              0 Vote for this issue
              Watchers:
              5 Start watching this issue

                Created:
                Updated:
                Resolved: