import time
import logging
import logging.handlers

TIME_FORMAT = '%Y-%m-%d %H:%M:%S'

def format_time(t):
    return time.strftime(TIME_FORMAT, time.localtime(t))

def now():
    return format_time(time.time())

def delay(logger, delay):
    time.sleep(delay)
    logger.info("%s: %s sec later", now(), delay)


def test():
    logger = logging.getLogger('testlogger')
    logger.setLevel(logging.DEBUG)
    logger.addHandler(logging.handlers.TimedRotatingFileHandler(
            'badlogdir/logfile', 's', 1, 3))
    logger.info("%s: startup", now())
    delay(logger, 1)
    delay(logger, 2)
    delay(logger, 4)
    delay(logger, 1)
    delay(logger, 1)

if __name__ == '__main__':
    test()