servod: add chatty sleep information
This may come in handy debgging timing issues in the future.
BUG=b:38448364
TEST=None
Change-Id: Ie456214d0ec104a5f90f7d52dd7a56f5e5f3ad06
Reviewed-on: https://chromium-review.googlesource.com/989294
Commit-Ready: Nick Sanders <nsanders@chromium.org>
Tested-by: Nick Sanders <nsanders@chromium.org>
Reviewed-by: Aseda Aboagye <aaboagye@chromium.org>
diff --git a/servo/drv/cros_ec_softrec_power.py b/servo/drv/cros_ec_softrec_power.py
index 5d79981..961cf9e 100644
--- a/servo/drv/cros_ec_softrec_power.py
+++ b/servo/drv/cros_ec_softrec_power.py
@@ -94,6 +94,7 @@
finally:
self._interface.set('ec_uart_regexp', 'None')
+ self._logger.debug('Reset recovery wait: %s', self._reset_recovery_time)
time.sleep(self._reset_recovery_time)
if self._warm_reset_can_hold_ap:
@@ -111,6 +112,7 @@
self._interface.set('ec_uart_regexp', 'None')
# Tell the EC to tell the CPU we're in recovery mode or non-recovery mode.
+ self._logger.debug('Hostevent delay: %s', self._hostevent_delay)
time.sleep(self._hostevent_delay)
cmd = self._REC_TYPE_HOSTEVENT_CMD_DICT[rec_type]
try:
@@ -118,10 +120,14 @@
self._interface.set('ec_uart_cmd', cmd)
finally:
self._interface.set('ec_uart_regexp', 'None')
+ self._logger.debug('Recovery detection delay: %s',
+ self._RECOVERY_DETECTION_DELAY)
time.sleep(self._RECOVERY_DETECTION_DELAY)
self._power_on_ap()
if rec_mode == self.REC_ON:
# Allow time to reach the recovery screen before yielding control.
+ self._logger.debug('Boot to rec screen delay: %s',
+ self._boot_to_rec_screen_delay)
time.sleep(self._boot_to_rec_screen_delay)
# If we are using CCD, make sure the DUT's Type-C port is a DFP so that
@@ -148,6 +154,8 @@
# Did it work?
try:
+ self._logger.debug('Role swap delay: %s',
+ self._role_swap_delay)
time.sleep(self._role_swap_delay)
cmd = 'pd 0 state'
self._interface.set('ec_uart_regexp', '["DFP"]')