fix: Retry multiplexed session failures

Author: sakthivelmanii

google-cloud-spanner/src/main/java/com/google/cloud/spanner/MultiplexedSessionDatabaseClient.java

@@ -53,6 +53,7 @@
 import java.util.concurrent.atomic.AtomicInteger;
 import java.util.concurrent.atomic.AtomicLong;
 import java.util.concurrent.atomic.AtomicReference;
+import java.util.concurrent.locks.ReentrantLock;
 
 /**
  * {@link TransactionRunner} that automatically handles "UNIMPLEMENTED" errors with the message
@@ -315,6 +316,10 @@ public void close() {
    */
   private final AtomicBoolean unimplemented = new AtomicBoolean(false);
 
+  private final AtomicBoolean retryingSessionCreation = new AtomicBoolean(true);
+
+  private final ReentrantLock sessionCreationLock = new ReentrantLock();
+
   /**
    * This flag is set to true if the server return UNIMPLEMENTED when a read-write transaction is
    * executed on a multiplexed session. TODO: Remove once this is guaranteed to be available.
@@ -358,11 +363,20 @@ public void close() {
         SettableApiFuture.create();
     this.readWriteBeginTransactionReferenceFuture = SettableApiFuture.create();
     this.multiplexedSessionReference = new AtomicReference<>(initialSessionReferenceFuture);
+    asyncCreateMultiplexedSession(initialSessionReferenceFuture);
+    maybeWaitForSessionCreation(
+        sessionClient.getSpanner().getOptions().getSessionPoolOptions(),
+        initialSessionReferenceFuture);
+  }
+
+  private void asyncCreateMultiplexedSession(
+      SettableApiFuture<SessionReference> sessionReferenceFuture) {
     this.sessionClient.asyncCreateMultiplexedSession(
         new SessionConsumer() {
           @Override
           public void onSessionReady(SessionImpl session) {
-            initialSessionReferenceFuture.set(session.getSessionReference());
+            retryingSessionCreation.set(false);
+            sessionReferenceFuture.set(session.getSessionReference());
             // only start the maintainer if we actually managed to create a session in the first
             // place.
             maintainer.start();
@@ -394,13 +408,11 @@ public void onSessionReady(SessionImpl session) {
           public void onSessionCreateFailure(Throwable t, int createFailureForSessionCount) {
             // Mark multiplexes sessions as unimplemented and fall back to regular sessions if
             // UNIMPLEMENTED is returned.
+            retryingSessionCreation.set(false);
             maybeMarkUnimplemented(t);
-            initialSessionReferenceFuture.setException(t);
+            sessionReferenceFuture.setException(t);
           }
         });
-    maybeWaitForSessionCreation(
-        sessionClient.getSpanner().getOptions().getSessionPoolOptions(),
-        initialSessionReferenceFuture);
   }
 
   void setPool(SessionPool pool) {
@@ -546,8 +558,27 @@ MultiplexedSessionMaintainer getMaintainer() {
     return this.maintainer;
   }
 
+  ApiFuture<SessionReference> getCurrentSessionReferenceFuture() {
+    return ApiFutures.immediateFuture(getCurrentSessionReference());
+  }
+
   @VisibleForTesting
   SessionReference getCurrentSessionReference() {
+    try {
+      return this.multiplexedSessionReference.get().get();
+    } catch (ExecutionException | InterruptedException exception) {
+      return maybeRetrySessionCreation();
+    }
+  }
+
+  private SessionReference maybeRetrySessionCreation() {
+    sessionCreationLock.lock();
+    if (isMultiplexedSessionsSupported() && retryingSessionCreation.compareAndSet(false, true)) {
+      SettableApiFuture<SessionReference> settableApiFuture = SettableApiFuture.create();
+      asyncCreateMultiplexedSession(settableApiFuture);
+      multiplexedSessionReference.set(settableApiFuture);
+    }
+    sessionCreationLock.unlock();
     try {
       return this.multiplexedSessionReference.get().get();
     } catch (ExecutionException executionException) {
@@ -587,28 +618,22 @@ private DatabaseClient createMultiplexedSessionTransaction(boolean singleUse) {
 
   private MultiplexedSessionTransaction createDirectMultiplexedSessionTransaction(
       boolean singleUse) {
-    try {
-      return new MultiplexedSessionTransaction(
-          this,
-          tracer.getCurrentSpan(),
-          // Getting the result of the SettableApiFuture that contains the multiplexed session will
-          // also automatically propagate any error that happened during the creation of the
-          // session, such as for example a DatabaseNotFound exception. We therefore do not need
-          // any special handling of such errors.
-          multiplexedSessionReference.get().get(),
-          singleUse ? getSingleUseChannelHint() : NO_CHANNEL_HINT,
-          singleUse,
-          this.pool);
-    } catch (ExecutionException executionException) {
-      throw SpannerExceptionFactory.asSpannerException(executionException.getCause());
-    } catch (InterruptedException interruptedException) {
-      throw SpannerExceptionFactory.propagateInterrupt(interruptedException);
-    }
+    return new MultiplexedSessionTransaction(
+        this,
+        tracer.getCurrentSpan(),
+        // Getting the result of the SettableApiFuture that contains the multiplexed session will
+        // also automatically propagate any error that happened during the creation of the
+        // session, such as for example a DatabaseNotFound exception. We therefore do not need
+        // any special handling of such errors.
+        getCurrentSessionReference(),
+        singleUse ? getSingleUseChannelHint() : NO_CHANNEL_HINT,
+        singleUse,
+        this.pool);
   }
 
   private DelayedMultiplexedSessionTransaction createDelayedMultiplexSessionTransaction() {
     return new DelayedMultiplexedSessionTransaction(
-        this, tracer.getCurrentSpan(), multiplexedSessionReference.get(), this.pool);
+        this, tracer.getCurrentSpan(), getCurrentSessionReferenceFuture(), this.pool);
   }
 
   private int getSingleUseChannelHint() {

google-cloud-spanner/src/test/java/com/google/cloud/spanner/MultiplexedSessionDatabaseClientMockServerTest.java

@@ -54,6 +54,8 @@
 import java.time.Duration;
 import java.util.*;
 import java.util.concurrent.CountDownLatch;
+import java.util.concurrent.ExecutorService;
+import java.util.concurrent.Executors;
 import java.util.concurrent.TimeUnit;
 import java.util.concurrent.atomic.AtomicInteger;
 import java.util.concurrent.atomic.AtomicReference;
@@ -245,6 +247,141 @@ public void testUnimplementedErrorOnCreation_fallsBackToRegularSessions() {
     assertEquals(0L, client.multiplexedSessionDatabaseClient.getNumSessionsReleased().get());
   }
 
+  @Test
+  public void testDeadlineExceededErrorWithOneRetry() {
+    // Setting up two exceptions
+    mockSpanner.setCreateSessionExecutionTime(
+        SimulatedExecutionTime.ofExceptions(
+            Arrays.asList(
+                Status.DEADLINE_EXCEEDED
+                    .withDescription(
+                        "CallOptions deadline exceeded after 22.986872393s. "
+                            + "Name resolution delay 6.911918521 seconds. [closed=[], "
+                            + "open=[[connecting_and_lb_delay=32445014148ns, was_still_waiting]]]")
+                    .asRuntimeException(),
+                Status.DEADLINE_EXCEEDED
+                    .withDescription(
+                        "CallOptions deadline exceeded after 22.986872393s. "
+                            + "Name resolution delay 6.911918521 seconds. [closed=[], "
+                            + "open=[[connecting_and_lb_delay=32445014148ns, was_still_waiting]]]")
+                    .asRuntimeException())));
+    DatabaseClientImpl client =
+        (DatabaseClientImpl) spanner.getDatabaseClient(DatabaseId.of("p", "i", "d"));
+    assertNotNull(client.multiplexedSessionDatabaseClient);
+
+    // initial fetch call fails with exception
+    // this call will try to fetch it again which again throws an exception
+    assertThrows(
+        SpannerException.class,
+        () -> {
+          try (ResultSet resultSet = client.singleUse().executeQuery(STATEMENT)) {
+            //noinspection StatementWithEmptyBody
+            while (resultSet.next()) {
+              // ignore
+            }
+          }
+        });
+
+    // When third request comes it should succeed
+    try (ResultSet resultSet = client.singleUse().executeQuery(STATEMENT)) {
+      //noinspection StatementWithEmptyBody
+      while (resultSet.next()) {
+        // ignore
+      }
+    }
+
+    // Verify that we received one ExecuteSqlRequest, and that it used a multiplexed session.
+    assertEquals(1, mockSpanner.countRequestsOfType(ExecuteSqlRequest.class));
+    List<ExecuteSqlRequest> requests = mockSpanner.getRequestsOfType(ExecuteSqlRequest.class);
+
+    Session session = mockSpanner.getSession(requests.get(0).getSession());
+    assertNotNull(session);
+    assertTrue(session.getMultiplexed());
+
+    assertNotNull(client.multiplexedSessionDatabaseClient);
+    assertEquals(1L, client.multiplexedSessionDatabaseClient.getNumSessionsAcquired().get());
+    assertEquals(1L, client.multiplexedSessionDatabaseClient.getNumSessionsReleased().get());
+  }
+
+  @Test
+  public void testDeadlineExceededErrorWithOneRetryWithParallelRequests()
+      throws InterruptedException {
+    mockSpanner.setCreateSessionExecutionTime(
+        SimulatedExecutionTime.ofMinimumAndRandomTimeAndExceptions(
+            2000, 0,
+            Arrays.asList(
+                Status.DEADLINE_EXCEEDED
+                    .withDescription(
+                        "CallOptions deadline exceeded after 22.986872393s. "
+                            + "Name resolution delay 6.911918521 seconds. [closed=[], "
+                            + "open=[[connecting_and_lb_delay=32445014148ns, was_still_waiting]]]")
+                    .asRuntimeException(),
+                Status.DEADLINE_EXCEEDED
+                    .withDescription(
+                        "CallOptions deadline exceeded after 22.986872393s. "
+                            + "Name resolution delay 6.911918521 seconds. [closed=[], "
+                            + "open=[[connecting_and_lb_delay=32445014148ns, was_still_waiting]]]")
+                    .asRuntimeException())));
+    DatabaseClientImpl client =
+        (DatabaseClientImpl) spanner.getDatabaseClient(DatabaseId.of("p", "i", "d"));
+    assertNotNull(client.multiplexedSessionDatabaseClient);
+
+
+    ExecutorService executor = Executors.newCachedThreadPool();
+
+    // First set of request should fail with an error
+    CountDownLatch failureCountDownLatch = new CountDownLatch(3);
+    for (int i = 0; i < 3; i++) {
+      executor.submit(() -> {
+        try {
+          try (ResultSet resultSet = client.singleUse().executeQuery(STATEMENT)) {
+            //noinspection StatementWithEmptyBody
+            while (resultSet.next()) {
+              // ignore
+            }
+          }
+        } catch (SpannerException e) {
+          failureCountDownLatch.countDown();
+        }
+      });
+    }
+
+    assertTrue(failureCountDownLatch.await(2, TimeUnit.SECONDS));
+    assertEquals(0, failureCountDownLatch.getCount());
+
+    // Second set of requests should pass
+    CountDownLatch countDownLatch = new CountDownLatch(3);
+    for (int i = 0; i < 3; i++) {
+      executor.submit(() -> {
+        try {
+          try (ResultSet resultSet = client.singleUse().executeQuery(STATEMENT)) {
+            //noinspection StatementWithEmptyBody
+            while (resultSet.next()) {
+              // ignore
+            }
+          }
+        } catch (SpannerException e) {
+          countDownLatch.countDown();
+        }
+      });
+    }
+
+    assertFalse(countDownLatch.await(3, TimeUnit.SECONDS));
+    assertEquals(3, countDownLatch.getCount());
+
+    // Verify that we received 3 ExecuteSqlRequest, and that it used a multiplexed session.
+    assertEquals(3, mockSpanner.countRequestsOfType(ExecuteSqlRequest.class));
+    List<ExecuteSqlRequest> requests = mockSpanner.getRequestsOfType(ExecuteSqlRequest.class);
+
+    Session session = mockSpanner.getSession(requests.get(0).getSession());
+    assertNotNull(session);
+    assertTrue(session.getMultiplexed());
+
+    assertNotNull(client.multiplexedSessionDatabaseClient);
+    assertEquals(3L, client.multiplexedSessionDatabaseClient.getNumSessionsAcquired().get());
+    assertEquals(3L, client.multiplexedSessionDatabaseClient.getNumSessionsReleased().get());
+  }
+
   @Test
   public void
       testUnimplementedErrorOnCreation_firstReceivesError_secondFallsBackToRegularSessions() {