Make timeout_retry include the total timeout in the exception error

devil/devil/utils/timeout_retry.py

 # Copyright 2013 The Chromium Authors. All rights reserved.
 # Use of this source code is governed by a BSD-style license that can be
 # found in the LICENSE file.
 
 """A utility to run functions with timeouts and retries."""
 # pylint: disable=W0702
 
 import logging
 import threading
 import time
@@ skipping 31 matching lines @@
       The number of seconds remaining before the thread times out, or None
       if the thread never times out.
 
     Raises:
       reraiser_thread.TimeoutError if the remaining time is less than the
         required time.
     """
     remaining = self._watcher.GetRemaining()
     if remaining is not None and remaining < required:
       if msg is None:
-        msg = 'Timeout expired'
+        msg = 'Timeout of %.1f secs expired' % self._watcher.GetTimeout()
       if remaining > 0:
         msg += (', wait of %.1f secs required but only %.1f secs left'
                 % (required, remaining))

[perezju, 2017/08/16 08:35:29]

As I just wrote on the tracking issue; maybe it's fine to remove this extra
detail?

[charliea (OOO until 10-5), 2017/08/18 18:52:18]

Done.

       raise reraiser_thread.TimeoutError(msg)
     return remaining
 
 
 def CurrentTimeoutThreadGroup():
   """Returns the thread group that owns or is blocked on the active thread.
 
   Returns:
     Returns None if no TimeoutRetryThreadGroup is tracking the current thread.
   """
@@ skipping 37 matching lines @@
     msg = ['condition', repr(condition_name), 'met' if result else 'not met']
     if timeout_thread_group:
       # pylint: disable=no-member
       msg.append('(%.1fs)' % timeout_thread_group.GetElapsedTime())
     logger.info(' '.join(msg))
     if result:
       return result
     if timeout_thread_group:
       # pylint: disable=no-member
       timeout_thread_group.GetRemainingTime(wait_period,
           msg='Timed out waiting for %r' % condition_name)

[perezju, 2017/08/16 08:35:29]

I think you also need to update the msg here to have an effect on the particular
log line you were looking at.

[charliea (OOO until 10-5), 2017/08/18 18:52:17]

Given that I think that the caller is more likely to want to customize the
suffix than the base message, I changed the "msg" parameter to a "suffix"
parameter. This appears to be the only caller of that function that uses the msg
parameter.

     time.sleep(wait_period)
   return None
 
 
 def AlwaysRetry(_exception):
   return True
 
 
 def Run(func, timeout, retries, args=None, kwargs=None, desc=None,
         error_log_func=logging.critical, retry_if_func=AlwaysRetry):
@@ skipping 42 matching lines @@
       if num_try > retries or not retry_if_func(e):
         raise
       # Do not catch KeyboardInterrupt.
     except Exception as e:  # pylint: disable=broad-except
       if num_try > retries or not retry_if_func(e):
         raise
       error_log_func(
           '(%s) Exception on %s, attempt %d of %d: %r',
           thread_name, desc, num_try, retries + 1, e)
     num_try += 1