NOAUTH authentication required when connecting via URL with password

[danconnell]

• Version: node_redis v2.5.3, redis 3.0.7 (on Heroku)
• Platform: node 4.2.6
• Description:

I connect to redis via a URL with the password in it and 99% of the time it works fine. However, every once in a while I get a NOAUTH authentication required error. I shouldn't get this error if I'm connecting via a URL with a password in it, should I?

Here's my connection code:

var client = redis.createClient({
  url: config.get('REDIS_URL'),
  retry_strategy: function (options) {
    logger.error('Redis: Retrying connection - Error: ',
      (options.error.code ? options.error.code : options.error),
      ', Total Retry Time: ',
      options.total_retry_time,
      ' Times Connected: ',
      options.times_connected,
      ', Attempt: ',
      options.attempt);

    // reconnect after
    return 3000;
  }
});
client.on('connect', function () {
  logger.info('Redis: Connected');
});
client.on('error', function (err) {
  if (!!err &&
      !!err.indexOf &&
      err.indexOf('NOAUTH Authentication required') > -1 &&
      !!config.get('REDIS_PASSWORD')) {
    client.auth(config.get('REDIS_PASSWORD'));
  }

  logger.error('Redis: Connection Error: ', err);
});

Here's what my logs look like. Including a lot of logs, since I thought it might be relevant that I'm reconnecting all the time for some reason with a Stream connection ended error.

