blob: db9d2ee99209d36c7d0def989f9b8ed23783dc75 [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 Tamda6c6ba2015-05-02 05:32:41 +0800319 self.switcher.reboot_to_mode(to_mode='rec', wait_for_dut_up=False)
Tom Wai-Hong Tamf2de4de2015-05-02 02:48:08 +0800320 self.servo.switch_usbkey('host')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700321 self.wait_fw_screen_and_plug_usb()
322 try:
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +0800323 self.wait_for_client()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700324 except ConnectionError:
325 raise error.TestError('Failed to boot the USB image.')
326
Yusuf Mohsinally64ee3a72014-06-26 10:24:27 -0700327 def _restore_routine_from_timeout(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700328 """A routine to try to restore the system from a timeout error.
329
330 This method is called when FAFT failed to connect DUT after reboot.
331
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700332 @raise TestFail: This exception is already raised, with a decription
333 why it failed.
334 """
335 # DUT is disconnected. Capture the UART output for debug.
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700336 self._record_uart_capture()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700337
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700338 # TODO(waihong@chromium.org): Implement replugging the Ethernet to
339 # identify if it is a network flaky.
340
341 recovery_reason = self._retrieve_recovery_reason_from_trap()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700342
343 # Reset client to a workable state.
344 self._reset_client()
345
346 # Raise the proper TestFail exception.
Yusuf Mohsinally64ee3a72014-06-26 10:24:27 -0700347 if recovery_reason:
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700348 raise error.TestFail('Trapped in the recovery screen (reason: %d) '
349 'and timed out' % recovery_reason)
350 else:
351 raise error.TestFail('Timed out waiting for DUT reboot')
352
353 def assert_test_image_in_usb_disk(self, usb_dev=None, install_shim=False):
354 """Assert an USB disk plugged-in on servo and a test image inside.
355
356 @param usb_dev: A string of USB stick path on the host, like '/dev/sdc'.
357 If None, it is detected automatically.
358 @param install_shim: True to verify an install shim instead of a test
359 image.
360 @raise TestError: if USB disk not detected or not a test (install shim)
361 image.
362 """
363 if self.check_setup_done('usb_check'):
364 return
365 if usb_dev:
366 assert self.servo.get_usbkey_direction() == 'host'
367 else:
368 self.servo.switch_usbkey('host')
369 usb_dev = self.servo.probe_host_usb_dev()
370 if not usb_dev:
371 raise error.TestError(
372 'An USB disk should be plugged in the servo board.')
373
374 rootfs = '%s%s' % (usb_dev, self._ROOTFS_PARTITION_NUMBER)
375 logging.info('usb dev is %s', usb_dev)
376 tmpd = self.servo.system_output('mktemp -d -t usbcheck.XXXX')
377 self.servo.system('mount -o ro %s %s' % (rootfs, tmpd))
378
Julius Wernerdc535df2015-02-26 16:42:38 -0800379 try:
380 if install_shim:
381 dir_list = self.servo.system_output('ls -a %s' %
382 os.path.join(tmpd, 'root'))
383 if '.factory_installer' not in dir_list:
384 raise error.TestError(
385 'USB stick in servo is not a factory install shim')
386 else:
387 usb_lsb = self.servo.system_output('cat %s' %
388 os.path.join(tmpd, 'etc/lsb-release'))
389 logging.debug('Dumping lsb-release on USB stick:\n%s', usb_lsb)
390 dut_lsb = '\n'.join(self.faft_client.system.
391 run_shell_command_get_output('cat /etc/lsb-release'))
392 logging.debug('Dumping lsb-release on DUT:\n%s', dut_lsb)
Julius Werner2a26faf2015-03-03 14:34:34 -0800393 if not re.search(r'RELEASE_DESCRIPTION=.*(T|t)est', usb_lsb):
Julius Wernerdc535df2015-02-26 16:42:38 -0800394 raise error.TestError('USB stick in servo is no test image')
395 usb_board = re.search(r'BOARD=(.*)', usb_lsb).group(1)
396 dut_board = re.search(r'BOARD=(.*)', dut_lsb).group(1)
397 if usb_board != dut_board:
398 raise error.TestError('USB stick in servo contains a %s '
399 'image, but DUT is a %s' % (usb_board, dut_board))
400 finally:
401 for cmd in ('umount %s' % rootfs, 'sync', 'rm -rf %s' % tmpd):
402 self.servo.system(cmd)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700403
404 self.mark_setup_done('usb_check')
405
406 def setup_usbkey(self, usbkey, host=None, install_shim=False):
407 """Setup the USB disk for the test.
408
409 It checks the setup of USB disk and a valid ChromeOS test image inside.
410 It also muxes the USB disk to either the host or DUT by request.
411
412 @param usbkey: True if the USB disk is required for the test, False if
413 not required.
414 @param host: Optional, True to mux the USB disk to host, False to mux it
415 to DUT, default to do nothing.
416 @param install_shim: True to verify an install shim instead of a test
417 image.
418 """
419 if usbkey:
420 self.assert_test_image_in_usb_disk(install_shim=install_shim)
421 elif host is None:
422 # USB disk is not required for the test. Better to mux it to host.
423 host = True
424
425 if host is True:
426 self.servo.switch_usbkey('host')
427 elif host is False:
428 self.servo.switch_usbkey('dut')
429
430 def get_usbdisk_path_on_dut(self):
431 """Get the path of the USB disk device plugged-in the servo on DUT.
432
433 Returns:
434 A string representing USB disk path, like '/dev/sdb', or None if
435 no USB disk is found.
436 """
437 cmd = 'ls -d /dev/s*[a-z]'
438 original_value = self.servo.get_usbkey_direction()
439
440 # Make the dut unable to see the USB disk.
441 self.servo.switch_usbkey('off')
442 no_usb_set = set(
443 self.faft_client.system.run_shell_command_get_output(cmd))
444
445 # Make the dut able to see the USB disk.
446 self.servo.switch_usbkey('dut')
447 time.sleep(self.faft_config.between_usb_plug)
448 has_usb_set = set(
449 self.faft_client.system.run_shell_command_get_output(cmd))
450
451 # Back to its original value.
452 if original_value != self.servo.get_usbkey_direction():
453 self.servo.switch_usbkey(original_value)
454
455 diff_set = has_usb_set - no_usb_set
456 if len(diff_set) == 1:
457 return diff_set.pop()
458 else:
459 return None
460
Duncan Laurie10eb6182014-10-07 15:39:05 -0700461 def _create_faft_lockfile(self):
462 """Creates the FAFT lockfile."""
463 logging.info('Creating FAFT lockfile...')
464 command = 'touch %s' % (self.lockfile)
465 self.faft_client.system.run_shell_command(command)
466
467 def _remove_faft_lockfile(self):
468 """Removes the FAFT lockfile."""
469 logging.info('Removing FAFT lockfile...')
470 command = 'rm -f %s' % (self.lockfile)
471 self.faft_client.system.run_shell_command(command)
472
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700473 def _stop_service(self, service):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700474 """Stops a upstart service on the client.
475
476 @param service: The name of the upstart service.
477 """
478 logging.info('Stopping %s...', service)
479 command = 'status %s | grep stop || stop %s' % (service, service)
480 self.faft_client.system.run_shell_command(command)
481
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700482 def _start_service(self, service):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700483 """Starts a upstart service on the client.
484
485 @param service: The name of the upstart service.
486 """
487 logging.info('Starting %s...', service)
488 command = 'status %s | grep start || start %s' % (service, service)
489 self.faft_client.system.run_shell_command(command)
490
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700491 def _write_gbb_flags(self, new_flags):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700492 """Write the GBB flags to the current firmware.
493
494 @param new_flags: The flags to write.
495 """
496 gbb_flags = self.faft_client.bios.get_gbb_flags()
497 if gbb_flags == new_flags:
498 return
499 logging.info('Changing GBB flags from 0x%x to 0x%x.',
500 gbb_flags, new_flags)
501 self.faft_client.system.run_shell_command(
502 '/usr/share/vboot/bin/set_gbb_flags.sh 0x%x' % new_flags)
503 self.faft_client.bios.reload()
504 # If changing FORCE_DEV_SWITCH_ON flag, reboot to get a clear state
505 if ((gbb_flags ^ new_flags) & vboot.GBB_FLAG_FORCE_DEV_SWITCH_ON):
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +0800506 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700507
508 def clear_set_gbb_flags(self, clear_mask, set_mask):
509 """Clear and set the GBB flags in the current flashrom.
510
511 @param clear_mask: A mask of flags to be cleared.
512 @param set_mask: A mask of flags to be set.
513 """
514 gbb_flags = self.faft_client.bios.get_gbb_flags()
515 new_flags = gbb_flags & ctypes.c_uint32(~clear_mask).value | set_mask
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700516 self._write_gbb_flags(new_flags)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700517
518 def check_ec_capability(self, required_cap=None, suppress_warning=False):
519 """Check if current platform has required EC capabilities.
520
521 @param required_cap: A list containing required EC capabilities. Pass in
522 None to only check for presence of Chrome EC.
523 @param suppress_warning: True to suppress any warning messages.
524 @return: True if requirements are met. Otherwise, False.
525 """
526 if not self.faft_config.chrome_ec:
527 if not suppress_warning:
528 logging.warn('Requires Chrome EC to run this test.')
529 return False
530
531 if not required_cap:
532 return True
533
534 for cap in required_cap:
535 if cap not in self.faft_config.ec_capability:
536 if not suppress_warning:
537 logging.warn('Requires EC capability "%s" to run this '
538 'test.', cap)
539 return False
540
541 return True
542
543 def check_root_part_on_non_recovery(self, part):
544 """Check the partition number of root device and on normal/dev boot.
545
546 @param part: A string of partition number, e.g.'3'.
547 @return: True if the root device matched and on normal/dev boot;
548 otherwise, False.
549 """
550 return self.checkers.root_part_checker(part) and \
551 self.checkers.crossystem_checker({
552 'mainfw_type': ('normal', 'developer'),
553 })
554
555 def _join_part(self, dev, part):
556 """Return a concatenated string of device and partition number.
557
558 @param dev: A string of device, e.g.'/dev/sda'.
559 @param part: A string of partition number, e.g.'3'.
560 @return: A concatenated string of device and partition number,
561 e.g.'/dev/sda3'.
562
563 >>> seq = FirmwareTest()
564 >>> seq._join_part('/dev/sda', '3')
565 '/dev/sda3'
566 >>> seq._join_part('/dev/mmcblk0', '2')
567 '/dev/mmcblk0p2'
568 """
569 if 'mmcblk' in dev:
570 return dev + 'p' + part
571 else:
572 return dev + part
573
574 def copy_kernel_and_rootfs(self, from_part, to_part):
575 """Copy kernel and rootfs from from_part to to_part.
576
577 @param from_part: A string of partition number to be copied from.
578 @param to_part: A string of partition number to be copied to.
579 """
580 root_dev = self.faft_client.system.get_root_dev()
581 logging.info('Copying kernel from %s to %s. Please wait...',
582 from_part, to_part)
583 self.faft_client.system.run_shell_command('dd if=%s of=%s bs=4M' %
584 (self._join_part(root_dev, self.KERNEL_MAP[from_part]),
585 self._join_part(root_dev, self.KERNEL_MAP[to_part])))
586 logging.info('Copying rootfs from %s to %s. Please wait...',
587 from_part, to_part)
588 self.faft_client.system.run_shell_command('dd if=%s of=%s bs=4M' %
589 (self._join_part(root_dev, self.ROOTFS_MAP[from_part]),
590 self._join_part(root_dev, self.ROOTFS_MAP[to_part])))
591
592 def ensure_kernel_boot(self, part):
593 """Ensure the request kernel boot.
594
595 If not, it duplicates the current kernel to the requested kernel
596 and sets the requested higher priority to ensure it boot.
597
598 @param part: A string of kernel partition number or 'a'/'b'.
599 """
600 if not self.checkers.root_part_checker(part):
601 if self.faft_client.kernel.diff_a_b():
602 self.copy_kernel_and_rootfs(
603 from_part=self.OTHER_KERNEL_MAP[part],
604 to_part=part)
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700605 self.reset_and_prioritize_kernel(part)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700606
607 def set_hardware_write_protect(self, enable):
608 """Set hardware write protect pin.
609
610 @param enable: True if asserting write protect pin. Otherwise, False.
611 """
612 self.servo.set('fw_wp_vref', self.faft_config.wp_voltage)
613 self.servo.set('fw_wp_en', 'on')
614 self.servo.set('fw_wp', 'on' if enable else 'off')
615
616 def set_ec_write_protect_and_reboot(self, enable):
617 """Set EC write protect status and reboot to take effect.
618
619 The write protect state is only activated if both hardware write
620 protect pin is asserted and software write protect flag is set.
621 This method asserts/deasserts hardware write protect pin first, and
622 set corresponding EC software write protect flag.
623
624 If the device uses non-Chrome EC, set the software write protect via
625 flashrom.
626
627 If the device uses Chrome EC, a reboot is required for write protect
628 to take effect. Since the software write protect flag cannot be unset
629 if hardware write protect pin is asserted, we need to deasserted the
630 pin first if we are deactivating write protect. Similarly, a reboot
631 is required before we can modify the software flag.
632
633 @param enable: True if activating EC write protect. Otherwise, False.
634 """
635 self.set_hardware_write_protect(enable)
636 if self.faft_config.chrome_ec:
637 self.set_chrome_ec_write_protect_and_reboot(enable)
638 else:
639 self.faft_client.ec.set_write_protect(enable)
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +0800640 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700641
642 def set_chrome_ec_write_protect_and_reboot(self, enable):
643 """Set Chrome EC write protect status and reboot to take effect.
644
645 @param enable: True if activating EC write protect. Otherwise, False.
646 """
647 if enable:
648 # Set write protect flag and reboot to take effect.
649 self.ec.set_flash_write_protect(enable)
650 self.sync_and_ec_reboot()
651 else:
652 # Reboot after deasserting hardware write protect pin to deactivate
653 # write protect. And then remove software write protect flag.
654 self.sync_and_ec_reboot()
655 self.ec.set_flash_write_protect(enable)
656
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700657 def _setup_ec_write_protect(self, ec_wp):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700658 """Setup for EC write-protection.
659
660 It makes sure the EC in the requested write-protection state. If not, it
661 flips the state. Flipping the write-protection requires DUT reboot.
662
663 @param ec_wp: True to request EC write-protected; False to request EC
664 not write-protected; None to do nothing.
665 """
666 if ec_wp is None:
667 self._old_ec_wp = None
668 return
669 self._old_ec_wp = self.checkers.crossystem_checker({'wpsw_boot': '1'})
670 if ec_wp != self._old_ec_wp:
671 logging.info('The test required EC is %swrite-protected. Reboot '
672 'and flip the state.', '' if ec_wp else 'not ')
Tom Wai-Hong Tam3e92b8e2015-05-07 06:29:57 +0800673 self.switcher.mode_aware_reboot(
674 'custom',
675 lambda:self.set_ec_write_protect_and_reboot(ec_wp))
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700676
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700677 def _restore_ec_write_protect(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700678 """Restore the original EC write-protection."""
679 if (not hasattr(self, '_old_ec_wp')) or (self._old_ec_wp is None):
680 return
681 if not self.checkers.crossystem_checker(
682 {'wpsw_boot': '1' if self._old_ec_wp else '0'}):
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700683 logging.info('Restore original EC write protection and reboot.')
Tom Wai-Hong Tam3e92b8e2015-05-07 06:29:57 +0800684 self.switcher.mode_aware_reboot(
685 'custom',
686 lambda:self.set_ec_write_protect_and_reboot(
687 self._old_ec_wp))
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700688
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700689 def wait_dev_screen_and_ctrl_d(self):
690 """Wait for firmware warning screen and press Ctrl-D."""
691 time.sleep(self.faft_config.dev_screen)
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800692 self.servo.ctrl_d()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700693
694 def wait_fw_screen_and_ctrl_d(self):
695 """Wait for firmware warning screen and press Ctrl-D."""
696 time.sleep(self.faft_config.firmware_screen)
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800697 self.servo.ctrl_d()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700698
699 def wait_fw_screen_and_ctrl_u(self):
700 """Wait for firmware warning screen and press Ctrl-U."""
701 time.sleep(self.faft_config.firmware_screen)
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800702 self.servo.ctrl_u()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700703
704 def wait_fw_screen_and_trigger_recovery(self, need_dev_transition=False):
705 """Wait for firmware warning screen and trigger recovery boot.
706
707 @param need_dev_transition: True when needs dev mode transition, only
708 for Alex/ZGB.
709 """
710 time.sleep(self.faft_config.firmware_screen)
711
712 # Pressing Enter for too long triggers a second key press.
713 # Let's press it without delay
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800714 self.servo.enter_key(press_secs=0)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700715
716 # For Alex/ZGB, there is a dev warning screen in text mode.
717 # Skip it by pressing Ctrl-D.
718 if need_dev_transition:
719 time.sleep(self.faft_config.legacy_text_screen)
Tom Wai-Hong Tam408c9952015-04-30 00:37:36 +0800720 self.servo.ctrl_d()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700721
722 def wait_fw_screen_and_unplug_usb(self):
723 """Wait for firmware warning screen and then unplug the servo USB."""
724 time.sleep(self.faft_config.load_usb)
725 self.servo.switch_usbkey('host')
726 time.sleep(self.faft_config.between_usb_plug)
727
728 def wait_fw_screen_and_plug_usb(self):
729 """Wait for firmware warning screen and then unplug and plug the USB."""
730 self.wait_fw_screen_and_unplug_usb()
731 self.servo.switch_usbkey('dut')
732
733 def wait_fw_screen_and_press_power(self):
734 """Wait for firmware warning screen and press power button."""
735 time.sleep(self.faft_config.firmware_screen)
736 # While the firmware screen, the power button probing loop sleeps
737 # 0.25 second on every scan. Use the normal delay (1.2 second) for
738 # power press.
739 self.servo.power_normal_press()
740
741 def wait_longer_fw_screen_and_press_power(self):
742 """Wait for firmware screen without timeout and press power button."""
743 time.sleep(self.faft_config.dev_screen_timeout)
744 self.wait_fw_screen_and_press_power()
745
746 def wait_fw_screen_and_close_lid(self):
747 """Wait for firmware warning screen and close lid."""
748 time.sleep(self.faft_config.firmware_screen)
749 self.servo.lid_close()
750
751 def wait_longer_fw_screen_and_close_lid(self):
752 """Wait for firmware screen without timeout and close lid."""
753 time.sleep(self.faft_config.firmware_screen)
754 self.wait_fw_screen_and_close_lid()
755
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700756 def _setup_uart_capture(self):
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700757 """Setup the CPU/EC/PD UART capture."""
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700758 self.cpu_uart_file = os.path.join(self.resultsdir, 'cpu_uart.txt')
759 self.servo.set('cpu_uart_capture', 'on')
760 self.ec_uart_file = None
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700761 self.usbpd_uart_file = None
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700762 if self.faft_config.chrome_ec:
763 try:
764 self.servo.set('ec_uart_capture', 'on')
765 self.ec_uart_file = os.path.join(self.resultsdir, 'ec_uart.txt')
766 except error.TestFail as e:
767 if 'No control named' in str(e):
768 logging.warn('The servod is too old that ec_uart_capture '
769 'not supported.')
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700770 # Log separate PD console if supported
771 if self.check_ec_capability(['usbpd_uart'], suppress_warning=True):
772 try:
773 self.servo.set('usbpd_uart_capture', 'on')
774 self.usbpd_uart_file = os.path.join(self.resultsdir,
775 'usbpd_uart.txt')
776 except error.TestFail as e:
777 if 'No control named' in str(e):
778 logging.warn('The servod is too old that '
779 'usbpd_uart_capture is not supported.')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700780 else:
781 logging.info('Not a Google EC, cannot capture ec console output.')
782
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700783 def _record_uart_capture(self):
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700784 """Record the CPU/EC/PD UART output stream to files."""
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700785 if self.cpu_uart_file:
786 with open(self.cpu_uart_file, 'a') as f:
787 f.write(ast.literal_eval(self.servo.get('cpu_uart_stream')))
788 if self.ec_uart_file and self.faft_config.chrome_ec:
789 with open(self.ec_uart_file, 'a') as f:
790 f.write(ast.literal_eval(self.servo.get('ec_uart_stream')))
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700791 if (self.usbpd_uart_file and self.faft_config.chrome_ec and
792 self.check_ec_capability(['usbpd_uart'], suppress_warning=True)):
793 with open(self.usbpd_uart_file, 'a') as f:
794 f.write(ast.literal_eval(self.servo.get('usbpd_uart_stream')))
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700795
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700796 def _cleanup_uart_capture(self):
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700797 """Cleanup the CPU/EC/PD UART capture."""
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700798 # Flush the remaining UART output.
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700799 self._record_uart_capture()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700800 self.servo.set('cpu_uart_capture', 'off')
801 if self.ec_uart_file and self.faft_config.chrome_ec:
802 self.servo.set('ec_uart_capture', 'off')
Duncan Laurieaf61c1f2014-10-07 15:35:18 -0700803 if (self.usbpd_uart_file and self.faft_config.chrome_ec and
804 self.check_ec_capability(['usbpd_uart'], suppress_warning=True)):
805 self.servo.set('usbpd_uart_capture', 'off')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700806
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700807 def _fetch_servo_log(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700808 """Fetch the servo log."""
809 cmd = '[ -e %s ] && cat %s || echo NOTFOUND' % ((self._SERVOD_LOG,) * 2)
810 servo_log = self.servo.system_output(cmd)
811 return None if servo_log == 'NOTFOUND' else servo_log
812
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700813 def _setup_servo_log(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700814 """Setup the servo log capturing."""
815 self.servo_log_original_len = -1
816 if self.servo.is_localhost():
817 # No servo log recorded when servod runs locally.
818 return
819
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700820 servo_log = self._fetch_servo_log()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700821 if servo_log:
822 self.servo_log_original_len = len(servo_log)
823 else:
824 logging.warn('Servo log file not found.')
825
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700826 def _record_servo_log(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700827 """Record the servo log to the results directory."""
828 if self.servo_log_original_len != -1:
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700829 servo_log = self._fetch_servo_log()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700830 servo_log_file = os.path.join(self.resultsdir, 'servod.log')
831 with open(servo_log_file, 'a') as f:
832 f.write(servo_log[self.servo_log_original_len:])
833
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700834 def _record_faft_client_log(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700835 """Record the faft client log to the results directory."""
836 client_log = self.faft_client.system.dump_log(True)
837 client_log_file = os.path.join(self.resultsdir, 'faft_client.log')
838 with open(client_log_file, 'w') as f:
839 f.write(client_log)
840
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700841 def _setup_gbb_flags(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700842 """Setup the GBB flags for FAFT test."""
843 if self.faft_config.gbb_version < 1.1:
844 logging.info('Skip modifying GBB on versions older than 1.1.')
845 return
846
847 if self.check_setup_done('gbb_flags'):
848 return
849
850 self._backup_gbb_flags = self.faft_client.bios.get_gbb_flags()
851
852 logging.info('Set proper GBB flags for test.')
853 self.clear_set_gbb_flags(vboot.GBB_FLAG_DEV_SCREEN_SHORT_DELAY |
854 vboot.GBB_FLAG_FORCE_DEV_SWITCH_ON |
855 vboot.GBB_FLAG_FORCE_DEV_BOOT_USB |
856 vboot.GBB_FLAG_DISABLE_FW_ROLLBACK_CHECK,
857 vboot.GBB_FLAG_ENTER_TRIGGERS_TONORM |
858 vboot.GBB_FLAG_FAFT_KEY_OVERIDE)
859 self.mark_setup_done('gbb_flags')
860
861 def drop_backup_gbb_flags(self):
862 """Drops the backup GBB flags.
863
864 This can be used when a test intends to permanently change GBB flags.
865 """
866 self._backup_gbb_flags = None
867
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700868 def _restore_gbb_flags(self):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700869 """Restore GBB flags to their original state."""
870 if not self._backup_gbb_flags:
871 return
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700872 self._write_gbb_flags(self._backup_gbb_flags)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700873 self.unmark_setup_done('gbb_flags')
874
875 def setup_tried_fwb(self, tried_fwb):
876 """Setup for fw B tried state.
877
878 It makes sure the system in the requested fw B tried state. If not, it
879 tries to do so.
880
881 @param tried_fwb: True if requested in tried_fwb=1;
882 False if tried_fwb=0.
883 """
884 if tried_fwb:
885 if not self.checkers.crossystem_checker({'tried_fwb': '1'}):
886 logging.info(
887 'Firmware is not booted with tried_fwb. Reboot into it.')
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700888 self.faft_client.system.set_try_fw_b()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700889 else:
890 if not self.checkers.crossystem_checker({'tried_fwb': '0'}):
891 logging.info(
892 'Firmware is booted with tried_fwb. Reboot to clear.')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700893
894 def power_on(self):
895 """Switch DUT AC power on."""
896 self._client.power_on(self.power_control)
897
898 def power_off(self):
899 """Switch DUT AC power off."""
900 self._client.power_off(self.power_control)
901
902 def power_cycle(self):
903 """Power cycle DUT AC power."""
904 self._client.power_cycle(self.power_control)
905
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700906 def setup_rw_boot(self, section='a'):
907 """Make sure firmware is in RW-boot mode.
908
909 If the given firmware section is in RO-boot mode, turn off the RO-boot
910 flag and reboot DUT into RW-boot mode.
911
912 @param section: A firmware section, either 'a' or 'b'.
913 """
914 flags = self.faft_client.bios.get_preamble_flags(section)
915 if flags & vboot.PREAMBLE_USE_RO_NORMAL:
916 flags = flags ^ vboot.PREAMBLE_USE_RO_NORMAL
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700917 self.faft_client.bios.set_preamble_flags(section, flags)
Tom Wai-Hong Tam47776242015-05-07 02:45:32 +0800918 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700919
920 def setup_kernel(self, part):
921 """Setup for kernel test.
922
923 It makes sure both kernel A and B bootable and the current boot is
924 the requested kernel part.
925
926 @param part: A string of kernel partition number or 'a'/'b'.
927 """
928 self.ensure_kernel_boot(part)
929 logging.info('Checking the integrity of kernel B and rootfs B...')
930 if (self.faft_client.kernel.diff_a_b() or
931 not self.faft_client.rootfs.verify_rootfs('B')):
932 logging.info('Copying kernel and rootfs from A to B...')
933 self.copy_kernel_and_rootfs(from_part=part,
934 to_part=self.OTHER_KERNEL_MAP[part])
935 self.reset_and_prioritize_kernel(part)
936
937 def reset_and_prioritize_kernel(self, part):
938 """Make the requested partition highest priority.
939
940 This function also reset kerenl A and B to bootable.
941
942 @param part: A string of partition number to be prioritized.
943 """
944 root_dev = self.faft_client.system.get_root_dev()
945 # Reset kernel A and B to bootable.
946 self.faft_client.system.run_shell_command(
947 'cgpt add -i%s -P1 -S1 -T0 %s' % (self.KERNEL_MAP['a'], root_dev))
948 self.faft_client.system.run_shell_command(
949 'cgpt add -i%s -P1 -S1 -T0 %s' % (self.KERNEL_MAP['b'], root_dev))
950 # Set kernel part highest priority.
951 self.faft_client.system.run_shell_command('cgpt prioritize -i%s %s' %
952 (self.KERNEL_MAP[part], root_dev))
953
Yusuf Mohsinally1bacc962014-08-14 11:37:32 -0700954 def blocking_sync(self):
955 """Run a blocking sync command."""
956 # The double calls to sync fakes a blocking call
957 # since the first call returns before the flush
958 # is complete, but the second will wait for the
959 # first to finish.
960 self.faft_client.system.run_shell_command('sync')
961 self.faft_client.system.run_shell_command('sync')
962
Ryan Lin5bee6102014-09-16 13:17:02 -0700963 # sync only sends SYNCHRONIZE_CACHE but doesn't
Steve Fungb5752422015-01-09 16:45:32 -0800964 # check the status. For mmc devices, use `mmc
965 # status get` command to send an empty command to
966 # wait for the disk to be available again. For
967 # other devices, hdparm sends TUR to check if
Ryan Lin5bee6102014-09-16 13:17:02 -0700968 # a device is ready for transfer operation.
969 root_dev = self.faft_client.system.get_root_dev()
Steve Fungb5752422015-01-09 16:45:32 -0800970 if 'mmcblk' in root_dev:
971 self.faft_client.system.run_shell_command('mmc status get %s' %
972 root_dev)
973 else:
974 self.faft_client.system.run_shell_command('hdparm -f %s' % root_dev)
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700975
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +0800976 def wait_for_kernel_up(self):
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700977 """
978 Helper function that waits for the device to boot up to kernel.
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700979 """
980 logging.info("-[FAFT]-[ start wait_for_kernel_up ]---")
Duncan Laurieb3abc432014-10-07 15:48:15 -0700981 # Wait for the system to respond to ping before attempting ssh
982 if not self._client.ping_wait_up(90):
983 logging.warning("-[FAFT]-[ system did not respond to ping ]")
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700984 try:
Tom Wai-Hong Tameeed7fb2015-05-08 09:43:29 +0800985 self.wait_for_client()
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700986 # Stop update-engine as it may change firmware/kernel.
Yusuf Mohsinally8b377eb2014-05-12 18:50:03 -0700987 self._stop_service('update-engine')
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700988 except ConnectionError:
989 logging.error('wait_for_client() timed out.')
Yusuf Mohsinally64ee3a72014-06-26 10:24:27 -0700990 self._restore_routine_from_timeout()
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -0700991 logging.info("-[FAFT]-[ end wait_for_kernel_up ]-----")
992
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -0700993 def sync_and_ec_reboot(self, flags=''):
994 """Request the client sync and do a EC triggered reboot.
995
996 @param flags: Optional, a space-separated string of flags passed to EC
997 reboot command, including:
998 default: EC soft reboot;
999 'hard': EC cold/hard reboot.
1000 """
Yusuf Mohsinally1bacc962014-08-14 11:37:32 -07001001 self.blocking_sync()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001002 self.ec.reboot(flags)
1003 time.sleep(self.faft_config.ec_boot_to_console)
1004 self.check_lid_and_power_on()
1005
1006 def reboot_with_factory_install_shim(self):
1007 """Request reboot with factory install shim to reset TPM.
1008
1009 Factory install shim requires dev mode enabled. So this method switches
1010 firmware to dev mode first and reboot. The client uses factory install
1011 shim to reset TPM values.
1012 """
1013 # Unplug USB first to avoid the complicated USB autoboot cases.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001014 is_dev = self.checkers.crossystem_checker({'devsw_boot': '1'})
1015 if not is_dev:
Tom Wai-Hong Tamda6c6ba2015-05-02 05:32:41 +08001016 self.switcher.reboot_to_mode(to_mode='dev', wait_for_dut_up=False)
Tom Wai-Hong Tamf2de4de2015-05-02 02:48:08 +08001017 self.switcher.reboot_to_mode(to_mode='rec')
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001018 self.wait_fw_screen_and_plug_usb()
1019 time.sleep(self.faft_config.install_shim_done)
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +08001020 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001021
1022 def full_power_off_and_on(self):
1023 """Shutdown the device by pressing power button and power on again."""
Danny Chan101b0b22014-11-06 10:08:54 -08001024 boot_id = self.get_bootid()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001025 # Press power button to trigger Chrome OS normal shutdown process.
1026 # We use a customized delay since the normal-press 1.2s is not enough.
1027 self.servo.power_key(self.faft_config.hold_pwr_button)
Danny Chan101b0b22014-11-06 10:08:54 -08001028 # device can take 44-51 seconds to restart,
1029 # add buffer from the default timeout of 60 seconds.
1030 self.wait_for_client_offline(timeout=100, orig_boot_id=boot_id)
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001031 time.sleep(self.faft_config.shutdown)
1032 # Short press power button to boot DUT again.
1033 self.servo.power_short_press()
1034
1035 def check_lid_and_power_on(self):
1036 """
1037 On devices with EC software sync, system powers on after EC reboots if
1038 lid is open. Otherwise, the EC shuts down CPU after about 3 seconds.
1039 This method checks lid switch state and presses power button if
1040 necessary.
1041 """
1042 if self.servo.get("lid_open") == "no":
1043 time.sleep(self.faft_config.software_sync)
1044 self.servo.power_short_press()
1045
1046 def _modify_usb_kernel(self, usb_dev, from_magic, to_magic):
1047 """Modify the kernel header magic in USB stick.
1048
1049 The kernel header magic is the first 8-byte of kernel partition.
1050 We modify it to make it fail on kernel verification check.
1051
1052 @param usb_dev: A string of USB stick path on the host, like '/dev/sdc'.
1053 @param from_magic: A string of magic which we change it from.
1054 @param to_magic: A string of magic which we change it to.
1055 @raise TestError: if failed to change magic.
1056 """
1057 assert len(from_magic) == 8
1058 assert len(to_magic) == 8
1059 # USB image only contains one kernel.
1060 kernel_part = self._join_part(usb_dev, self.KERNEL_MAP['a'])
1061 read_cmd = "sudo dd if=%s bs=8 count=1 2>/dev/null" % kernel_part
1062 current_magic = self.servo.system_output(read_cmd)
1063 if current_magic == to_magic:
1064 logging.info("The kernel magic is already %s.", current_magic)
1065 return
1066 if current_magic != from_magic:
1067 raise error.TestError("Invalid kernel image on USB: wrong magic.")
1068
1069 logging.info('Modify the kernel magic in USB, from %s to %s.',
1070 from_magic, to_magic)
1071 write_cmd = ("echo -n '%s' | sudo dd of=%s oflag=sync conv=notrunc "
1072 " 2>/dev/null" % (to_magic, kernel_part))
1073 self.servo.system(write_cmd)
1074
1075 if self.servo.system_output(read_cmd) != to_magic:
1076 raise error.TestError("Failed to write new magic.")
1077
1078 def corrupt_usb_kernel(self, usb_dev):
1079 """Corrupt USB kernel by modifying its magic from CHROMEOS to CORRUPTD.
1080
1081 @param usb_dev: A string of USB stick path on the host, like '/dev/sdc'.
1082 """
1083 self._modify_usb_kernel(usb_dev, self.CHROMEOS_MAGIC,
1084 self.CORRUPTED_MAGIC)
1085
1086 def restore_usb_kernel(self, usb_dev):
1087 """Restore USB kernel by modifying its magic from CORRUPTD to CHROMEOS.
1088
1089 @param usb_dev: A string of USB stick path on the host, like '/dev/sdc'.
1090 """
1091 self._modify_usb_kernel(usb_dev, self.CORRUPTED_MAGIC,
1092 self.CHROMEOS_MAGIC)
1093
1094 def _call_action(self, action_tuple, check_status=False):
1095 """Call the action function with/without arguments.
1096
1097 @param action_tuple: A function, or a tuple (function, args, error_msg),
1098 in which, args and error_msg are optional. args is
1099 either a value or a tuple if multiple arguments.
1100 This can also be a list containing multiple
1101 function or tuple. In this case, these actions are
1102 called in sequence.
1103 @param check_status: Check the return value of action function. If not
1104 succeed, raises a TestFail exception.
1105 @return: The result value of the action function.
1106 @raise TestError: An error when the action function is not callable.
1107 @raise TestFail: When check_status=True, action function not succeed.
1108 """
1109 if isinstance(action_tuple, list):
1110 return all([self._call_action(action, check_status=check_status)
1111 for action in action_tuple])
1112
1113 action = action_tuple
1114 args = ()
1115 error_msg = 'Not succeed'
1116 if isinstance(action_tuple, tuple):
1117 action = action_tuple[0]
1118 if len(action_tuple) >= 2:
1119 args = action_tuple[1]
1120 if not isinstance(args, tuple):
1121 args = (args,)
1122 if len(action_tuple) >= 3:
1123 error_msg = action_tuple[2]
1124
1125 if action is None:
1126 return
1127
1128 if not callable(action):
1129 raise error.TestError('action is not callable!')
1130
1131 info_msg = 'calling %s' % str(action)
1132 if args:
1133 info_msg += ' with args %s' % str(args)
1134 logging.info(info_msg)
1135 ret = action(*args)
1136
1137 if check_status and not ret:
1138 raise error.TestFail('%s: %s returning %s' %
1139 (error_msg, info_msg, str(ret)))
1140 return ret
1141
1142 def run_shutdown_process(self, shutdown_action, pre_power_action=None,
1143 post_power_action=None, shutdown_timeout=None):
1144 """Run shutdown_action(), which makes DUT shutdown, and power it on.
1145
1146 @param shutdown_action: function which makes DUT shutdown, like
1147 pressing power key.
1148 @param pre_power_action: function which is called before next power on.
1149 @param post_power_action: function which is called after next power on.
1150 @param shutdown_timeout: a timeout to confirm DUT shutdown.
1151 @raise TestFail: if the shutdown_action() failed to turn DUT off.
1152 """
1153 self._call_action(shutdown_action)
1154 logging.info('Wait to ensure DUT shut down...')
1155 try:
1156 if shutdown_timeout is None:
1157 shutdown_timeout = self.faft_config.shutdown_timeout
1158 self.wait_for_client(timeout=shutdown_timeout)
1159 raise error.TestFail(
1160 'Should shut the device down after calling %s.' %
1161 str(shutdown_action))
1162 except ConnectionError:
1163 logging.info(
1164 'DUT is surely shutdown. We are going to power it on again...')
1165
1166 if pre_power_action:
1167 self._call_action(pre_power_action)
1168 self.servo.power_short_press()
1169 if post_power_action:
1170 self._call_action(post_power_action)
1171
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001172 def get_bootid(self, retry=3):
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001173 """
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001174 Return the bootid.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001175 """
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001176 boot_id = None
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001177 while retry:
1178 try:
1179 boot_id = self._client.get_boot_id()
1180 break
1181 except error.AutoservRunError:
1182 retry -= 1
1183 if retry:
1184 logging.info('Retry to get boot_id...')
1185 else:
1186 logging.warning('Failed to get boot_id.')
1187 logging.info('boot_id: %s', boot_id)
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001188 return boot_id
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001189
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001190 def check_state(self, func):
1191 """
1192 Wrapper around _call_action with check_status set to True. This is a
1193 helper function to be used by tests and is currently implemented by
1194 calling _call_action with check_status=True.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001195
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001196 TODO: This function's arguments need to be made more stringent. And
1197 its functionality should be moved over to check functions directly in
1198 the future.
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001199
Yusuf Mohsinallyab1b5fc2014-05-08 12:46:10 -07001200 @param func: A function, or a tuple (function, args, error_msg),
1201 in which, args and error_msg are optional. args is
1202 either a value or a tuple if multiple arguments.
1203 This can also be a list containing multiple
1204 function or tuple. In this case, these actions are
1205 called in sequence.
1206 @return: The result value of the action function.
1207 @raise TestFail: If the function does notsucceed.
1208 """
1209 logging.info("-[FAFT]-[ start stepstate_checker ]----------")
1210 self._call_action(func, check_status=True)
1211 logging.info("-[FAFT]-[ end state_checker ]----------------")
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001212
1213 def get_current_firmware_sha(self):
1214 """Get current firmware sha of body and vblock.
1215
1216 @return: Current firmware sha follows the order (
1217 vblock_a_sha, body_a_sha, vblock_b_sha, body_b_sha)
1218 """
1219 current_firmware_sha = (self.faft_client.bios.get_sig_sha('a'),
1220 self.faft_client.bios.get_body_sha('a'),
1221 self.faft_client.bios.get_sig_sha('b'),
1222 self.faft_client.bios.get_body_sha('b'))
1223 if not all(current_firmware_sha):
1224 raise error.TestError('Failed to get firmware sha.')
1225 return current_firmware_sha
1226
1227 def is_firmware_changed(self):
1228 """Check if the current firmware changed, by comparing its SHA.
1229
1230 @return: True if it is changed, otherwise Flase.
1231 """
1232 # Device may not be rebooted after test.
1233 self.faft_client.bios.reload()
1234
1235 current_sha = self.get_current_firmware_sha()
1236
1237 if current_sha == self._backup_firmware_sha:
1238 return False
1239 else:
1240 corrupt_VBOOTA = (current_sha[0] != self._backup_firmware_sha[0])
1241 corrupt_FVMAIN = (current_sha[1] != self._backup_firmware_sha[1])
1242 corrupt_VBOOTB = (current_sha[2] != self._backup_firmware_sha[2])
1243 corrupt_FVMAINB = (current_sha[3] != self._backup_firmware_sha[3])
1244 logging.info("Firmware changed:")
1245 logging.info('VBOOTA is changed: %s', corrupt_VBOOTA)
1246 logging.info('VBOOTB is changed: %s', corrupt_VBOOTB)
1247 logging.info('FVMAIN is changed: %s', corrupt_FVMAIN)
1248 logging.info('FVMAINB is changed: %s', corrupt_FVMAINB)
1249 return True
1250
1251 def backup_firmware(self, suffix='.original'):
1252 """Backup firmware to file, and then send it to host.
1253
1254 @param suffix: a string appended to backup file name
1255 """
1256 remote_temp_dir = self.faft_client.system.create_temp_dir()
1257 self.faft_client.bios.dump_whole(os.path.join(remote_temp_dir, 'bios'))
1258 self._client.get_file(os.path.join(remote_temp_dir, 'bios'),
1259 os.path.join(self.resultsdir, 'bios' + suffix))
1260
1261 self._backup_firmware_sha = self.get_current_firmware_sha()
1262 logging.info('Backup firmware stored in %s with suffix %s',
1263 self.resultsdir, suffix)
1264
1265 def is_firmware_saved(self):
1266 """Check if a firmware saved (called backup_firmware before).
1267
1268 @return: True if the firmware is backuped; otherwise False.
1269 """
1270 return self._backup_firmware_sha != ()
1271
1272 def clear_saved_firmware(self):
1273 """Clear the firmware saved by the method backup_firmware."""
1274 self._backup_firmware_sha = ()
1275
1276 def restore_firmware(self, suffix='.original'):
1277 """Restore firmware from host in resultsdir.
1278
1279 @param suffix: a string appended to backup file name
1280 """
1281 if not self.is_firmware_changed():
1282 return
1283
1284 # Backup current corrupted firmware.
1285 self.backup_firmware(suffix='.corrupt')
1286
1287 # Restore firmware.
1288 remote_temp_dir = self.faft_client.system.create_temp_dir()
1289 self._client.send_file(os.path.join(self.resultsdir, 'bios' + suffix),
1290 os.path.join(remote_temp_dir, 'bios'))
1291
1292 self.faft_client.bios.write_whole(
1293 os.path.join(remote_temp_dir, 'bios'))
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +08001294 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001295 logging.info('Successfully restore firmware.')
1296
1297 def setup_firmwareupdate_shellball(self, shellball=None):
1298 """Deside a shellball to use in firmware update test.
1299
1300 Check if there is a given shellball, and it is a shell script. Then,
1301 send it to the remote host. Otherwise, use
1302 /usr/sbin/chromeos-firmwareupdate.
1303
1304 @param shellball: path of a shellball or default to None.
1305
1306 @return: Path of shellball in remote host. If use default shellball,
1307 reutrn None.
1308 """
1309 updater_path = None
1310 if shellball:
1311 # Determine the firmware file is a shellball or a raw binary.
1312 is_shellball = (utils.system_output("file %s" % shellball).find(
1313 "shell script") != -1)
1314 if is_shellball:
1315 logging.info('Device will update firmware with shellball %s',
1316 shellball)
1317 temp_dir = self.faft_client.system.create_temp_dir(
1318 'shellball_')
1319 temp_shellball = os.path.join(temp_dir, 'updater.sh')
1320 self._client.send_file(shellball, temp_shellball)
1321 updater_path = temp_shellball
1322 else:
1323 raise error.TestFail(
1324 'The given shellball is not a shell script.')
1325 return updater_path
1326
1327 def is_kernel_changed(self):
1328 """Check if the current kernel is changed, by comparing its SHA1 hash.
1329
1330 @return: True if it is changed; otherwise, False.
1331 """
1332 changed = False
1333 for p in ('A', 'B'):
1334 backup_sha = self._backup_kernel_sha.get(p, None)
1335 current_sha = self.faft_client.kernel.get_sha(p)
1336 if backup_sha != current_sha:
1337 changed = True
1338 logging.info('Kernel %s is changed', p)
1339 return changed
1340
1341 def backup_kernel(self, suffix='.original'):
1342 """Backup kernel to files, and the send them to host.
1343
1344 @param suffix: a string appended to backup file name.
1345 """
1346 remote_temp_dir = self.faft_client.system.create_temp_dir()
1347 for p in ('A', 'B'):
1348 remote_path = os.path.join(remote_temp_dir, 'kernel_%s' % p)
1349 self.faft_client.kernel.dump(p, remote_path)
1350 self._client.get_file(
1351 remote_path,
1352 os.path.join(self.resultsdir, 'kernel_%s%s' % (p, suffix)))
1353 self._backup_kernel_sha[p] = self.faft_client.kernel.get_sha(p)
1354 logging.info('Backup kernel stored in %s with suffix %s',
1355 self.resultsdir, suffix)
1356
1357 def is_kernel_saved(self):
1358 """Check if kernel images are saved (backup_kernel called before).
1359
1360 @return: True if the kernel is saved; otherwise, False.
1361 """
1362 return len(self._backup_kernel_sha) != 0
1363
1364 def clear_saved_kernel(self):
1365 """Clear the kernel saved by backup_kernel()."""
1366 self._backup_kernel_sha = dict()
1367
1368 def restore_kernel(self, suffix='.original'):
1369 """Restore kernel from host in resultsdir.
1370
1371 @param suffix: a string appended to backup file name.
1372 """
1373 if not self.is_kernel_changed():
1374 return
1375
1376 # Backup current corrupted kernel.
1377 self.backup_kernel(suffix='.corrupt')
1378
1379 # Restore kernel.
1380 remote_temp_dir = self.faft_client.system.create_temp_dir()
1381 for p in ('A', 'B'):
1382 remote_path = os.path.join(remote_temp_dir, 'kernel_%s' % p)
1383 self._client.send_file(
1384 os.path.join(self.resultsdir, 'kernel_%s%s' % (p, suffix)),
1385 remote_path)
1386 self.faft_client.kernel.write(p, remote_path)
1387
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +08001388 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001389 logging.info('Successfully restored kernel.')
1390
1391 def backup_cgpt_attributes(self):
1392 """Backup CGPT partition table attributes."""
1393 self._backup_cgpt_attr = self.faft_client.cgpt.get_attributes()
1394
1395 def restore_cgpt_attributes(self):
1396 """Restore CGPT partition table attributes."""
1397 current_table = self.faft_client.cgpt.get_attributes()
1398 if current_table == self._backup_cgpt_attr:
1399 return
1400 logging.info('CGPT table is changed. Original: %r. Current: %r.',
1401 self._backup_cgpt_attr,
1402 current_table)
1403 self.faft_client.cgpt.set_attributes(self._backup_cgpt_attr)
1404
Tom Wai-Hong Tama704f182015-05-06 06:12:55 +08001405 self.switcher.mode_aware_reboot()
Yusuf Mohsinally05c3c552014-05-07 23:56:42 -07001406 logging.info('Successfully restored CGPT table.')
Shelley Chen3edea982014-12-30 14:54:21 -08001407
1408 def try_fwb(self, count=0):
1409 """set to try booting FWB count # times
1410
1411 Wrapper to set fwb_tries for vboot1 and fw_try_count,fw_try_next for
1412 vboot2
1413
1414 @param count: an integer specifying value to program into
1415 fwb_tries(vb1)/fw_try_next(vb2)
1416 """
1417 if self.fw_vboot2:
1418 self.faft_client.system.set_fw_try_next('B', count)
1419 else:
1420 # vboot1: we need to boot into fwb at least once
1421 if not count:
1422 count = count + 1
1423 self.faft_client.system.set_try_fw_b(count)
1424