Added diagnostics to test_logging, after reverting last change.

This commit is contained in:
Vinay Sajip 2011-05-13 07:09:40 +01:00
parent 93ea851e83
commit 672c581633
1 changed files with 12 additions and 9 deletions

View File

@ -3502,7 +3502,6 @@ class TimedRotatingFileHandlerTest(BaseFileTest):
fh = logging.handlers.TimedRotatingFileHandler(self.fn, 'S',
backupCount=1)
r = logging.makeLogRecord({'msg': 'testing'})
start = datetime.datetime.now()
fh.emit(r)
self.assertLogFile(self.fn)
time.sleep(1.0)
@ -3511,21 +3510,25 @@ class TimedRotatingFileHandlerTest(BaseFileTest):
# At this point, we should have a recent rotated file which we
# can test for the existence of. However, in practice, on some
# machines which run really slowly, we don't know how far back
# in time to go to look for the log file. So, we go back as far as
# when the test started, and stop as soon as we see a rotated file.
# in time to go to look for the log file. So, we go back a fair
# bit, and stop as soon as we see a rotated file. In theory this
# could of course still fail, but the chances are lower.
found = False
now = datetime.datetime.now()
secs = 1
prev = now - datetime.timedelta(seconds=secs)
while prev > start:
GO_BACK = 2 * 60 # seconds
for secs in range(GO_BACK):
prev = now - datetime.timedelta(seconds=secs)
fn = self.fn + prev.strftime(".%Y-%m-%d_%H-%M-%S")
found = os.path.exists(fn)
if found:
self.rmfiles.append(fn)
break
secs += 1
prev -= datetime.timedelta(seconds=1)
msg = 'No rotated files found, went back %d seconds' % secs
msg = 'No rotated files found, went back %d seconds' % GO_BACK
if not found:
#print additional diagnostics
dn = os.path.dirname(self.fn)
files = [f for f in os.listdir(dn) if f.startswith(self.fn)]
print('The only matching files are: %s' % files)
self.assertTrue(found, msg=msg)
def test_invalid(self):