Apr 03 01:42:24 api app/web.3:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  19 , Attempt:  1 
Apr 03 01:42:27 api app/web.3:  info: Redis: Connected 
Apr 03 01:44:02 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  23 , Attempt:  1 
Apr 03 01:44:05 api app/web.2:  info: Redis: Connected 
Apr 03 01:47:50 api app/web.4:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  21 , Attempt:  1 
Apr 03 01:47:53 api app/web.4:  info: Redis: Connected 
Apr 03 01:50:15 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  24 , Attempt:  1 
Apr 03 01:50:18 api app/web.1:  info: Redis: Connected 
Apr 03 01:52:14 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  24 , Attempt:  1 
Apr 03 01:52:17 api app/web.2:  info: Redis: Connected 
Apr 03 01:54:56 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  22 , Attempt:  1 
Apr 03 01:54:59 api app/web.5:  info: Redis: Connected 
Apr 03 01:56:11 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  25 , Attempt:  1 
Apr 03 01:56:11 api app/web.4:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  22 , Attempt:  1 
Apr 03 01:56:14 api app/web.1:  info: Redis: Connected 
Apr 03 01:56:14 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 01:56:14 api app/web.4:  info: Redis: Connected 
Apr 03 01:58:59 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  25 , Attempt:  1 
Apr 03 01:59:02 api app/web.2:  info: Redis: Connected 
Apr 03 02:00:00 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  23 , Attempt:  1 
Apr 03 02:00:03 api app/web.5:  info: Redis: Connected 
Apr 03 02:01:10 api app/web.3:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  20 , Attempt:  1 
Apr 03 02:01:13 api app/web.3:  info: Redis: Connected 
Apr 03 02:01:14 api app/web.4:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  23 , Attempt:  1 
Apr 03 02:01:15 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  26 , Attempt:  1 
Apr 03 02:01:17 api app/web.4:  info: Redis: Connected 
Apr 03 02:01:18 api app/web.1:  info: Redis: Connected 
Apr 03 02:01:18 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:04:02 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  26 , Attempt:  1 
Apr 03 02:04:05 api app/web.2:  info: Redis: Connected 
Apr 03 02:06:13 api app/web.3:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  21 , Attempt:  1 
Apr 03 02:06:16 api app/web.3:  info: Redis: Connected 
Apr 03 02:06:18 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  27 , Attempt:  1 
Apr 03 02:06:21 api app/web.1:  info: Redis: Connected 
Apr 03 02:06:21 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:08:44 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  24 , Attempt:  1 
Apr 03 02:08:47 api app/web.5:  info: Redis: Connected 
Apr 03 02:09:06 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  27 , Attempt:  1 
Apr 03 02:09:09 api app/web.2:  info: Redis: Connected 
Apr 03 02:11:22 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  28 , Attempt:  1 
Apr 03 02:11:25 api app/web.1:  info: Redis: Connected 
Apr 03 02:11:25 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:13:48 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  25 , Attempt:  1 
Apr 03 02:13:51 api app/web.5:  info: Redis: Connected 
Apr 03 02:14:10 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  28 , Attempt:  1 
Apr 03 02:14:13 api app/web.2:  info: Redis: Connected 
Apr 03 02:14:34 api app/web.3:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  22 , Attempt:  1 
Apr 03 02:14:37 api app/web.3:  info: Redis: Connected 
Apr 03 02:16:26 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  29 , Attempt:  1 
Apr 03 02:16:29 api app/web.1:  info: Redis: Connected 
Apr 03 02:16:29 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:18:15 api app/web.4:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  24 , Attempt:  1 
Apr 03 02:18:19 api app/web.4:  info: Redis: Connected 
Apr 03 02:18:52 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  26 , Attempt:  1 
Apr 03 02:18:55 api app/web.5:  info: Redis: Connected 
Apr 03 02:19:14 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  29 , Attempt:  1 
Apr 03 02:19:16 api app/web.2:  info: Redis: Connected 
Apr 03 02:21:29 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  30 , Attempt:  1 
Apr 03 02:21:32 api app/web.1:  info: Redis: Connected 
Apr 03 02:21:32 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:23:18 api app/web.4:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  25 , Attempt:  1 
Apr 03 02:23:21 api app/web.4:  info: Redis: Connected 
Apr 03 02:24:13 api app/web.3:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  23 , Attempt:  1 
Apr 03 02:24:16 api app/web.3:  info: Redis: Connected 
Apr 03 02:24:50 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  30 , Attempt:  1 
Apr 03 02:24:53 api app/web.2:  info: Redis: Connected 
Apr 03 02:26:32 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  31 , Attempt:  1 
Apr 03 02:26:35 api app/web.1:  info: Redis: Connected 
Apr 03 02:26:35 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:27:58 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  27 , Attempt:  1 
Apr 03 02:28:01 api app/web.5:  info: Redis: Connected 
Apr 03 02:31:35 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  32 , Attempt:  1 
Apr 03 02:31:38 api app/web.1:  info: Redis: Connected 
Apr 03 02:31:38 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:36:38 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  33 , Attempt:  1 
Apr 03 02:36:41 api app/web.1:  info: Redis: Connected 
Apr 03 02:36:41 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:41:41 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  34 , Attempt:  1 
Apr 03 02:41:44 api app/web.1:  info: Redis: Connected 
Apr 03 02:41:44 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:44:47 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  31 , Attempt:  1 
Apr 03 02:44:50 api app/web.2:  info: Redis: Connected 
Apr 03 02:44:51 api app/web.4:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  26 , Attempt:  1 
Apr 03 02:44:54 api app/web.4:  info: Redis: Connected 
Apr 03 02:45:19 api app/web.3:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  24 , Attempt:  1 
Apr 03 02:45:22 api app/web.3:  info: Redis: Connected 
Apr 03 02:45:34 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  28 , Attempt:  1 
Apr 03 02:45:37 api app/web.5:  info: Redis: Connected 
Apr 03 02:46:44 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  35 , Attempt:  1 
Apr 03 02:46:47 api app/web.1:  info: Redis: Connected 
Apr 03 02:46:47 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:49:51 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  32 , Attempt:  1 
Apr 03 02:49:54 api app/web.2:  info: Redis: Connected 
Apr 03 02:51:47 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  36 , Attempt:  1 
Apr 03 02:51:50 api app/web.1:  info: Redis: Connected 
Apr 03 02:51:50 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 02:55:35 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  29 , Attempt:  1 
Apr 03 02:55:38 api app/web.5:  info: Redis: Connected 
Apr 03 02:56:51 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  37 , Attempt:  1 
Apr 03 02:56:54 api app/web.1:  info: Redis: Connected 
Apr 03 02:56:54 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:00:22 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  33 , Attempt:  1 
Apr 03 03:00:25 api app/web.2:  info: Redis: Connected 
Apr 03 03:01:54 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  38 , Attempt:  1 
Apr 03 03:01:57 api app/web.1:  info: Redis: Connected 
Apr 03 03:01:57 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:06:57 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  39 , Attempt:  1 
Apr 03 03:07:00 api app/web.1:  info: Redis: Connected 
Apr 03 03:07:00 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:08:31 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  34 , Attempt:  1 
Apr 03 03:08:34 api app/web.2:  info: Redis: Connected 
Apr 03 03:12:01 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  40 , Attempt:  1 
Apr 03 03:12:04 api app/web.1:  info: Redis: Connected 
Apr 03 03:12:04 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:17:05 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  41 , Attempt:  1 
Apr 03 03:17:08 api app/web.1:  info: Redis: Connected 
Apr 03 03:17:08 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:22:09 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  42 , Attempt:  1 
Apr 03 03:22:12 api app/web.1:  info: Redis: Connected 
Apr 03 03:22:12 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:27:13 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  43 , Attempt:  1 
Apr 03 03:27:16 api app/web.1:  info: Redis: Connected 
Apr 03 03:27:16 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:32:16 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  44 , Attempt:  1 
Apr 03 03:32:19 api app/web.1:  info: Redis: Connected 
Apr 03 03:32:19 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:37:20 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  45 , Attempt:  1 
Apr 03 03:37:23 api app/web.1:  info: Redis: Connected 
Apr 03 03:37:23 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:42:24 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  46 , Attempt:  1 
Apr 03 03:42:27 api app/web.1:  info: Redis: Connected 
Apr 03 03:42:27 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:47:28 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  47 , Attempt:  1 
Apr 03 03:47:31 api app/web.1:  info: Redis: Connected 
Apr 03 03:47:31 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:52:32 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  48 , Attempt:  1 
Apr 03 03:52:35 api app/web.1:  info: Redis: Connected 
Apr 03 03:52:35 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 03:57:35 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  49 , Attempt:  1 
Apr 03 03:57:38 api app/web.1:  info: Redis: Connected 
Apr 03 03:57:38 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:02:39 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  50 , Attempt:  1 
Apr 03 04:02:42 api app/web.1:  info: Redis: Connected 
Apr 03 04:02:42 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:07:42 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  51 , Attempt:  1 
Apr 03 04:07:45 api app/web.1:  info: Redis: Connected 
Apr 03 04:07:45 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:12:46 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  52 , Attempt:  1 
Apr 03 04:12:49 api app/web.1:  info: Redis: Connected 
Apr 03 04:12:49 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:17:50 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  53 , Attempt:  1 
Apr 03 04:17:53 api app/web.1:  info: Redis: Connected 
Apr 03 04:17:53 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:22:10 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  35 , Attempt:  1 
Apr 03 04:22:13 api app/web.2:  info: Redis: Connected 
Apr 03 04:22:39 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  30 , Attempt:  1 
Apr 03 04:22:42 api app/web.5:  info: Redis: Connected 
Apr 03 04:22:54 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  54 , Attempt:  1 
Apr 03 04:22:57 api app/web.1:  info: Redis: Connected 
Apr 03 04:22:57 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:27:57 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  55 , Attempt:  1 
Apr 03 04:28:00 api app/web.1:  info: Redis: Connected 
Apr 03 04:28:00 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:28:14 api app/web.2:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  36 , Attempt:  1 
Apr 03 04:28:17 api app/web.2:  info: Redis: Connected 
Apr 03 04:33:01 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  56 , Attempt:  1 
Apr 03 04:33:04 api app/web.1:  info: Redis: Connected 
Apr 03 04:33:04 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:38:04 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  57 , Attempt:  1 
Apr 03 04:38:07 api app/web.1:  info: Redis: Connected 
Apr 03 04:38:07 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:41:51 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  31 , Attempt:  1 
Apr 03 04:41:54 api app/web.5:  info: Redis: Connected 
Apr 03 04:43:08 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  58 , Attempt:  1 
Apr 03 04:43:11 api app/web.1:  info: Redis: Connected 
Apr 03 04:43:11 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:48:12 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  59 , Attempt:  1 
Apr 03 04:48:15 api app/web.1:  info: Redis: Connected 
Apr 03 04:48:15 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:53:16 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  60 , Attempt:  1 
Apr 03 04:53:19 api app/web.1:  info: Redis: Connected 
Apr 03 04:53:19 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 04:58:20 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  61 , Attempt:  1 
Apr 03 04:58:23 api app/web.1:  info: Redis: Connected 
Apr 03 04:58:23 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:03:24 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  62 , Attempt:  1 
Apr 03 05:03:27 api app/web.1:  info: Redis: Connected 
Apr 03 05:03:27 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:08:28 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  63 , Attempt:  1 
Apr 03 05:08:31 api app/web.1:  info: Redis: Connected 
Apr 03 05:08:31 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:13:31 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  64 , Attempt:  1 
Apr 03 05:13:34 api app/web.1:  info: Redis: Connected 
Apr 03 05:13:34 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:18:34 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  65 , Attempt:  1 
Apr 03 05:18:37 api app/web.1:  info: Redis: Connected 
Apr 03 05:18:37 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:23:37 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  66 , Attempt:  1 
Apr 03 05:23:40 api app/web.1:  info: Redis: Connected 
Apr 03 05:23:40 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:28:40 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  67 , Attempt:  1 
Apr 03 05:28:43 api app/web.1:  info: Redis: Connected 
Apr 03 05:28:43 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:33:44 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  68 , Attempt:  1 
Apr 03 05:33:47 api app/web.1:  info: Redis: Connected 
Apr 03 05:33:47 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:38:47 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  69 , Attempt:  1 
Apr 03 05:38:50 api app/web.1:  info: Redis: Connected 
Apr 03 05:38:50 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:43:50 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  70 , Attempt:  1 
Apr 03 05:43:53 api app/web.1:  info: Redis: Connected 
Apr 03 05:43:53 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:48:54 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  71 , Attempt:  1 
Apr 03 05:48:57 api app/web.1:  info: Redis: Connected 
Apr 03 05:48:57 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:53:58 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  72 , Attempt:  1 
Apr 03 05:54:01 api app/web.1:  info: Redis: Connected 
Apr 03 05:54:01 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 05:59:01 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  73 , Attempt:  1 
Apr 03 05:59:04 api app/web.1:  info: Redis: Connected 
Apr 03 05:59:04 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:04:05 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  74 , Attempt:  1 
Apr 03 06:04:08 api app/web.1:  info: Redis: Connected 
Apr 03 06:04:08 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:09:09 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  75 , Attempt:  1 
Apr 03 06:09:12 api app/web.1:  info: Redis: Connected 
Apr 03 06:09:12 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:14:13 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  76 , Attempt:  1 
Apr 03 06:14:16 api app/web.1:  info: Redis: Connected 
Apr 03 06:14:16 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:19:17 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  77 , Attempt:  1 
Apr 03 06:19:20 api app/web.1:  info: Redis: Connected 
Apr 03 06:19:20 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:24:21 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  78 , Attempt:  1 
Apr 03 06:24:24 api app/web.1:  info: Redis: Connected 
Apr 03 06:24:24 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:29:24 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  79 , Attempt:  1 
Apr 03 06:29:27 api app/web.1:  info: Redis: Connected 
Apr 03 06:29:27 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:34:27 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  80 , Attempt:  1 
Apr 03 06:34:30 api app/web.1:  info: Redis: Connected 
Apr 03 06:34:30 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:39:30 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  81 , Attempt:  1 
Apr 03 06:39:33 api app/web.1:  info: Redis: Connected 
Apr 03 06:39:33 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:44:33 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  82 , Attempt:  1 
Apr 03 06:44:36 api app/web.1:  info: Redis: Connected 
Apr 03 06:44:36 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:49:37 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  83 , Attempt:  1 
Apr 03 06:49:40 api app/web.1:  info: Redis: Connected 
Apr 03 06:49:40 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:54:41 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  84 , Attempt:  1 
Apr 03 06:54:44 api app/web.1:  info: Redis: Connected 
Apr 03 06:54:44 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 06:59:44 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  85 , Attempt:  1 
Apr 03 06:59:47 api app/web.1:  info: Redis: Connected 
Apr 03 06:59:47 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:04:47 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  86 , Attempt:  1 
Apr 03 07:04:50 api app/web.1:  info: Redis: Connected 
Apr 03 07:04:50 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:09:50 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  87 , Attempt:  1 
Apr 03 07:09:53 api app/web.1:  info: Redis: Connected 
Apr 03 07:09:53 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:14:54 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  88 , Attempt:  1 
Apr 03 07:14:57 api app/web.1:  info: Redis: Connected 
Apr 03 07:14:57 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:19:57 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  89 , Attempt:  1 
Apr 03 07:20:23 api app/web.1:  info: Redis: Connected 
Apr 03 07:20:23 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:25:00 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  90 , Attempt:  1 
Apr 03 07:25:03 api app/web.1:  info: Redis: Connected 
Apr 03 07:25:03 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:30:04 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  91 , Attempt:  1 
Apr 03 07:30:07 api app/web.1:  info: Redis: Connected 
Apr 03 07:30:07 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:35:07 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  92 , Attempt:  1 
Apr 03 07:35:10 api app/web.1:  info: Redis: Connected 
Apr 03 07:35:10 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:40:10 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  93 , Attempt:  1 
Apr 03 07:40:13 api app/web.1:  info: Redis: Connected 
Apr 03 07:40:13 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:45:13 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  94 , Attempt:  1 
Apr 03 07:45:16 api app/web.1:  info: Redis: Connected 
Apr 03 07:45:16 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:50:16 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  95 , Attempt:  1 
Apr 03 07:50:19 api app/web.1:  info: Redis: Connected 
Apr 03 07:50:19 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 07:55:20 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  96 , Attempt:  1 
Apr 03 07:55:23 api app/web.1:  info: Redis: Connected 
Apr 03 07:55:23 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:00:24 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  97 , Attempt:  1 
Apr 03 08:00:27 api app/web.1:  info: Redis: Connected 
Apr 03 08:00:27 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:05:27 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  98 , Attempt:  1 
Apr 03 08:05:30 api app/web.1:  info: Redis: Connected 
Apr 03 08:05:30 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:10:30 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  99 , Attempt:  1 
Apr 03 08:10:33 api app/web.1:  info: Redis: Connected 
Apr 03 08:10:33 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:15:33 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  100 , Attempt:  1 
Apr 03 08:15:36 api app/web.1:  info: Redis: Connected 
Apr 03 08:15:36 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:16:39 api app/web.3:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  25 , Attempt:  1 
Apr 03 08:16:42 api app/web.3:  info: Redis: Connected 
Apr 03 08:20:37 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  101 , Attempt:  1 
Apr 03 08:20:40 api app/web.1:  info: Redis: Connected 
Apr 03 08:20:40 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:25:40 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  102 , Attempt:  1 
Apr 03 08:25:43 api app/web.1:  info: Redis: Connected 
Apr 03 08:25:43 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:30:43 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  103 , Attempt:  1 
Apr 03 08:30:46 api app/web.1:  info: Redis: Connected 
Apr 03 08:30:46 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:35:46 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  104 , Attempt:  1 
Apr 03 08:35:49 api app/web.1:  info: Redis: Connected 
Apr 03 08:35:49 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 03 08:38:29 api app/web.1:  info: Redis: Connected 

