blob: 365021abb9e893dd7a08463eca8bcd8d5a261ee3 [file] [log] [blame]
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001# Copyright (c) 2014 The Chromium OS Authors. All rights reserved.
2# Use of this source code is governed by a BSD-style license that can be
3# found in the LICENSE file.
4
5import ast
6import ctypes
7import logging
8import os
9import re
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070010import time
11import uuid
12
13from autotest_lib.client.bin import utils
14from autotest_lib.client.common_lib import error
J. Richard Barnettecab6be32014-07-17 13:07:39 -070015from autotest_lib.server import test
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070016from autotest_lib.server.cros import vboot_constants as vboot
17from autotest_lib.server.cros.faft.config.config import Config as FAFTConfig
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070018from autotest_lib.server.cros.faft.rpc_proxy import RPCProxy
J. Richard Barnettea57ff842014-06-05 10:00:31 -070019from autotest_lib.server.cros.faft.utils.faft_checkers import FAFTCheckers
Tom Wai-Hong Tamf2de4de2015-05-02 02:48:08 +080020from autotest_lib.server.cros.faft.utils.mode_switcher import ModeSwitcher
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070021from autotest_lib.server.cros.servo import chrome_ec
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070022
23
24class ConnectionError(Exception):
25 """Raised on an error of connecting DUT."""
26 pass
27
28
J. Richard Barnettecab6be32014-07-17 13:07:39 -070029class FAFTBase(test.test):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070030 """The base class of FAFT classes.
31
32 It launches the FAFTClient on DUT, such that the test can access its
33 firmware functions and interfaces. It also provides some methods to
34 handle the reboot mechanism, in order to ensure FAFTClient is still
35 connected after reboot.
36 """
37 def initialize(self, host):
38 """Create a FAFTClient object and install the dependency."""
J. Richard Barnettecab6be32014-07-17 13:07:39 -070039 self.servo = host.servo
40 self.servo.initialize_dut()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070041 self._client = host
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070042 self.faft_client = RPCProxy(host)
Duncan Laurie10eb6182014-10-07 15:39:05 -070043 self.lockfile = '/var/tmp/faft/lock'
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070044
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +080045 def wait_for_client(self, timeout=100):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070046 """Wait for the client to come back online.
47
48 New remote processes will be launched if their used flags are enabled.
49
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070050 @param timeout: Time in seconds to wait for the client SSH daemon to
51 come up.
52 @raise ConnectionError: Failed to connect DUT.
53 """
54 if not self._client.wait_up(timeout):
55 raise ConnectionError()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070056 # Check the FAFT client is avaiable.
57 self.faft_client.system.is_available()
58
59 def wait_for_client_offline(self, timeout=60, orig_boot_id=None):
60 """Wait for the client to come offline.
61
62 @param timeout: Time in seconds to wait the client to come offline.
63 @param orig_boot_id: A string containing the original boot id.
64 @raise ConnectionError: Failed to connect DUT.
65 """
66 # When running against panther, we see that sometimes
67 # ping_wait_down() does not work correctly. There needs to
68 # be some investigation to the root cause.
69 # If we sleep for 120s before running get_boot_id(), it
70 # does succeed. But if we change this to ping_wait_down()
71 # there are implications on the wait time when running
72 # commands at the fw screens.
73 if not self._client.ping_wait_down(timeout):
74 if orig_boot_id and self._client.get_boot_id() != orig_boot_id:
75 logging.warn('Reboot done very quickly.')
76 return
77 raise ConnectionError()
78
79
80class FirmwareTest(FAFTBase):
81 """
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -070082 Base class that sets up helper objects/functions for firmware tests.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070083
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -070084 TODO: add documentaion as the FAFT rework progresses.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -070085 """
86 version = 1
87
88 # Mapping of partition number of kernel and rootfs.
89 KERNEL_MAP = {'a':'2', 'b':'4', '2':'2', '4':'4', '3':'2', '5':'4'}
90 ROOTFS_MAP = {'a':'3', 'b':'5', '2':'3', '4':'5', '3':'3', '5':'5'}
91 OTHER_KERNEL_MAP = {'a':'4', 'b':'2', '2':'4', '4':'2', '3':'4', '5':'2'}
92 OTHER_ROOTFS_MAP = {'a':'5', 'b':'3', '2':'5', '4':'3', '3':'5', '5':'3'}
93
94 CHROMEOS_MAGIC = "CHROMEOS"
95 CORRUPTED_MAGIC = "CORRUPTD"
96
97 _SERVOD_LOG = '/var/log/servod.log'
98
99 _ROOTFS_PARTITION_NUMBER = 3
100
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700101 _backup_firmware_sha = ()
102 _backup_kernel_sha = dict()
103 _backup_cgpt_attr = dict()
104 _backup_gbb_flags = None
105 _backup_dev_mode = None
106
107 # Class level variable, keep track the states of one time setup.
108 # This variable is preserved across tests which inherit this class.
109 _global_setup_done = {
110 'gbb_flags': False,
111 'reimage': False,
112 'usb_check': False,
113 }
114
115 @classmethod
116 def check_setup_done(cls, label):
117 """Check if the given setup is done.
118
119 @param label: The label of the setup.
120 """
121 return cls._global_setup_done[label]
122
123 @classmethod
124 def mark_setup_done(cls, label):
125 """Mark the given setup done.
126
127 @param label: The label of the setup.
128 """
129 cls._global_setup_done[label] = True
130
131 @classmethod
132 def unmark_setup_done(cls, label):
133 """Mark the given setup not done.
134
135 @param label: The label of the setup.
136 """
137 cls._global_setup_done[label] = False
138
139 def initialize(self, host, cmdline_args, ec_wp=None):
140 super(FirmwareTest, self).initialize(host)
141 self.run_id = str(uuid.uuid4())
142 logging.info('FirmwareTest initialize begin (id=%s)', self.run_id)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700143 # Parse arguments from command line
144 args = {}
145 self.power_control = host.POWER_CONTROL_RPM
146 for arg in cmdline_args:
147 match = re.search("^(\w+)=(.+)", arg)
148 if match:
149 args[match.group(1)] = match.group(2)
150 if 'power_control' in args:
151 self.power_control = args['power_control']
152 if self.power_control not in host.POWER_CONTROL_VALID_ARGS:
153 raise error.TestError('Valid values for --args=power_control '
154 'are %s. But you entered wrong argument '
155 'as "%s".'
156 % (host.POWER_CONTROL_VALID_ARGS,
157 self.power_control))
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700158
159 self.faft_config = FAFTConfig(
160 self.faft_client.system.get_platform_name())
Tom Wai-Hong Tam0cc9a4f2015-05-02 05:12:39 +0800161 self.checkers = FAFTCheckers(self)
Tom Wai-Hong Tamf2de4de2015-05-02 02:48:08 +0800162 self.switcher = ModeSwitcher(self)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700163
164 if self.faft_config.chrome_ec:
165 self.ec = chrome_ec.ChromeEC(self.servo)
166
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700167 self._setup_uart_capture()
168 self._setup_servo_log()
169 self._record_system_info()
Daisuke Nojiri682a6d62014-11-21 09:59:32 -0800170 self.fw_vboot2 = self.faft_client.system.get_fw_vboot2()
171 logging.info('vboot version: %d', 2 if self.fw_vboot2 else 1)
172 if self.fw_vboot2:
173 self.faft_client.system.set_fw_try_next('A')
174 if self.faft_client.system.get_crossystem_value('mainfw_act') == 'B':
175 logging.info('mainfw_act is B. rebooting to set it A')
Tom Wai-Hong Tam47776242015-05-07 02:45:32 +0800176 self.switcher.mode_aware_reboot()
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700177 self._setup_gbb_flags()
178 self._stop_service('update-engine')
Duncan Laurie10eb6182014-10-07 15:39:05 -0700179 self._create_faft_lockfile()
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700180 self._setup_ec_write_protect(ec_wp)
Yusuf Mohsinally1b7a48b2014-05-12 19:25:35 -0700181 # See chromium:239034 regarding needing this sync.
Yusuf Mohsinally1bacc962014-08-14 11:37:32 -0700182 self.blocking_sync()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700183 logging.info('FirmwareTest initialize done (id=%s)', self.run_id)
184
185 def cleanup(self):
186 """Autotest cleanup function."""
187 # Unset state checker in case it's set by subclass
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700188 logging.info('FirmwareTest cleaning up (id=%s)', self.run_id)
189 try:
190 self.faft_client.system.is_available()
191 except:
192 # Remote is not responding. Revive DUT so that subsequent tests
193 # don't fail.
194 self._restore_routine_from_timeout()
Tom Wai-Hong Tam0cc9a4f2015-05-02 05:12:39 +0800195 self.switcher.restore_mode()
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700196 self._restore_ec_write_protect()
197 self._restore_gbb_flags()
198 self._start_service('update-engine')
Duncan Laurie10eb6182014-10-07 15:39:05 -0700199 self._remove_faft_lockfile()
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700200 self._record_servo_log()
201 self._record_faft_client_log()
202 self._cleanup_uart_capture()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700203 super(FirmwareTest, self).cleanup()
204 logging.info('FirmwareTest cleanup done (id=%s)', self.run_id)
205
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700206 def _record_system_info(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700207 """Record some critical system info to the attr keyval.
208
209 This info is used by generate_test_report and local_dash later.
210 """
211 self.write_attr_keyval({
212 'fw_version': self.faft_client.ec.get_version(),
213 'hwid': self.faft_client.system.get_crossystem_value('hwid'),
214 'fwid': self.faft_client.system.get_crossystem_value('fwid'),
215 })
216
217 def invalidate_firmware_setup(self):
218 """Invalidate all firmware related setup state.
219
220 This method is called when the firmware is re-flashed. It resets all
221 firmware related setup states so that the next test setup properly
222 again.
223 """
224 self.unmark_setup_done('gbb_flags')
225
226 def _retrieve_recovery_reason_from_trap(self):
227 """Try to retrieve the recovery reason from a trapped recovery screen.
228
229 @return: The recovery_reason, 0 if any error.
230 """
231 recovery_reason = 0
232 logging.info('Try to retrieve recovery reason...')
233 if self.servo.get_usbkey_direction() == 'dut':
234 self.wait_fw_screen_and_plug_usb()
235 else:
236 self.servo.switch_usbkey('dut')
237
238 try:
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +0800239 self.wait_for_client()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700240 lines = self.faft_client.system.run_shell_command_get_output(
241 'crossystem recovery_reason')
242 recovery_reason = int(lines[0])
243 logging.info('Got the recovery reason %d.', recovery_reason)
244 except ConnectionError:
245 logging.error('Failed to get the recovery reason due to connection '
246 'error.')
247 return recovery_reason
248
249 def _reset_client(self):
250 """Reset client to a workable state.
251
252 This method is called when the client is not responsive. It may be
253 caused by the following cases:
254 - halt on a firmware screen without timeout, e.g. REC_INSERT screen;
255 - corrupted firmware;
256 - corrutped OS image.
257 """
258 # DUT may halt on a firmware screen. Try cold reboot.
259 logging.info('Try cold reboot...')
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +0800260 self.switcher.mode_aware_reboot(reboot_type='cold',
261 sync_before_boot=False,
262 wait_for_dut_up=False)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700263 self.wait_for_client_offline()
264 self.wait_dev_screen_and_ctrl_d()
265 try:
266 self.wait_for_client()
267 return
268 except ConnectionError:
269 logging.warn('Cold reboot doesn\'t help, still connection error.')
270
271 # DUT may be broken by a corrupted firmware. Restore firmware.
272 # We assume the recovery boot still works fine. Since the recovery
273 # code is in RO region and all FAFT tests don't change the RO region
274 # except GBB.
275 if self.is_firmware_saved():
276 self._ensure_client_in_recovery()
277 logging.info('Try restore the original firmware...')
278 if self.is_firmware_changed():
279 try:
280 self.restore_firmware()
281 return
282 except ConnectionError:
283 logging.warn('Restoring firmware doesn\'t help, still '
284 'connection error.')
285
286 # Perhaps it's kernel that's broken. Let's try restoring it.
287 if self.is_kernel_saved():
288 self._ensure_client_in_recovery()
289 logging.info('Try restore the original kernel...')
290 if self.is_kernel_changed():
291 try:
292 self.restore_kernel()
293 return
294 except ConnectionError:
295 logging.warn('Restoring kernel doesn\'t help, still '
296 'connection error.')
297
298 # DUT may be broken by a corrupted OS image. Restore OS image.
299 self._ensure_client_in_recovery()
300 logging.info('Try restore the OS image...')
301 self.faft_client.system.run_shell_command('chromeos-install --yes')
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +0800302 self.switcher.mode_aware_reboot(wait_for_dut_up=False)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700303 self.wait_for_client_offline()
304 self.wait_dev_screen_and_ctrl_d()
305 try:
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +0800306 self.wait_for_client()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700307 logging.info('Successfully restore OS image.')
308 return
309 except ConnectionError:
310 logging.warn('Restoring OS image doesn\'t help, still connection '
311 'error.')
312
313 def _ensure_client_in_recovery(self):
314 """Ensure client in recovery boot; reboot into it if necessary.
315
316 @raise TestError: if failed to boot the USB image.
317 """
318 logging.info('Try boot into USB image...')
Tom Wai-Hong Tamd7a0d052015-05-14 02:18:23 +0800319 self.switcher.reboot_to_mode(to_mode='rec', sync_before_boot=False,
320 wait_for_dut_up=False)
Tom Wai-Hong Tamf2de4de2015-05-02 02:48:08 +0800321 self.servo.switch_usbkey('host')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700322 self.wait_fw_screen_and_plug_usb()
323 try:
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +0800324 self.wait_for_client()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700325 except ConnectionError:
326 raise error.TestError('Failed to boot the USB image.')
327
Yusuf Mohsinally64ee3a72014-06-26 10:24:27 -0700328 def _restore_routine_from_timeout(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700329 """A routine to try to restore the system from a timeout error.
330
331 This method is called when FAFT failed to connect DUT after reboot.
332
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700333 @raise TestFail: This exception is already raised, with a decription
334 why it failed.
335 """
336 # DUT is disconnected. Capture the UART output for debug.
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700337 self._record_uart_capture()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700338
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700339 # TODO(waihong@chromium.org): Implement replugging the Ethernet to
340 # identify if it is a network flaky.
341
342 recovery_reason = self._retrieve_recovery_reason_from_trap()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700343
344 # Reset client to a workable state.
345 self._reset_client()
346
347 # Raise the proper TestFail exception.
Yusuf Mohsinally64ee3a72014-06-26 10:24:27 -0700348 if recovery_reason:
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700349 raise error.TestFail('Trapped in the recovery screen (reason: %d) '
350 'and timed out' % recovery_reason)
351 else:
352 raise error.TestFail('Timed out waiting for DUT reboot')
353
354 def assert_test_image_in_usb_disk(self, usb_dev=None, install_shim=False):
355 """Assert an USB disk plugged-in on servo and a test image inside.
356
357 @param usb_dev: A string of USB stick path on the host, like '/dev/sdc'.
358 If None, it is detected automatically.
359 @param install_shim: True to verify an install shim instead of a test
360 image.
361 @raise TestError: if USB disk not detected or not a test (install shim)
362 image.
363 """
364 if self.check_setup_done('usb_check'):
365 return
366 if usb_dev:
367 assert self.servo.get_usbkey_direction() == 'host'
368 else:
369 self.servo.switch_usbkey('host')
370 usb_dev = self.servo.probe_host_usb_dev()
371 if not usb_dev:
372 raise error.TestError(
373 'An USB disk should be plugged in the servo board.')
374
375 rootfs = '%s%s' % (usb_dev, self._ROOTFS_PARTITION_NUMBER)
376 logging.info('usb dev is %s', usb_dev)
377 tmpd = self.servo.system_output('mktemp -d -t usbcheck.XXXX')
378 self.servo.system('mount -o ro %s %s' % (rootfs, tmpd))
379
Julius Wernerdc535df2015-02-26 16:42:38 -0800380 try:
381 if install_shim:
382 dir_list = self.servo.system_output('ls -a %s' %
383 os.path.join(tmpd, 'root'))
384 if '.factory_installer' not in dir_list:
385 raise error.TestError(
386 'USB stick in servo is not a factory install shim')
387 else:
388 usb_lsb = self.servo.system_output('cat %s' %
389 os.path.join(tmpd, 'etc/lsb-release'))
390 logging.debug('Dumping lsb-release on USB stick:\n%s', usb_lsb)
391 dut_lsb = '\n'.join(self.faft_client.system.
392 run_shell_command_get_output('cat /etc/lsb-release'))
393 logging.debug('Dumping lsb-release on DUT:\n%s', dut_lsb)
Julius Werner2a26faf2015-03-03 14:34:34 -0800394 if not re.search(r'RELEASE_DESCRIPTION=.*(T|t)est', usb_lsb):
Julius Wernerdc535df2015-02-26 16:42:38 -0800395 raise error.TestError('USB stick in servo is no test image')
396 usb_board = re.search(r'BOARD=(.*)', usb_lsb).group(1)
397 dut_board = re.search(r'BOARD=(.*)', dut_lsb).group(1)
398 if usb_board != dut_board:
399 raise error.TestError('USB stick in servo contains a %s '
400 'image, but DUT is a %s' % (usb_board, dut_board))
401 finally:
402 for cmd in ('umount %s' % rootfs, 'sync', 'rm -rf %s' % tmpd):
403 self.servo.system(cmd)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700404
405 self.mark_setup_done('usb_check')
406
407 def setup_usbkey(self, usbkey, host=None, install_shim=False):
408 """Setup the USB disk for the test.
409
410 It checks the setup of USB disk and a valid ChromeOS test image inside.
411 It also muxes the USB disk to either the host or DUT by request.
412
413 @param usbkey: True if the USB disk is required for the test, False if
414 not required.
415 @param host: Optional, True to mux the USB disk to host, False to mux it
416 to DUT, default to do nothing.
417 @param install_shim: True to verify an install shim instead of a test
418 image.
419 """
420 if usbkey:
421 self.assert_test_image_in_usb_disk(install_shim=install_shim)
422 elif host is None:
423 # USB disk is not required for the test. Better to mux it to host.
424 host = True
425
426 if host is True:
427 self.servo.switch_usbkey('host')
428 elif host is False:
429 self.servo.switch_usbkey('dut')
430
431 def get_usbdisk_path_on_dut(self):
432 """Get the path of the USB disk device plugged-in the servo on DUT.
433
434 Returns:
435 A string representing USB disk path, like '/dev/sdb', or None if
436 no USB disk is found.
437 """
438 cmd = 'ls -d /dev/s*[a-z]'
439 original_value = self.servo.get_usbkey_direction()
440
441 # Make the dut unable to see the USB disk.
442 self.servo.switch_usbkey('off')
443 no_usb_set = set(
444 self.faft_client.system.run_shell_command_get_output(cmd))
445
446 # Make the dut able to see the USB disk.
447 self.servo.switch_usbkey('dut')
448 time.sleep(self.faft_config.between_usb_plug)
449 has_usb_set = set(
450 self.faft_client.system.run_shell_command_get_output(cmd))
451
452 # Back to its original value.
453 if original_value != self.servo.get_usbkey_direction():
454 self.servo.switch_usbkey(original_value)
455
456 diff_set = has_usb_set - no_usb_set
457 if len(diff_set) == 1:
458 return diff_set.pop()
459 else:
460 return None
461
Duncan Laurie10eb6182014-10-07 15:39:05 -0700462 def _create_faft_lockfile(self):
463 """Creates the FAFT lockfile."""
464 logging.info('Creating FAFT lockfile...')
465 command = 'touch %s' % (self.lockfile)
466 self.faft_client.system.run_shell_command(command)
467
468 def _remove_faft_lockfile(self):
469 """Removes the FAFT lockfile."""
470 logging.info('Removing FAFT lockfile...')
471 command = 'rm -f %s' % (self.lockfile)
472 self.faft_client.system.run_shell_command(command)
473
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700474 def _stop_service(self, service):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700475 """Stops a upstart service on the client.
476
477 @param service: The name of the upstart service.
478 """
479 logging.info('Stopping %s...', service)
480 command = 'status %s | grep stop || stop %s' % (service, service)
481 self.faft_client.system.run_shell_command(command)
482
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700483 def _start_service(self, service):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700484 """Starts a upstart service on the client.
485
486 @param service: The name of the upstart service.
487 """
488 logging.info('Starting %s...', service)
489 command = 'status %s | grep start || start %s' % (service, service)
490 self.faft_client.system.run_shell_command(command)
491
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700492 def _write_gbb_flags(self, new_flags):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700493 """Write the GBB flags to the current firmware.
494
495 @param new_flags: The flags to write.
496 """
497 gbb_flags = self.faft_client.bios.get_gbb_flags()
498 if gbb_flags == new_flags:
499 return
500 logging.info('Changing GBB flags from 0x%x to 0x%x.',
501 gbb_flags, new_flags)
502 self.faft_client.system.run_shell_command(
503 '/usr/share/vboot/bin/set_gbb_flags.sh 0x%x' % new_flags)
504 self.faft_client.bios.reload()
505 # If changing FORCE_DEV_SWITCH_ON flag, reboot to get a clear state
506 if ((gbb_flags ^ new_flags) & vboot.GBB_FLAG_FORCE_DEV_SWITCH_ON):
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +0800507 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700508
509 def clear_set_gbb_flags(self, clear_mask, set_mask):
510 """Clear and set the GBB flags in the current flashrom.
511
512 @param clear_mask: A mask of flags to be cleared.
513 @param set_mask: A mask of flags to be set.
514 """
515 gbb_flags = self.faft_client.bios.get_gbb_flags()
516 new_flags = gbb_flags & ctypes.c_uint32(~clear_mask).value | set_mask
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700517 self._write_gbb_flags(new_flags)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700518
519 def check_ec_capability(self, required_cap=None, suppress_warning=False):
520 """Check if current platform has required EC capabilities.
521
522 @param required_cap: A list containing required EC capabilities. Pass in
523 None to only check for presence of Chrome EC.
524 @param suppress_warning: True to suppress any warning messages.
525 @return: True if requirements are met. Otherwise, False.
526 """
527 if not self.faft_config.chrome_ec:
528 if not suppress_warning:
529 logging.warn('Requires Chrome EC to run this test.')
530 return False
531
532 if not required_cap:
533 return True
534
535 for cap in required_cap:
536 if cap not in self.faft_config.ec_capability:
537 if not suppress_warning:
538 logging.warn('Requires EC capability "%s" to run this '
539 'test.', cap)
540 return False
541
542 return True
543
544 def check_root_part_on_non_recovery(self, part):
545 """Check the partition number of root device and on normal/dev boot.
546
547 @param part: A string of partition number, e.g.'3'.
548 @return: True if the root device matched and on normal/dev boot;
549 otherwise, False.
550 """
551 return self.checkers.root_part_checker(part) and \
552 self.checkers.crossystem_checker({
553 'mainfw_type': ('normal', 'developer'),
554 })
555
556 def _join_part(self, dev, part):
557 """Return a concatenated string of device and partition number.
558
559 @param dev: A string of device, e.g.'/dev/sda'.
560 @param part: A string of partition number, e.g.'3'.
561 @return: A concatenated string of device and partition number,
562 e.g.'/dev/sda3'.
563
564 >>> seq = FirmwareTest()
565 >>> seq._join_part('/dev/sda', '3')
566 '/dev/sda3'
567 >>> seq._join_part('/dev/mmcblk0', '2')
568 '/dev/mmcblk0p2'
569 """
570 if 'mmcblk' in dev:
571 return dev + 'p' + part
572 else:
573 return dev + part
574
575 def copy_kernel_and_rootfs(self, from_part, to_part):
576 """Copy kernel and rootfs from from_part to to_part.
577
578 @param from_part: A string of partition number to be copied from.
579 @param to_part: A string of partition number to be copied to.
580 """
581 root_dev = self.faft_client.system.get_root_dev()
582 logging.info('Copying kernel from %s to %s. Please wait...',
583 from_part, to_part)
584 self.faft_client.system.run_shell_command('dd if=%s of=%s bs=4M' %
585 (self._join_part(root_dev, self.KERNEL_MAP[from_part]),
586 self._join_part(root_dev, self.KERNEL_MAP[to_part])))
587 logging.info('Copying rootfs from %s to %s. Please wait...',
588 from_part, to_part)
589 self.faft_client.system.run_shell_command('dd if=%s of=%s bs=4M' %
590 (self._join_part(root_dev, self.ROOTFS_MAP[from_part]),
591 self._join_part(root_dev, self.ROOTFS_MAP[to_part])))
592
593 def ensure_kernel_boot(self, part):
594 """Ensure the request kernel boot.
595
596 If not, it duplicates the current kernel to the requested kernel
597 and sets the requested higher priority to ensure it boot.
598
599 @param part: A string of kernel partition number or 'a'/'b'.
600 """
601 if not self.checkers.root_part_checker(part):
602 if self.faft_client.kernel.diff_a_b():
603 self.copy_kernel_and_rootfs(
604 from_part=self.OTHER_KERNEL_MAP[part],
605 to_part=part)
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700606 self.reset_and_prioritize_kernel(part)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700607
608 def set_hardware_write_protect(self, enable):
609 """Set hardware write protect pin.
610
611 @param enable: True if asserting write protect pin. Otherwise, False.
612 """
613 self.servo.set('fw_wp_vref', self.faft_config.wp_voltage)
614 self.servo.set('fw_wp_en', 'on')
615 self.servo.set('fw_wp', 'on' if enable else 'off')
616
617 def set_ec_write_protect_and_reboot(self, enable):
618 """Set EC write protect status and reboot to take effect.
619
620 The write protect state is only activated if both hardware write
621 protect pin is asserted and software write protect flag is set.
622 This method asserts/deasserts hardware write protect pin first, and
623 set corresponding EC software write protect flag.
624
625 If the device uses non-Chrome EC, set the software write protect via
626 flashrom.
627
628 If the device uses Chrome EC, a reboot is required for write protect
629 to take effect. Since the software write protect flag cannot be unset
630 if hardware write protect pin is asserted, we need to deasserted the
631 pin first if we are deactivating write protect. Similarly, a reboot
632 is required before we can modify the software flag.
633
634 @param enable: True if activating EC write protect. Otherwise, False.
635 """
636 self.set_hardware_write_protect(enable)
637 if self.faft_config.chrome_ec:
638 self.set_chrome_ec_write_protect_and_reboot(enable)
639 else:
640 self.faft_client.ec.set_write_protect(enable)
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +0800641 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700642
643 def set_chrome_ec_write_protect_and_reboot(self, enable):
644 """Set Chrome EC write protect status and reboot to take effect.
645
646 @param enable: True if activating EC write protect. Otherwise, False.
647 """
648 if enable:
649 # Set write protect flag and reboot to take effect.
650 self.ec.set_flash_write_protect(enable)
651 self.sync_and_ec_reboot()
652 else:
653 # Reboot after deasserting hardware write protect pin to deactivate
654 # write protect. And then remove software write protect flag.
655 self.sync_and_ec_reboot()
656 self.ec.set_flash_write_protect(enable)
657
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700658 def _setup_ec_write_protect(self, ec_wp):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700659 """Setup for EC write-protection.
660
661 It makes sure the EC in the requested write-protection state. If not, it
662 flips the state. Flipping the write-protection requires DUT reboot.
663
664 @param ec_wp: True to request EC write-protected; False to request EC
665 not write-protected; None to do nothing.
666 """
667 if ec_wp is None:
668 self._old_ec_wp = None
669 return
670 self._old_ec_wp = self.checkers.crossystem_checker({'wpsw_boot': '1'})
671 if ec_wp != self._old_ec_wp:
672 logging.info('The test required EC is %swrite-protected. Reboot '
673 'and flip the state.', '' if ec_wp else 'not ')
Tom Wai-Hong Tam3e92b8e2015-05-07 06:29:57 +0800674 self.switcher.mode_aware_reboot(
675 'custom',
676 lambda:self.set_ec_write_protect_and_reboot(ec_wp))
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700677
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700678 def _restore_ec_write_protect(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700679 """Restore the original EC write-protection."""
680 if (not hasattr(self, '_old_ec_wp')) or (self._old_ec_wp is None):
681 return
682 if not self.checkers.crossystem_checker(
683 {'wpsw_boot': '1' if self._old_ec_wp else '0'}):
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700684 logging.info('Restore original EC write protection and reboot.')
Tom Wai-Hong Tam3e92b8e2015-05-07 06:29:57 +0800685 self.switcher.mode_aware_reboot(
686 'custom',
687 lambda:self.set_ec_write_protect_and_reboot(
688 self._old_ec_wp))
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700689
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700690 def wait_dev_screen_and_ctrl_d(self):
691 """Wait for firmware warning screen and press Ctrl-D."""
692 time.sleep(self.faft_config.dev_screen)
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800693 self.servo.ctrl_d()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700694
695 def wait_fw_screen_and_ctrl_d(self):
696 """Wait for firmware warning screen and press Ctrl-D."""
697 time.sleep(self.faft_config.firmware_screen)
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800698 self.servo.ctrl_d()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700699
700 def wait_fw_screen_and_ctrl_u(self):
701 """Wait for firmware warning screen and press Ctrl-U."""
702 time.sleep(self.faft_config.firmware_screen)
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800703 self.servo.ctrl_u()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700704
705 def wait_fw_screen_and_trigger_recovery(self, need_dev_transition=False):
706 """Wait for firmware warning screen and trigger recovery boot.
707
708 @param need_dev_transition: True when needs dev mode transition, only
709 for Alex/ZGB.
710 """
711 time.sleep(self.faft_config.firmware_screen)
712
713 # Pressing Enter for too long triggers a second key press.
714 # Let's press it without delay
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800715 self.servo.enter_key(press_secs=0)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700716
717 # For Alex/ZGB, there is a dev warning screen in text mode.
718 # Skip it by pressing Ctrl-D.
719 if need_dev_transition:
720 time.sleep(self.faft_config.legacy_text_screen)
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800721 self.servo.ctrl_d()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700722
723 def wait_fw_screen_and_unplug_usb(self):
724 """Wait for firmware warning screen and then unplug the servo USB."""
725 time.sleep(self.faft_config.load_usb)
726 self.servo.switch_usbkey('host')
727 time.sleep(self.faft_config.between_usb_plug)
728
729 def wait_fw_screen_and_plug_usb(self):
730 """Wait for firmware warning screen and then unplug and plug the USB."""
731 self.wait_fw_screen_and_unplug_usb()
732 self.servo.switch_usbkey('dut')
733
734 def wait_fw_screen_and_press_power(self):
735 """Wait for firmware warning screen and press power button."""
736 time.sleep(self.faft_config.firmware_screen)
737 # While the firmware screen, the power button probing loop sleeps
738 # 0.25 second on every scan. Use the normal delay (1.2 second) for
739 # power press.
740 self.servo.power_normal_press()
741
742 def wait_longer_fw_screen_and_press_power(self):
743 """Wait for firmware screen without timeout and press power button."""
744 time.sleep(self.faft_config.dev_screen_timeout)
745 self.wait_fw_screen_and_press_power()
746
747 def wait_fw_screen_and_close_lid(self):
748 """Wait for firmware warning screen and close lid."""
749 time.sleep(self.faft_config.firmware_screen)
750 self.servo.lid_close()
751
752 def wait_longer_fw_screen_and_close_lid(self):
753 """Wait for firmware screen without timeout and close lid."""
754 time.sleep(self.faft_config.firmware_screen)
755 self.wait_fw_screen_and_close_lid()
756
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700757 def _setup_uart_capture(self):
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700758 """Setup the CPU/EC/PD UART capture."""
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700759 self.cpu_uart_file = os.path.join(self.resultsdir, 'cpu_uart.txt')
760 self.servo.set('cpu_uart_capture', 'on')
761 self.ec_uart_file = None
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700762 self.usbpd_uart_file = None
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700763 if self.faft_config.chrome_ec:
764 try:
765 self.servo.set('ec_uart_capture', 'on')
766 self.ec_uart_file = os.path.join(self.resultsdir, 'ec_uart.txt')
767 except error.TestFail as e:
768 if 'No control named' in str(e):
769 logging.warn('The servod is too old that ec_uart_capture '
770 'not supported.')
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700771 # Log separate PD console if supported
772 if self.check_ec_capability(['usbpd_uart'], suppress_warning=True):
773 try:
774 self.servo.set('usbpd_uart_capture', 'on')
775 self.usbpd_uart_file = os.path.join(self.resultsdir,
776 'usbpd_uart.txt')
777 except error.TestFail as e:
778 if 'No control named' in str(e):
779 logging.warn('The servod is too old that '
780 'usbpd_uart_capture is not supported.')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700781 else:
782 logging.info('Not a Google EC, cannot capture ec console output.')
783
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700784 def _record_uart_capture(self):
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700785 """Record the CPU/EC/PD UART output stream to files."""
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700786 if self.cpu_uart_file:
787 with open(self.cpu_uart_file, 'a') as f:
788 f.write(ast.literal_eval(self.servo.get('cpu_uart_stream')))
789 if self.ec_uart_file and self.faft_config.chrome_ec:
790 with open(self.ec_uart_file, 'a') as f:
791 f.write(ast.literal_eval(self.servo.get('ec_uart_stream')))
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700792 if (self.usbpd_uart_file and self.faft_config.chrome_ec and
793 self.check_ec_capability(['usbpd_uart'], suppress_warning=True)):
794 with open(self.usbpd_uart_file, 'a') as f:
795 f.write(ast.literal_eval(self.servo.get('usbpd_uart_stream')))
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700796
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700797 def _cleanup_uart_capture(self):
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700798 """Cleanup the CPU/EC/PD UART capture."""
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700799 # Flush the remaining UART output.
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700800 self._record_uart_capture()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700801 self.servo.set('cpu_uart_capture', 'off')
802 if self.ec_uart_file and self.faft_config.chrome_ec:
803 self.servo.set('ec_uart_capture', 'off')
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700804 if (self.usbpd_uart_file and self.faft_config.chrome_ec and
805 self.check_ec_capability(['usbpd_uart'], suppress_warning=True)):
806 self.servo.set('usbpd_uart_capture', 'off')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700807
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700808 def _fetch_servo_log(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700809 """Fetch the servo log."""
810 cmd = '[ -e %s ] && cat %s || echo NOTFOUND' % ((self._SERVOD_LOG,) * 2)
811 servo_log = self.servo.system_output(cmd)
812 return None if servo_log == 'NOTFOUND' else servo_log
813
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700814 def _setup_servo_log(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700815 """Setup the servo log capturing."""
816 self.servo_log_original_len = -1
817 if self.servo.is_localhost():
818 # No servo log recorded when servod runs locally.
819 return
820
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700821 servo_log = self._fetch_servo_log()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700822 if servo_log:
823 self.servo_log_original_len = len(servo_log)
824 else:
825 logging.warn('Servo log file not found.')
826
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700827 def _record_servo_log(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700828 """Record the servo log to the results directory."""
829 if self.servo_log_original_len != -1:
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700830 servo_log = self._fetch_servo_log()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700831 servo_log_file = os.path.join(self.resultsdir, 'servod.log')
832 with open(servo_log_file, 'a') as f:
833 f.write(servo_log[self.servo_log_original_len:])
834
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700835 def _record_faft_client_log(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700836 """Record the faft client log to the results directory."""
837 client_log = self.faft_client.system.dump_log(True)
838 client_log_file = os.path.join(self.resultsdir, 'faft_client.log')
839 with open(client_log_file, 'w') as f:
840 f.write(client_log)
841
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700842 def _setup_gbb_flags(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700843 """Setup the GBB flags for FAFT test."""
844 if self.faft_config.gbb_version < 1.1:
845 logging.info('Skip modifying GBB on versions older than 1.1.')
846 return
847
848 if self.check_setup_done('gbb_flags'):
849 return
850
851 self._backup_gbb_flags = self.faft_client.bios.get_gbb_flags()
852
853 logging.info('Set proper GBB flags for test.')
854 self.clear_set_gbb_flags(vboot.GBB_FLAG_DEV_SCREEN_SHORT_DELAY |
855 vboot.GBB_FLAG_FORCE_DEV_SWITCH_ON |
856 vboot.GBB_FLAG_FORCE_DEV_BOOT_USB |
857 vboot.GBB_FLAG_DISABLE_FW_ROLLBACK_CHECK,
858 vboot.GBB_FLAG_ENTER_TRIGGERS_TONORM |
859 vboot.GBB_FLAG_FAFT_KEY_OVERIDE)
860 self.mark_setup_done('gbb_flags')
861
862 def drop_backup_gbb_flags(self):
863 """Drops the backup GBB flags.
864
865 This can be used when a test intends to permanently change GBB flags.
866 """
867 self._backup_gbb_flags = None
868
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700869 def _restore_gbb_flags(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700870 """Restore GBB flags to their original state."""
871 if not self._backup_gbb_flags:
872 return
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700873 self._write_gbb_flags(self._backup_gbb_flags)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700874 self.unmark_setup_done('gbb_flags')
875
876 def setup_tried_fwb(self, tried_fwb):
877 """Setup for fw B tried state.
878
879 It makes sure the system in the requested fw B tried state. If not, it
880 tries to do so.
881
882 @param tried_fwb: True if requested in tried_fwb=1;
883 False if tried_fwb=0.
884 """
885 if tried_fwb:
886 if not self.checkers.crossystem_checker({'tried_fwb': '1'}):
887 logging.info(
888 'Firmware is not booted with tried_fwb. Reboot into it.')
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700889 self.faft_client.system.set_try_fw_b()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700890 else:
891 if not self.checkers.crossystem_checker({'tried_fwb': '0'}):
892 logging.info(
893 'Firmware is booted with tried_fwb. Reboot to clear.')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700894
895 def power_on(self):
896 """Switch DUT AC power on."""
897 self._client.power_on(self.power_control)
898
899 def power_off(self):
900 """Switch DUT AC power off."""
901 self._client.power_off(self.power_control)
902
903 def power_cycle(self):
904 """Power cycle DUT AC power."""
905 self._client.power_cycle(self.power_control)
906
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700907 def setup_rw_boot(self, section='a'):
908 """Make sure firmware is in RW-boot mode.
909
910 If the given firmware section is in RO-boot mode, turn off the RO-boot
911 flag and reboot DUT into RW-boot mode.
912
913 @param section: A firmware section, either 'a' or 'b'.
914 """
915 flags = self.faft_client.bios.get_preamble_flags(section)
916 if flags & vboot.PREAMBLE_USE_RO_NORMAL:
917 flags = flags ^ vboot.PREAMBLE_USE_RO_NORMAL
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700918 self.faft_client.bios.set_preamble_flags(section, flags)
Tom Wai-Hong Tam47776242015-05-07 02:45:32 +0800919 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700920
921 def setup_kernel(self, part):
922 """Setup for kernel test.
923
924 It makes sure both kernel A and B bootable and the current boot is
925 the requested kernel part.
926
927 @param part: A string of kernel partition number or 'a'/'b'.
928 """
929 self.ensure_kernel_boot(part)
930 logging.info('Checking the integrity of kernel B and rootfs B...')
931 if (self.faft_client.kernel.diff_a_b() or
932 not self.faft_client.rootfs.verify_rootfs('B')):
933 logging.info('Copying kernel and rootfs from A to B...')
934 self.copy_kernel_and_rootfs(from_part=part,
935 to_part=self.OTHER_KERNEL_MAP[part])
936 self.reset_and_prioritize_kernel(part)
937
938 def reset_and_prioritize_kernel(self, part):
939 """Make the requested partition highest priority.
940
941 This function also reset kerenl A and B to bootable.
942
943 @param part: A string of partition number to be prioritized.
944 """
945 root_dev = self.faft_client.system.get_root_dev()
946 # Reset kernel A and B to bootable.
947 self.faft_client.system.run_shell_command(
948 'cgpt add -i%s -P1 -S1 -T0 %s' % (self.KERNEL_MAP['a'], root_dev))
949 self.faft_client.system.run_shell_command(
950 'cgpt add -i%s -P1 -S1 -T0 %s' % (self.KERNEL_MAP['b'], root_dev))
951 # Set kernel part highest priority.
952 self.faft_client.system.run_shell_command('cgpt prioritize -i%s %s' %
953 (self.KERNEL_MAP[part], root_dev))
954
Yusuf Mohsinally1bacc962014-08-14 11:37:32 -0700955 def blocking_sync(self):
956 """Run a blocking sync command."""
957 # The double calls to sync fakes a blocking call
958 # since the first call returns before the flush
959 # is complete, but the second will wait for the
960 # first to finish.
961 self.faft_client.system.run_shell_command('sync')
962 self.faft_client.system.run_shell_command('sync')
963
Ryan Lin5bee6102014-09-16 13:17:02 -0700964 # sync only sends SYNCHRONIZE_CACHE but doesn't
Steve Fungb5752422015-01-09 16:45:32 -0800965 # check the status. For mmc devices, use `mmc
966 # status get` command to send an empty command to
967 # wait for the disk to be available again. For
968 # other devices, hdparm sends TUR to check if
Ryan Lin5bee6102014-09-16 13:17:02 -0700969 # a device is ready for transfer operation.
970 root_dev = self.faft_client.system.get_root_dev()
Steve Fungb5752422015-01-09 16:45:32 -0800971 if 'mmcblk' in root_dev:
972 self.faft_client.system.run_shell_command('mmc status get %s' %
973 root_dev)
974 else:
975 self.faft_client.system.run_shell_command('hdparm -f %s' % root_dev)
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700976
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +0800977 def wait_for_kernel_up(self):
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700978 """
979 Helper function that waits for the device to boot up to kernel.
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700980 """
981 logging.info("-[FAFT]-[ start wait_for_kernel_up ]---")
Duncan Laurieb3abc432014-10-07 15:48:15 -0700982 # Wait for the system to respond to ping before attempting ssh
983 if not self._client.ping_wait_up(90):
984 logging.warning("-[FAFT]-[ system did not respond to ping ]")
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700985 try:
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +0800986 self.wait_for_client()
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700987 # Stop update-engine as it may change firmware/kernel.
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700988 self._stop_service('update-engine')
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700989 except ConnectionError:
990 logging.error('wait_for_client() timed out.')
Yusuf Mohsinally64ee3a72014-06-26 10:24:27 -0700991 self._restore_routine_from_timeout()
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700992 logging.info("-[FAFT]-[ end wait_for_kernel_up ]-----")
993
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700994 def sync_and_ec_reboot(self, flags=''):
995 """Request the client sync and do a EC triggered reboot.
996
997 @param flags: Optional, a space-separated string of flags passed to EC
998 reboot command, including:
999 default: EC soft reboot;
1000 'hard': EC cold/hard reboot.
1001 """
Yusuf Mohsinally1bacc962014-08-14 11:37:32 -07001002 self.blocking_sync()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001003 self.ec.reboot(flags)
1004 time.sleep(self.faft_config.ec_boot_to_console)
1005 self.check_lid_and_power_on()
1006
1007 def reboot_with_factory_install_shim(self):
1008 """Request reboot with factory install shim to reset TPM.
1009
1010 Factory install shim requires dev mode enabled. So this method switches
1011 firmware to dev mode first and reboot. The client uses factory install
1012 shim to reset TPM values.
1013 """
1014 # Unplug USB first to avoid the complicated USB autoboot cases.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001015 is_dev = self.checkers.crossystem_checker({'devsw_boot': '1'})
1016 if not is_dev:
Tom Wai-Hong Tamda6c6ba2015-05-02 05:32:41 +08001017 self.switcher.reboot_to_mode(to_mode='dev', wait_for_dut_up=False)
Tom Wai-Hong Tamd7a0d052015-05-14 02:18:23 +08001018 self.switcher.reboot_to_mode(to_mode='rec', sync_before_boot=False)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001019 self.wait_fw_screen_and_plug_usb()
1020 time.sleep(self.faft_config.install_shim_done)
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +08001021 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001022
1023 def full_power_off_and_on(self):
1024 """Shutdown the device by pressing power button and power on again."""
Danny Chan101b0b22014-11-06 10:08:54 -08001025 boot_id = self.get_bootid()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001026 # Press power button to trigger Chrome OS normal shutdown process.
1027 # We use a customized delay since the normal-press 1.2s is not enough.
1028 self.servo.power_key(self.faft_config.hold_pwr_button)
Danny Chan101b0b22014-11-06 10:08:54 -08001029 # device can take 44-51 seconds to restart,
1030 # add buffer from the default timeout of 60 seconds.
1031 self.wait_for_client_offline(timeout=100, orig_boot_id=boot_id)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001032 time.sleep(self.faft_config.shutdown)
1033 # Short press power button to boot DUT again.
1034 self.servo.power_short_press()
1035
1036 def check_lid_and_power_on(self):
1037 """
1038 On devices with EC software sync, system powers on after EC reboots if
1039 lid is open. Otherwise, the EC shuts down CPU after about 3 seconds.
1040 This method checks lid switch state and presses power button if
1041 necessary.
1042 """
1043 if self.servo.get("lid_open") == "no":
1044 time.sleep(self.faft_config.software_sync)
1045 self.servo.power_short_press()
1046
1047 def _modify_usb_kernel(self, usb_dev, from_magic, to_magic):
1048 """Modify the kernel header magic in USB stick.
1049
1050 The kernel header magic is the first 8-byte of kernel partition.
1051 We modify it to make it fail on kernel verification check.
1052
1053 @param usb_dev: A string of USB stick path on the host, like '/dev/sdc'.
1054 @param from_magic: A string of magic which we change it from.
1055 @param to_magic: A string of magic which we change it to.
1056 @raise TestError: if failed to change magic.
1057 """
1058 assert len(from_magic) == 8
1059 assert len(to_magic) == 8
1060 # USB image only contains one kernel.
1061 kernel_part = self._join_part(usb_dev, self.KERNEL_MAP['a'])
1062 read_cmd = "sudo dd if=%s bs=8 count=1 2>/dev/null" % kernel_part
1063 current_magic = self.servo.system_output(read_cmd)
1064 if current_magic == to_magic:
1065 logging.info("The kernel magic is already %s.", current_magic)
1066 return
1067 if current_magic != from_magic:
1068 raise error.TestError("Invalid kernel image on USB: wrong magic.")
1069
1070 logging.info('Modify the kernel magic in USB, from %s to %s.',
1071 from_magic, to_magic)
1072 write_cmd = ("echo -n '%s' | sudo dd of=%s oflag=sync conv=notrunc "
1073 " 2>/dev/null" % (to_magic, kernel_part))
1074 self.servo.system(write_cmd)
1075
1076 if self.servo.system_output(read_cmd) != to_magic:
1077 raise error.TestError("Failed to write new magic.")
1078
1079 def corrupt_usb_kernel(self, usb_dev):
1080 """Corrupt USB kernel by modifying its magic from CHROMEOS to CORRUPTD.
1081
1082 @param usb_dev: A string of USB stick path on the host, like '/dev/sdc'.
1083 """
1084 self._modify_usb_kernel(usb_dev, self.CHROMEOS_MAGIC,
1085 self.CORRUPTED_MAGIC)
1086
1087 def restore_usb_kernel(self, usb_dev):
1088 """Restore USB kernel by modifying its magic from CORRUPTD to CHROMEOS.
1089
1090 @param usb_dev: A string of USB stick path on the host, like '/dev/sdc'.
1091 """
1092 self._modify_usb_kernel(usb_dev, self.CORRUPTED_MAGIC,
1093 self.CHROMEOS_MAGIC)
1094
1095 def _call_action(self, action_tuple, check_status=False):
1096 """Call the action function with/without arguments.
1097
1098 @param action_tuple: A function, or a tuple (function, args, error_msg),
1099 in which, args and error_msg are optional. args is
1100 either a value or a tuple if multiple arguments.
1101 This can also be a list containing multiple
1102 function or tuple. In this case, these actions are
1103 called in sequence.
1104 @param check_status: Check the return value of action function. If not
1105 succeed, raises a TestFail exception.
1106 @return: The result value of the action function.
1107 @raise TestError: An error when the action function is not callable.
1108 @raise TestFail: When check_status=True, action function not succeed.
1109 """
1110 if isinstance(action_tuple, list):
1111 return all([self._call_action(action, check_status=check_status)
1112 for action in action_tuple])
1113
1114 action = action_tuple
1115 args = ()
1116 error_msg = 'Not succeed'
1117 if isinstance(action_tuple, tuple):
1118 action = action_tuple[0]
1119 if len(action_tuple) >= 2:
1120 args = action_tuple[1]
1121 if not isinstance(args, tuple):
1122 args = (args,)
1123 if len(action_tuple) >= 3:
1124 error_msg = action_tuple[2]
1125
1126 if action is None:
1127 return
1128
1129 if not callable(action):
1130 raise error.TestError('action is not callable!')
1131
1132 info_msg = 'calling %s' % str(action)
1133 if args:
1134 info_msg += ' with args %s' % str(args)
1135 logging.info(info_msg)
1136 ret = action(*args)
1137
1138 if check_status and not ret:
1139 raise error.TestFail('%s: %s returning %s' %
1140 (error_msg, info_msg, str(ret)))
1141 return ret
1142
1143 def run_shutdown_process(self, shutdown_action, pre_power_action=None,
1144 post_power_action=None, shutdown_timeout=None):
1145 """Run shutdown_action(), which makes DUT shutdown, and power it on.
1146
1147 @param shutdown_action: function which makes DUT shutdown, like
1148 pressing power key.
1149 @param pre_power_action: function which is called before next power on.
1150 @param post_power_action: function which is called after next power on.
1151 @param shutdown_timeout: a timeout to confirm DUT shutdown.
1152 @raise TestFail: if the shutdown_action() failed to turn DUT off.
1153 """
1154 self._call_action(shutdown_action)
1155 logging.info('Wait to ensure DUT shut down...')
1156 try:
1157 if shutdown_timeout is None:
1158 shutdown_timeout = self.faft_config.shutdown_timeout
1159 self.wait_for_client(timeout=shutdown_timeout)
1160 raise error.TestFail(
1161 'Should shut the device down after calling %s.' %
1162 str(shutdown_action))
1163 except ConnectionError:
1164 logging.info(
1165 'DUT is surely shutdown. We are going to power it on again...')
1166
1167 if pre_power_action:
1168 self._call_action(pre_power_action)
1169 self.servo.power_short_press()
1170 if post_power_action:
1171 self._call_action(post_power_action)
1172
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001173 def get_bootid(self, retry=3):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001174 """
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001175 Return the bootid.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001176 """
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001177 boot_id = None
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001178 while retry:
1179 try:
1180 boot_id = self._client.get_boot_id()
1181 break
1182 except error.AutoservRunError:
1183 retry -= 1
1184 if retry:
1185 logging.info('Retry to get boot_id...')
1186 else:
1187 logging.warning('Failed to get boot_id.')
1188 logging.info('boot_id: %s', boot_id)
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001189 return boot_id
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001190
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001191 def check_state(self, func):
1192 """
1193 Wrapper around _call_action with check_status set to True. This is a
1194 helper function to be used by tests and is currently implemented by
1195 calling _call_action with check_status=True.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001196
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001197 TODO: This function's arguments need to be made more stringent. And
1198 its functionality should be moved over to check functions directly in
1199 the future.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001200
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001201 @param func: A function, or a tuple (function, args, error_msg),
1202 in which, args and error_msg are optional. args is
1203 either a value or a tuple if multiple arguments.
1204 This can also be a list containing multiple
1205 function or tuple. In this case, these actions are
1206 called in sequence.
1207 @return: The result value of the action function.
1208 @raise TestFail: If the function does notsucceed.
1209 """
1210 logging.info("-[FAFT]-[ start stepstate_checker ]----------")
1211 self._call_action(func, check_status=True)
1212 logging.info("-[FAFT]-[ end state_checker ]----------------")
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001213
1214 def get_current_firmware_sha(self):
1215 """Get current firmware sha of body and vblock.
1216
1217 @return: Current firmware sha follows the order (
1218 vblock_a_sha, body_a_sha, vblock_b_sha, body_b_sha)
1219 """
1220 current_firmware_sha = (self.faft_client.bios.get_sig_sha('a'),
1221 self.faft_client.bios.get_body_sha('a'),
1222 self.faft_client.bios.get_sig_sha('b'),
1223 self.faft_client.bios.get_body_sha('b'))
1224 if not all(current_firmware_sha):
1225 raise error.TestError('Failed to get firmware sha.')
1226 return current_firmware_sha
1227
1228 def is_firmware_changed(self):
1229 """Check if the current firmware changed, by comparing its SHA.
1230
1231 @return: True if it is changed, otherwise Flase.
1232 """
1233 # Device may not be rebooted after test.
1234 self.faft_client.bios.reload()
1235
1236 current_sha = self.get_current_firmware_sha()
1237
1238 if current_sha == self._backup_firmware_sha:
1239 return False
1240 else:
1241 corrupt_VBOOTA = (current_sha[0] != self._backup_firmware_sha[0])
1242 corrupt_FVMAIN = (current_sha[1] != self._backup_firmware_sha[1])
1243 corrupt_VBOOTB = (current_sha[2] != self._backup_firmware_sha[2])
1244 corrupt_FVMAINB = (current_sha[3] != self._backup_firmware_sha[3])
1245 logging.info("Firmware changed:")
1246 logging.info('VBOOTA is changed: %s', corrupt_VBOOTA)
1247 logging.info('VBOOTB is changed: %s', corrupt_VBOOTB)
1248 logging.info('FVMAIN is changed: %s', corrupt_FVMAIN)
1249 logging.info('FVMAINB is changed: %s', corrupt_FVMAINB)
1250 return True
1251
1252 def backup_firmware(self, suffix='.original'):
1253 """Backup firmware to file, and then send it to host.
1254
1255 @param suffix: a string appended to backup file name
1256 """
1257 remote_temp_dir = self.faft_client.system.create_temp_dir()
1258 self.faft_client.bios.dump_whole(os.path.join(remote_temp_dir, 'bios'))
1259 self._client.get_file(os.path.join(remote_temp_dir, 'bios'),
1260 os.path.join(self.resultsdir, 'bios' + suffix))
1261
1262 self._backup_firmware_sha = self.get_current_firmware_sha()
1263 logging.info('Backup firmware stored in %s with suffix %s',
1264 self.resultsdir, suffix)
1265
1266 def is_firmware_saved(self):
1267 """Check if a firmware saved (called backup_firmware before).
1268
1269 @return: True if the firmware is backuped; otherwise False.
1270 """
1271 return self._backup_firmware_sha != ()
1272
1273 def clear_saved_firmware(self):
1274 """Clear the firmware saved by the method backup_firmware."""
1275 self._backup_firmware_sha = ()
1276
1277 def restore_firmware(self, suffix='.original'):
1278 """Restore firmware from host in resultsdir.
1279
1280 @param suffix: a string appended to backup file name
1281 """
1282 if not self.is_firmware_changed():
1283 return
1284
1285 # Backup current corrupted firmware.
1286 self.backup_firmware(suffix='.corrupt')
1287
1288 # Restore firmware.
1289 remote_temp_dir = self.faft_client.system.create_temp_dir()
1290 self._client.send_file(os.path.join(self.resultsdir, 'bios' + suffix),
1291 os.path.join(remote_temp_dir, 'bios'))
1292
1293 self.faft_client.bios.write_whole(
1294 os.path.join(remote_temp_dir, 'bios'))
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +08001295 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001296 logging.info('Successfully restore firmware.')
1297
1298 def setup_firmwareupdate_shellball(self, shellball=None):
1299 """Deside a shellball to use in firmware update test.
1300
1301 Check if there is a given shellball, and it is a shell script. Then,
1302 send it to the remote host. Otherwise, use
1303 /usr/sbin/chromeos-firmwareupdate.
1304
1305 @param shellball: path of a shellball or default to None.
1306
1307 @return: Path of shellball in remote host. If use default shellball,
1308 reutrn None.
1309 """
1310 updater_path = None
1311 if shellball:
1312 # Determine the firmware file is a shellball or a raw binary.
1313 is_shellball = (utils.system_output("file %s" % shellball).find(
1314 "shell script") != -1)
1315 if is_shellball:
1316 logging.info('Device will update firmware with shellball %s',
1317 shellball)
1318 temp_dir = self.faft_client.system.create_temp_dir(
1319 'shellball_')
1320 temp_shellball = os.path.join(temp_dir, 'updater.sh')
1321 self._client.send_file(shellball, temp_shellball)
1322 updater_path = temp_shellball
1323 else:
1324 raise error.TestFail(
1325 'The given shellball is not a shell script.')
1326 return updater_path
1327
1328 def is_kernel_changed(self):
1329 """Check if the current kernel is changed, by comparing its SHA1 hash.
1330
1331 @return: True if it is changed; otherwise, False.
1332 """
1333 changed = False
1334 for p in ('A', 'B'):
1335 backup_sha = self._backup_kernel_sha.get(p, None)
1336 current_sha = self.faft_client.kernel.get_sha(p)
1337 if backup_sha != current_sha:
1338 changed = True
1339 logging.info('Kernel %s is changed', p)
1340 return changed
1341
1342 def backup_kernel(self, suffix='.original'):
1343 """Backup kernel to files, and the send them to host.
1344
1345 @param suffix: a string appended to backup file name.
1346 """
1347 remote_temp_dir = self.faft_client.system.create_temp_dir()
1348 for p in ('A', 'B'):
1349 remote_path = os.path.join(remote_temp_dir, 'kernel_%s' % p)
1350 self.faft_client.kernel.dump(p, remote_path)
1351 self._client.get_file(
1352 remote_path,
1353 os.path.join(self.resultsdir, 'kernel_%s%s' % (p, suffix)))
1354 self._backup_kernel_sha[p] = self.faft_client.kernel.get_sha(p)
1355 logging.info('Backup kernel stored in %s with suffix %s',
1356 self.resultsdir, suffix)
1357
1358 def is_kernel_saved(self):
1359 """Check if kernel images are saved (backup_kernel called before).
1360
1361 @return: True if the kernel is saved; otherwise, False.
1362 """
1363 return len(self._backup_kernel_sha) != 0
1364
1365 def clear_saved_kernel(self):
1366 """Clear the kernel saved by backup_kernel()."""
1367 self._backup_kernel_sha = dict()
1368
1369 def restore_kernel(self, suffix='.original'):
1370 """Restore kernel from host in resultsdir.
1371
1372 @param suffix: a string appended to backup file name.
1373 """
1374 if not self.is_kernel_changed():
1375 return
1376
1377 # Backup current corrupted kernel.
1378 self.backup_kernel(suffix='.corrupt')
1379
1380 # Restore kernel.
1381 remote_temp_dir = self.faft_client.system.create_temp_dir()
1382 for p in ('A', 'B'):
1383 remote_path = os.path.join(remote_temp_dir, 'kernel_%s' % p)
1384 self._client.send_file(
1385 os.path.join(self.resultsdir, 'kernel_%s%s' % (p, suffix)),
1386 remote_path)
1387 self.faft_client.kernel.write(p, remote_path)
1388
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +08001389 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001390 logging.info('Successfully restored kernel.')
1391
1392 def backup_cgpt_attributes(self):
1393 """Backup CGPT partition table attributes."""
1394 self._backup_cgpt_attr = self.faft_client.cgpt.get_attributes()
1395
1396 def restore_cgpt_attributes(self):
1397 """Restore CGPT partition table attributes."""
1398 current_table = self.faft_client.cgpt.get_attributes()
1399 if current_table == self._backup_cgpt_attr:
1400 return
1401 logging.info('CGPT table is changed. Original: %r. Current: %r.',
1402 self._backup_cgpt_attr,
1403 current_table)
1404 self.faft_client.cgpt.set_attributes(self._backup_cgpt_attr)
1405
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +08001406 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001407 logging.info('Successfully restored CGPT table.')
Shelley Chen3edea982014-12-30 14:54:21 -08001408
1409 def try_fwb(self, count=0):
1410 """set to try booting FWB count # times
1411
1412 Wrapper to set fwb_tries for vboot1 and fw_try_count,fw_try_next for
1413 vboot2
1414
1415 @param count: an integer specifying value to program into
1416 fwb_tries(vb1)/fw_try_next(vb2)
1417 """
1418 if self.fw_vboot2:
1419 self.faft_client.system.set_fw_try_next('B', count)
1420 else:
1421 # vboot1: we need to boot into fwb at least once
1422 if not count:
1423 count = count + 1
1424 self.faft_client.system.set_try_fw_b(count)
1425