From 85c06dd3aeae1964103a58ddb1c1fc6c660dd2b1 Mon Sep 17 00:00:00 2001 From: Nicolas Martinelli Date: Wed, 17 Jan 2024 16:09:37 +0100 Subject: [PATCH] [IMP] base: log job duration Log the job duration of the usual `INFO` level for easier monitoring. closes odoo/odoo#149881 Signed-off-by: Nicolas Martinelli (nim) --- odoo/addons/base/models/ir_cron.py | 8 +++----- 1 file changed, 3 insertions(+), 5 deletions(-) diff --git a/odoo/addons/base/models/ir_cron.py b/odoo/addons/base/models/ir_cron.py index 9393f2c616b..0d920b44158 100644 --- a/odoo/addons/base/models/ir_cron.py +++ b/odoo/addons/base/models/ir_cron.py @@ -371,14 +371,12 @@ class ir_cron(models.Model): log_depth = (None if _logger.isEnabledFor(logging.DEBUG) else 1) odoo.netsvc.log(_logger, logging.DEBUG, 'cron.object.execute', (self._cr.dbname, self._uid, '*', cron_name, server_action_id), depth=log_depth) - start_time = False _logger.info('Starting job `%s`.', cron_name) - if _logger.isEnabledFor(logging.DEBUG): - start_time = time.time() + start_time = time.time() self.env['ir.actions.server'].browse(server_action_id).run() - _logger.info('Job `%s` done.', cron_name) + end_time = time.time() + _logger.info('Job done: `%s` (%.3fs).', cron_name, end_time - start_time) if start_time and _logger.isEnabledFor(logging.DEBUG): - end_time = time.time() _logger.debug('%.3fs (cron %s, server action %d with uid %d)', end_time - start_time, cron_name, server_action_id, self.env.uid) self.pool.signal_changes() except Exception as e: