Uploaded image for project: 'JBoss A-MQ'
  1. JBoss A-MQ
  2. ENTMQ-1654

Revisit the log level in LeaseDatabaseLocker

    XMLWordPrintable

Details

    • Story
    • Resolution: Done
    • Major
    • JBoss A-MQ 6.3
    • JBoss A-MQ 6.2.1, JBoss A-MQ 6.3
    • jdbc
    • None
    • User Experience

    Description

      We are using jdbc persistent and using master/slave topology.

             <persistenceAdapter>
                <jdbcPersistenceAdapter dataDirectory="${data}" dataSource="#oracle-ds" lockKeepAlivePeriod="5000">
                  <locker>
                    <lease-database-locker lockAcquireSleepInterval="10000"/>
                  </locker>
                </jdbcPersistenceAdapter>
          </persistenceAdapter>
      

      There are too many logs like below every 10 seconds:

      2016-04-18 11:50:49,773 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  101 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 failed to acquire lease.  Sleeping for 10000 milli(s) before trying again...
      2016-04-18 11:50:59,776 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  117 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 Lease held by AMQ_PR_01 till Mon Apr 18 11:51:09 AEST 2016
      2016-04-18 11:50:59,776 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  101 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 failed to acquire lease.  Sleeping for 10000 milli(s) before trying again...
      2016-04-18 11:51:09,779 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  117 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 Lease held by AMQ_PR_01 till Mon Apr 18 11:51:19 AEST 2016
      2016-04-18 11:51:09,779 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  101 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 failed to acquire lease.  Sleeping for 10000 milli(s) before trying again...
      2016-04-18 11:51:19,782 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  117 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 Lease held by AMQ_PR_01 till Mon Apr 18 11:51:29 AEST 2016
      2016-04-18 11:51:19,782 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  101 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 failed to acquire lease.  Sleeping for 10000 milli(s) before trying again...
      2016-04-18 11:51:29,786 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  117 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 Lease held by AMQ_PR_01 till Mon Apr 18 11:51:39 AEST 2016
      2016-04-18 11:51:29,786 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  101 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 failed to acquire lease.  Sleeping for 10000 milli(s) before trying again...
      2016-04-18 11:51:39,790 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  117 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 Lease held by AMQ_PR_01 till Mon Apr 18 11:51:49 AEST 2016
      2016-04-18 11:51:39,790 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  101 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 failed to acquire lease.  Sleeping for 10000 milli(s) before trying again...
      2016-04-18 11:51:49,793 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  117 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 Lease held by AMQ_PR_01 till Mon Apr 18 11:51:59 AEST 2016
      2016-04-18 11:51:49,793 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  101 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 failed to acquire lease.  Sleeping for 10000 milli(s) before trying again...
      2016-04-18 11:51:50,235 | INFO  | ]-timer-thread-1 | ServerSession                    | d.common.session.AbstractSession 1052 | 39 - org.apache.sshd.core - 0.12.0.redhat-002 | Disconnecting: Session has timed out waiting for authentication after 120000 ms.
      2016-04-18 11:51:59,796 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  117 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 Lease held by AMQ_PR_01 till Mon Apr 18 11:52:09 AEST 2016
      2016-04-18 11:51:59,797 | INFO  | pool-13-thread-1 | LeaseDatabaseLocker              | q.store.jdbc.LeaseDatabaseLocker  101 | 171 - org.apache.activemq.activemq-osgi - 5.11.0.redhat-620133 | AMQ_PR_02 failed to acquire lease.  Sleeping for 10000 milli(s) before trying again...
      
      

      Can this log being changed to debug level?

      and for this line, since it is in the exception , can change to a warn level?

      LOG.debug(getLeaseHolderId() + " lease acquire failure: "+ e, e);
      

      Attachments

        Activity

          People

            dejanbosanac Dejan Bosanac
            rhn-support-xiwu Xiaohui Wu
            Votes:
            0 Vote for this issue
            Watchers:
            2 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: