BUG-8618: fix test driver
[controller.git] / opendaylight / md-sal / samples / clustering-test-app / provider / src / main / java / org / opendaylight / controller / clustering / it / provider / impl / AbstractTransactionHandler.java
index f23e7ec194b77e02c205def4e54cca003ffb27ba..d0923ce6de7a5b4486f2292231c3fcc0f93dc471 100644 (file)
@@ -11,19 +11,13 @@ import com.google.common.base.Stopwatch;
 import com.google.common.util.concurrent.FutureCallback;
 import com.google.common.util.concurrent.Futures;
 import com.google.common.util.concurrent.ListenableFuture;
-import java.util.ArrayDeque;
-import java.util.ArrayList;
 import java.util.Collection;
-import java.util.List;
-import java.util.Optional;
-import java.util.Queue;
+import java.util.HashSet;
 import java.util.concurrent.ExecutionException;
-import java.util.concurrent.Executors;
 import java.util.concurrent.ScheduledExecutorService;
 import java.util.concurrent.ScheduledFuture;
 import java.util.concurrent.TimeUnit;
 import java.util.concurrent.TimeoutException;
-import javax.annotation.concurrent.GuardedBy;
 import org.opendaylight.yang.gen.v1.tag.opendaylight.org._2017.controller.yang.lowlevel.control.rev170215.TransactionsParams;
 import org.opendaylight.yangtools.yang.common.QName;
 import org.opendaylight.yangtools.yang.data.api.YangInstanceIdentifier;
@@ -31,66 +25,16 @@ import org.slf4j.Logger;
 import org.slf4j.LoggerFactory;
 
 abstract class AbstractTransactionHandler {
-    private abstract static class Phase {
-        abstract void txSuccess(ListenableFuture<Void> execFuture, long txId);
-
-        abstract void txFailure(ListenableFuture<Void> execFuture, long txId, Throwable cause);
-    }
-
-    private static final class Running extends Phase {
-        private final Queue<ListenableFuture<Void>> futures = new ArrayDeque<>();
-        private Throwable failure;
-
-        void addFuture(final ListenableFuture<Void> execFuture) {
-            futures.add(execFuture);
-        }
-
-        @Override
-        void txSuccess(final ListenableFuture<Void> execFuture, final long txId) {
-            futures.remove(execFuture);
-        }
-
-        @Override
-        void txFailure(final ListenableFuture<Void> execFuture, final long txId, final Throwable cause) {
-            futures.remove(execFuture);
-            if (failure != null) {
-                failure = cause;
-            }
-        }
-
-        Optional<Throwable> getFailure() {
-            return Optional.ofNullable(failure);
-        }
-    }
-
-    private final class Collecting extends Phase {
-        private final List<ListenableFuture<Void>> futures;
-        private boolean done;
-
-        Collecting(final Collection<ListenableFuture<Void>> futures) {
-            this.futures = new ArrayList<>(futures);
-        }
-
-        @Override
-        void txSuccess(final ListenableFuture<Void> execFuture, final long txId) {
-            futures.remove(execFuture);
-            if (futures.isEmpty() && !done) {
-                LOG.debug("All futures completed successfully.");
-                runSuccessful(txCounter);
-            }
-        }
-
-        @Override
-        void txFailure(final ListenableFuture<Void> execFuture, final long txId, final Throwable cause) {
-            futures.remove(execFuture);
-            done = true;
-            runFailed(cause);
-        }
+    private enum State {
+        RUNNING,
+        WAITING,
+        SUCCESSFUL,
+        FAILED,
     }
 
     private static final Logger LOG = LoggerFactory.getLogger(AbstractTransactionHandler.class);
 
-    static final int SECOND_AS_NANO = 1000000000;
+    static final int SECOND_AS_NANO = 1_000_000_000;
     //2^20 as in the model
     static final int MAX_ITEM = 1048576;
 
@@ -110,17 +54,17 @@ abstract class AbstractTransactionHandler {
 
     static final long INIT_TX_TIMEOUT_SECONDS = 125;
 
-    private static final long DEAD_TIMEOUT_SECONDS = TimeUnit.MINUTES.toSeconds(5);
+    private static final long DEAD_TIMEOUT_SECONDS = TimeUnit.MINUTES.toSeconds(15);
 
-    private final ScheduledExecutorService executor = Executors.newSingleThreadScheduledExecutor();
-    private final Stopwatch stopwatch = Stopwatch.createStarted();
+    private final ScheduledExecutorService executor = FinalizableScheduledExecutorService.newSingleThread();
+    private final Collection<ListenableFuture<Void>> futures = new HashSet<>();
+    private final Stopwatch stopwatch = Stopwatch.createUnstarted();
     private final long runtimeNanos;
     private final long delayNanos;
 
     private ScheduledFuture<?> scheduledFuture;
     private long txCounter;
-    @GuardedBy("this")
-    private Phase phase;
+    private State state;
 
     AbstractTransactionHandler(final TransactionsParams params) {
         runtimeNanos = TimeUnit.SECONDS.toNanos(params.getSeconds());
@@ -128,90 +72,128 @@ abstract class AbstractTransactionHandler {
     }
 
     final synchronized void doStart() {
-        phase = new Running();
         scheduledFuture = executor.scheduleAtFixedRate(this::execute, 0, delayNanos, TimeUnit.NANOSECONDS);
+        stopwatch.start();
+        state = State.RUNNING;
     }
 
-    private void execute() {
-        final long elapsed = stopwatch.elapsed(TimeUnit.NANOSECONDS);
-        if (elapsed < runtimeNanos) {
-            // Not completed yet: create a transaction and hook it up
-            final long txId = txCounter++;
-            final ListenableFuture<Void> execFuture = execWrite(txId);
-
-            // Ordering is important: we need to add the future before hooking the callback
-            synchronized (this) {
-                ((Running) phase).addFuture(execFuture);
-            }
-            Futures.addCallback(execFuture, new FutureCallback<Void>() {
-                @Override
-                public void onSuccess(final Void result) {
-                    txSuccess(execFuture, txId);
-                }
-
-                @Override
-                public void onFailure(final Throwable cause) {
-                    txFailure(execFuture, txId, cause);
-                }
-            });
-        } else {
-            startCollection();
+    private synchronized void execute() {
+        switch (state) {
+            case FAILED:
+                // This could happen due to scheduling artifacts
+                break;
+            case RUNNING:
+                runningExecute();
+                break;
+            default:
+                throw new IllegalStateException("Unhandled state " + state);
         }
     }
 
-    private synchronized void startCollection() {
-        scheduledFuture.cancel(false);
+    private void runningExecute() {
+        final long elapsed = stopwatch.elapsed(TimeUnit.NANOSECONDS);
+        if (elapsed >= runtimeNanos) {
+            LOG.debug("Reached maximum run time with {} outstanding futures", futures.size());
+            if (!checkSuccessful()) {
+                state = State.WAITING;
+                scheduledFuture.cancel(false);
+                scheduledFuture = executor.schedule(this::checkComplete, DEAD_TIMEOUT_SECONDS, TimeUnit.SECONDS);
+            }
 
-        final Running running = (Running) phase;
-        final Optional<Throwable> failure = running.getFailure();
-        if (failure.isPresent()) {
-            executor.shutdown();
-            runFailed(failure.get());
             return;
         }
 
-        LOG.debug("Reached maximum run time with {} outstanding futures", running.futures.size());
-        if (running.futures.isEmpty()) {
-            executor.shutdown();
-            runSuccessful(txCounter);
-            return;
-        }
+        // Not completed yet: create a transaction and hook it up
+        final long txId = txCounter++;
+        final ListenableFuture<Void> execFuture = execWrite(txId);
+        LOG.debug("New future #{} allocated", txId);
+
+        // Ordering is important: we need to add the future before hooking the callback
+        futures.add(execFuture);
+        Futures.addCallback(execFuture, new FutureCallback<Void>() {
+            @Override
+            public void onSuccess(final Void result) {
+                txSuccess(execFuture, txId);
+            }
 
-        phase = new Collecting(running.futures);
-        executor.schedule(this::checkCollection, DEAD_TIMEOUT_SECONDS, TimeUnit.SECONDS);
-        executor.shutdown();
+            @Override
+            public void onFailure(final Throwable cause) {
+                txFailure(execFuture, txId, cause);
+            }
+        }, executor);
     }
 
-    final synchronized void txSuccess(final ListenableFuture<Void> execFuture, final long txId) {
+    final void txSuccess(final ListenableFuture<Void> execFuture, final long txId) {
         LOG.debug("Future #{} completed successfully", txId);
-        phase.txSuccess(execFuture, txId);
+        futures.remove(execFuture);
+
+        switch (state) {
+            case FAILED:
+            case RUNNING:
+                // No-op
+                break;
+            case WAITING:
+                checkSuccessful();
+                break;
+            default:
+                throw new IllegalStateException("Unhandled state " + state);
+        }
     }
 
-    final synchronized void txFailure(final ListenableFuture<Void> execFuture, final long txId, final Throwable cause) {
+    final void txFailure(final ListenableFuture<Void> execFuture, final long txId, final Throwable cause) {
         LOG.debug("Future #{} failed", txId, cause);
-        phase.txFailure(execFuture, txId, cause);
+        futures.remove(execFuture);
+
+        switch (state) {
+            case FAILED:
+                // no-op
+                break;
+            case RUNNING:
+            case WAITING:
+                state = State.FAILED;
+                scheduledFuture.cancel(false);
+                runFailed(cause);
+                break;
+            default:
+                throw new IllegalStateException("Unhandled state " + state);
+        }
     }
 
-    private synchronized void checkCollection() {
-        final Collecting collecting = (Collecting) phase;
-        if (!collecting.done) {
-            final int size = collecting.futures.size();
-            for (int i = 0; i < size; i++) {
-                final ListenableFuture<Void> future = collecting.futures.get(i);
-
-                try {
-                    future.get(0, TimeUnit.NANOSECONDS);
-                } catch (final TimeoutException e) {
-                    LOG.warn("Future #{}/{} not completed yet", i, size);
-                } catch (final ExecutionException e) {
-                    LOG.warn("Future #{}/{} failed", i, size, e.getCause());
-                } catch (final InterruptedException e) {
-                    LOG.warn("Interrupted while examining future #{}/{}", i, size, e);
-                }
+    private void checkComplete() {
+        final int size = futures.size();
+        if (size == 0) {
+            return;
+        }
+
+        int offset = 0;
+        for (ListenableFuture<Void> future : futures) {
+            try {
+                future.get(0, TimeUnit.NANOSECONDS);
+            } catch (final TimeoutException e) {
+                LOG.warn("Future #{}/{} not completed yet", offset, size);
+            } catch (final ExecutionException e) {
+                LOG.warn("Future #{}/{} failed", offset, size, e.getCause());
+            } catch (final InterruptedException e) {
+                LOG.warn("Interrupted while examining future #{}/{}", offset, size, e);
             }
 
-            runTimedOut(new TimeoutException("Collection did not finish in " + DEAD_TIMEOUT_SECONDS + " seconds"));
+            ++offset;
+        }
+
+        state = State.FAILED;
+        runTimedOut(new TimeoutException("Collection did not finish in " + DEAD_TIMEOUT_SECONDS + " seconds"));
+    }
+
+    private boolean checkSuccessful() {
+        if (futures.isEmpty()) {
+            LOG.debug("Completed waiting for all futures");
+            state = State.SUCCESSFUL;
+            scheduledFuture.cancel(false);
+            runSuccessful(txCounter);
+            return true;
         }
+
+        return false;
     }
 
     abstract ListenableFuture<Void> execWrite(final long txId);