[danconnell]

Any temporary workaround to this would be appreciated as well. I added that second auth check in the error handler to try to reauth but it didn't work.

Would turning off the ready check help, for example?

[BridgeAR]

This looks weird, indeed.

The connection drops because heroku has a timeout of five minutes for inactive connections. So at least in the end it seems like you hit that value. And as node_redis prefers a live connection, it is going to reconnect as soon as the connection has been closed and so forth.

But this should not have any impact on the redis auth and should always keep on working. Please activate the debug_mode. It'll be a lot easier to debug this with that output.

[danconnell]

Alright, I'll report back when it happens again.

In case it's relevant: I set no_ready_check: true and it didn't happen for about 48hrs (not that it necessarily would have happened if I hadn't set that).

[BridgeAR]

That would be great!

By using the no_ready_check option you might indeed prevent this from occurring. But if you have the chance to run your code on a environment without that option, it might help me to debug this better. The only reason I can think of why you see these errors are that the order is somehow getting messed up of the auth and the info command and this bothers me. To verify this, you might log the output of the following when you hit that error:

console.error(client.command_queue.toArray(), client.offline_queue.toArray());

If you get the error on the info command and the auth command is the next command in the command_queue they got somehow mixed up, even though I can't think of a way how this could happen.

[danconnell]

Is setting NODE_DEBUG=redis doing something that would be preventing the connections from going inactive? Because I'm not seeing the constant reconnects anymore. I don't think I'll be able to reproduce this bug if I'm not reconnecting all the time.

Should I just use that queue logging instead of doing NODE_DEBUG=redis?

[BridgeAR]

It would be better to use the debug mode in addition to the other logging. It should not have any impact what so ever as it only prints out the debug statements and nothing more.

If you're looking at your production environment, you might have some more traffic today than over the weekend and therefore the mentioned timeout might not be triggered.

[BridgeAR]

@danconnell as you also use Heroku: there was a similar issue for @ryanwe over the weekend and RedisCloud fixed something on their side. See #1027

[danconnell]

You were right, it was just having more activity during the day. I'll let you know if/when it happens again.

I don't use RedisCloud, I use Heroku Redis, but it's possible they're using the same thing in the background, so perhaps it's been resolved. The issue for me did start a few days ago as well and we'd been using redis for about a month without issue. We'll see.

[danconnell]

It happened again. Here's the logging info:

Apr 04 23:07:31 api app/web.1:  Redis connection is gone from end event. 
Apr 04 23:07:31 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  26 , Attempt:  1 
Apr 04 23:07:31 api app/web.1:  Retry connection in 3000 ms 
Apr 04 23:07:32 api app/web.1:  Queueing get for next server connection. 
Apr 04 23:07:34 api app/web.1:  Retrying connection... 
Apr 04 23:07:34 api app/web.1:  Sending auth to ******* id 0 
Apr 04 23:07:34 api app/web.1:  Queueing auth for next server connection. 
Apr 04 23:07:34 api app/web.1:  Stream connected ******* id 0 
Apr 04 23:07:34 api app/web.1:  info: Redis: Connected 
Apr 04 23:07:34 api app/web.1:  Checking server ready state... 
Apr 04 23:07:34 api app/web.1:  Send ******* id 0: *1  
Apr 04 23:07:34 api app/web.1:  $4  
Apr 04 23:07:34 api app/web.1:  info  
Apr 04 23:07:34 api app/web.1:  Net read ******* id 0 
Apr 04 23:07:34 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 04 23:07:34 api app/web.1:      at JavascriptReplyParser.parseResult (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:86:16) 
Apr 04 23:07:34 api app/web.1:      at JavascriptReplyParser.tryParsing (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:116:21) 
Apr 04 23:07:34 api app/web.1:      at JavascriptReplyParser.run (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:130:22) 
Apr 04 23:07:34 api app/web.1:      at JavascriptReplyParser.execute (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:111:10) 
Apr 04 23:07:34 api app/web.1:      at Socket.<anonymous> (/app/node_modules/redis/index.js:223:27) 
Apr 04 23:07:34 api app/web.1:      at emitOne (events.js:77:13) 
Apr 04 23:07:34 api app/web.1:      at Socket.emit (events.js:169:7) 
Apr 04 23:07:34 api app/web.1:      at readableAddChunk (_stream_readable.js:146:16) 
Apr 04 23:07:34 api app/web.1:      at Socket.Readable.push (_stream_readable.js:110:10) 
Apr 04 23:07:34 api app/web.1:      at TCP.onread (net.js:523:20) 
Apr 04 23:07:34 api app/web.1:  error: Command queue:  
Apr 04 23:07:34 api app/web.1:  error: Offline queue:  command=get, args=[web:ttl:services:slug=personal-training], buffer_args=false, callback=function runBound() { 
Apr 04 23:07:34 api app/web.1:      return bound(this, self, cb, arguments); 
Apr 04 23:07:34 api app/web.1:    }, command=auth, args=[*******], buffer_args=false, callback=function (err, res) { 
Apr 04 23:07:34 api app/web.1:          if (err) { 
Apr 04 23:07:34 api app/web.1:              if (no_password_is_set.test(err.message)) { 
Apr 04 23:07:34 api app/web.1:                  self.warn('Warning: Redis server does not require a password, but a password was supplied.'); 
Apr 04 23:07:34 api app/web.1:                  err = null; 
Apr 04 23:07:34 api app/web.1:                  res = 'OK'; 
Apr 04 23:07:34 api app/web.1:              } else if (loading.test(err.message)) { 
Apr 04 23:07:34 api app/web.1:                  // If redis is still loading the db, it will not authenticate and everything else will fail 
Apr 04 23:07:34 api app/web.1:                  debug('Redis still loading, trying to authenticate later'); 
Apr 04 23:07:34 api app/web.1:                  setTimeout(function () { 
Apr 04 23:07:34 api app/web.1:                      self.auth(pass, callback); 
Apr 04 23:07:34 api app/web.1:                  }, 200); 
Apr 04 23:07:34 api app/web.1:                  return; 
Apr 04 23:07:34 api app/web.1:              } 
Apr 04 23:07:34 api app/web.1:          } 
Apr 04 23:07:34 api app/web.1:          utils.callback_or_emit(self, callback, err, res); 
Apr 04 23:07:34 api app/web.1:      } 
Apr 04 23:12:35 api app/web.1:  Redis connection is gone from end event. 
Apr 04 23:12:35 api app/web.1:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  27 , Attempt:  1 
Apr 04 23:12:35 api app/web.1:  Retry connection in 3000 ms 
Apr 04 23:12:38 api app/web.1:  Retrying connection... 
Apr 04 23:12:38 api app/web.1:  Sending auth to ******* id 0 
Apr 04 23:12:38 api app/web.1:  Queueing auth for next server connection. 
Apr 04 23:12:38 api app/web.1:  Stream connected ******* id 0 
Apr 04 23:12:38 api app/web.1:  info: Redis: Connected 
Apr 04 23:12:38 api app/web.1:  Checking server ready state... 
Apr 04 23:12:38 api app/web.1:  Send ******* id 0: *1  
Apr 04 23:12:38 api app/web.1:  $4  
Apr 04 23:12:38 api app/web.1:  info  
Apr 04 23:12:38 api app/web.1:  Net read ******* id 0 
Apr 04 23:12:38 api app/web.1:  error: Redis: Connection Error:  Error: Ready check failed: NOAUTH Authentication required. 
Apr 04 23:12:38 api app/web.1:      at JavascriptReplyParser.parseResult (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:86:16) 
Apr 04 23:12:38 api app/web.1:      at JavascriptReplyParser.tryParsing (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:116:21) 
Apr 04 23:12:38 api app/web.1:      at JavascriptReplyParser.run (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:130:22) 
Apr 04 23:12:38 api app/web.1:      at JavascriptReplyParser.execute (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:111:10) 
Apr 04 23:12:38 api app/web.1:      at Socket.<anonymous> (/app/node_modules/redis/index.js:223:27) 
Apr 04 23:12:38 api app/web.1:      at emitOne (events.js:77:13) 
Apr 04 23:12:38 api app/web.1:      at Socket.emit (events.js:169:7) 
Apr 04 23:12:38 api app/web.1:      at readableAddChunk (_stream_readable.js:146:16) 
Apr 04 23:12:38 api app/web.1:      at Socket.Readable.push (_stream_readable.js:110:10) 
Apr 04 23:12:38 api app/web.1:      at TCP.onread (net.js:523:20) 
Apr 04 23:12:38 api app/web.1:  error: Command queue:  
Apr 04 23:12:38 api app/web.1:  error: Offline queue:  command=get, args=[web:ttl:services:slug=personal-training], buffer_args=false, callback=function runBound() { 
Apr 04 23:12:38 api app/web.1:      return bound(this, self, cb, arguments); 
Apr 04 23:12:38 api app/web.1:    }, command=auth, args=[*******], buffer_args=false, callback=function (err, res) { 
Apr 04 23:12:38 api app/web.1:          if (err) { 
Apr 04 23:12:38 api app/web.1:              if (no_password_is_set.test(err.message)) { 
Apr 04 23:12:38 api app/web.1:                  self.warn('Warning: Redis server does not require a password, but a password was supplied.'); 
Apr 04 23:12:38 api app/web.1:                  err = null; 
Apr 04 23:12:38 api app/web.1:                  res = 'OK'; 
Apr 04 23:12:38 api app/web.1:              } else if (loading.test(err.message)) { 
Apr 04 23:12:38 api app/web.1:                  // If redis is still loading the db, it will not authenticate and everything else will fail 
Apr 04 23:12:38 api app/web.1:                  debug('Redis still loading, trying to authenticate later'); 
Apr 04 23:12:38 api app/web.1:                  setTimeout(function () { 
Apr 04 23:12:38 api app/web.1:                      self.auth(pass, callback); 
Apr 04 23:12:38 api app/web.1:                  }, 200); 
Apr 04 23:12:38 api app/web.1:                  return; 
Apr 04 23:12:38 api app/web.1:              } 
Apr 04 23:12:38 api app/web.1:          } 
Apr 04 23:12:38 api app/web.1:          utils.callback_or_emit(self, callback, err, res); 
Apr 04 23:12:38 api app/web.1:      }, command=auth, args=[*******], buffer_args=false, callback=function (err, res) { 
Apr 04 23:12:38 api app/web.1:          if (err) { 
Apr 04 23:12:38 api app/web.1:              if (no_password_is_set.test(err.message)) { 
Apr 04 23:12:38 api app/web.1:                  self.warn('Warning: Redis server does not require a password, but a password was supplied.'); 
Apr 04 23:12:38 api app/web.1:                  err = null; 
Apr 04 23:12:38 api app/web.1:                  res = 'OK'; 
Apr 04 23:12:38 api app/web.1:              } else if (loading.test(err.message)) { 
Apr 04 23:12:38 api app/web.1:                  // If redis is still loading the db, it will not authenticate and everything else will fail 
Apr 04 23:12:38 api app/web.1:                  debug('Redis still loading, trying to authenticate later'); 
Apr 04 23:12:38 api app/web.1:                  setTimeout(function () { 
Apr 04 23:12:38 api app/web.1:                      self.auth(pass, callback); 
Apr 04 23:12:38 api app/web.1:                  }, 200); 
Apr 04 23:12:38 api app/web.1:                  return; 
Apr 04 23:12:38 api app/web.1:              } 
Apr 04 23:12:38 api app/web.1:          } 
Apr 04 23:12:38 api app/web.1:          utils.callback_or_emit(self, callback, err, res); 
Apr 04 23:12:38 api app/web.1:      } 
Apr 04 23:12:46 api app/web.1:  Queueing get for next server connection. 

I added back no_ready_check: true and turned off debug mode after that. Hopefully that's enough info for you to figure it out.

And FYI, I removed that manual auth call I had in the error handler since it wasn't working anyways before this happened, so that's not polluting the queues. This is what the code looked like:

var client = redis.createClient({
  url: config.get('REDIS_URL'),
  retry_strategy: function (options) {
    logger.error('Redis: Retrying connection - Error: ',
      (options.error.code ? options.error.code : options.error),
      ', Total Retry Time: ',
      options.total_retry_time,
      ' Times Connected: ',
      options.times_connected,
      ', Attempt: ',
      options.attempt);

    // reconnect after
    return 3000;
  }
});
client.on('connect', function () {
  logger.info('Redis: Connected');
});
client.on('error', function (err) {
  logger.error('Redis: Connection Error: ', err);
  if (!!client &&
      !!client.command_queue &&
      !!client.command_queue.toArray) {
    logger.error('Command queue: ', client.command_queue.toArray());
  }

  if (!!client &&
      !!client.offline_queue &&
      !!client.offline_queue.toArray) {
    logger.error('Offline queue: ', client.offline_queue.toArray());
  }
});

[danconnell]

Looks like it can still have the same error with no_ready_check: true, it just doesn't hit the redis error handler.

Got this from elsewhere in my code with no logging coming from the redis error handler:

Apr 04 23:43:54 api app/web.5:  error: Redis: Retrying connection - Error:  [Error: Stream connection ended] , Total Retry Time:  0  Times Connected:  2 , Attempt:  1 
Apr 04 23:43:58 api app/web.5:  info: Redis: Connected 
Apr 04 23:43:58 api app/web.5:  error: Error in serviceCtrl:  Error: NOAUTH Authentication required. 
Apr 04 23:43:58 api app/web.5:      at JavascriptReplyParser.parseResult (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:86:16) 
Apr 04 23:43:58 api app/web.5:      at JavascriptReplyParser.tryParsing (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:116:21) 
Apr 04 23:43:58 api app/web.5:      at JavascriptReplyParser.run (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:130:22) 
Apr 04 23:43:58 api app/web.5:      at JavascriptReplyParser.execute (/app/node_modules/redis/node_modules/redis-parser/lib/javascript.js:111:10) 
Apr 04 23:43:58 api app/web.5:      at Socket.<anonymous> (/app/node_modules/redis/index.js:223:27) 
Apr 04 23:43:58 api app/web.5:      at emitOne (events.js:77:13) 
Apr 04 23:43:58 api app/web.5:      at Socket.emit (events.js:169:7) 
Apr 04 23:43:58 api app/web.5:      at readableAddChunk (_stream_readable.js:146:16) 
Apr 04 23:43:58 api app/web.5:      at Socket.Readable.push (_stream_readable.js:110:10) 
Apr 04 23:43:58 api app/web.5:      at TCP.onread (net.js:523:20) 

[BridgeAR]

Thanks a lot! That output helped a lot and I'll fix it later on today. As a workaround you should be able to use v.2.4.2 without any issues.

Please check your E-Mails from me too.