blob: 8e36aec88cbae53d80b55bc15264a6f4b5a04d2c [file] [log] [blame]
mbligh6203ace2007-10-04 21:54:24 +00001#!/usr/bin/python -u
mbligh1ffd5dc2008-11-25 13:24:05 +00002# Copyright 2007-2008 Martin J. Bligh <mbligh@google.com>, Google Inc.
mbligh82648e52008-11-20 16:54:25 +00003# Released under the GPL v2
mblighdcd57a82007-07-11 23:06:47 +00004
mblighc8949b82007-07-23 16:33:58 +00005"""
Aviv Keshetde6bb192013-01-30 16:17:22 -08006Run a control file through the server side engine
mblighdcd57a82007-07-11 23:06:47 +00007"""
mbligh1ffd5dc2008-11-25 13:24:05 +00008
Fang Deng042c1472014-10-23 13:56:41 -07009import ast
10import datetime
11import getpass
12import logging
13import os
14import re
15import signal
Dan Shicf4d2032015-03-12 15:04:21 -070016import socket
Fang Deng042c1472014-10-23 13:56:41 -070017import sys
18import traceback
19import time
20import urllib2
mbligh1ffd5dc2008-11-25 13:24:05 +000021
mblighf5427bb2008-04-09 15:55:57 +000022import common
mbligh9ff89cd2009-09-03 20:28:17 +000023
Dan Shia1ecd5c2013-06-06 11:21:31 -070024from autotest_lib.client.common_lib import control_data
Dan Shi32649b82015-08-29 20:53:36 -070025from autotest_lib.client.common_lib import error
Dan Shia1ecd5c2013-06-06 11:21:31 -070026from autotest_lib.client.common_lib import global_config
Dan Shi5ddf6a32015-05-02 00:22:01 -070027from autotest_lib.client.common_lib import utils
Dan Shi37bee222015-04-13 15:46:47 -070028from autotest_lib.client.common_lib.cros.graphite import autotest_es
29from autotest_lib.client.common_lib.cros.graphite import autotest_stats
Prashanth Balasubramanianf8b83712014-11-06 15:58:21 -080030try:
31 from autotest_lib.puppylab import results_mocker
32except ImportError:
33 results_mocker = None
34
Dan Shia06f3e22015-09-03 16:15:15 -070035_CONFIG = global_config.global_config
36
37require_atfork = _CONFIG.get_config_value(
mblighcb8cb332009-09-03 21:08:56 +000038 'AUTOSERV', 'require_atfork_module', type=bool, default=True)
39
Dan Shia1ecd5c2013-06-06 11:21:31 -070040
Jakob Jueliche497b552014-09-23 19:11:59 -070041# Number of seconds to wait before returning if testing mode is enabled
Prashanth B6285f6a2014-05-08 18:01:27 -070042TESTING_MODE_SLEEP_SECS = 1
Jakob Jueliche497b552014-09-23 19:11:59 -070043
mblighcb8cb332009-09-03 21:08:56 +000044try:
45 import atfork
46 atfork.monkeypatch_os_fork_functions()
47 import atfork.stdlib_fixer
48 # Fix the Python standard library for threading+fork safety with its
49 # internal locks. http://code.google.com/p/python-atfork/
50 import warnings
51 warnings.filterwarnings('ignore', 'logging module already imported')
52 atfork.stdlib_fixer.fix_logging_module()
53except ImportError, e:
54 from autotest_lib.client.common_lib import global_config
Dan Shia06f3e22015-09-03 16:15:15 -070055 if _CONFIG.get_config_value(
mblighcb8cb332009-09-03 21:08:56 +000056 'AUTOSERV', 'require_atfork_module', type=bool, default=False):
57 print >>sys.stderr, 'Please run utils/build_externals.py'
58 print e
59 sys.exit(1)
mbligh9ff89cd2009-09-03 20:28:17 +000060
Dan Shia1ecd5c2013-06-06 11:21:31 -070061from autotest_lib.server import frontend
showard75cdfee2009-06-10 17:40:41 +000062from autotest_lib.server import server_logging_config
showard043c62a2009-06-10 19:48:57 +000063from autotest_lib.server import server_job, utils, autoserv_parser, autotest
Dan Shia1ecd5c2013-06-06 11:21:31 -070064from autotest_lib.server import utils as server_utils
Dan Shicf4d2032015-03-12 15:04:21 -070065from autotest_lib.site_utils import job_directories
Fang Deng042c1472014-10-23 13:56:41 -070066from autotest_lib.site_utils import job_overhead
Dan Shicf4d2032015-03-12 15:04:21 -070067from autotest_lib.site_utils import lxc
Dan Shi7836d252015-04-27 15:33:58 -070068from autotest_lib.site_utils import lxc_utils
showard75cdfee2009-06-10 17:40:41 +000069from autotest_lib.client.common_lib import pidfile, logging_manager
Gabe Black1e1c41b2015-02-04 23:55:15 -080070from autotest_lib.client.common_lib.cros.graphite import autotest_stats
mbligh92c0fc22008-11-20 16:52:23 +000071
Dan Shicf4d2032015-03-12 15:04:21 -070072# Control segment to stage server-side package.
73STAGE_SERVER_SIDE_PACKAGE_CONTROL_FILE = server_job._control_segment_path(
74 'stage_server_side_package')
75
Dan Shia06f3e22015-09-03 16:15:15 -070076# Command line to start servod in a moblab.
77START_SERVOD_CMD = 'sudo start servod BOARD=%s PORT=%s'
78STOP_SERVOD_CMD = 'sudo stop servod'
79
Alex Millerf1af17e2013-01-09 22:50:32 -080080def log_alarm(signum, frame):
81 logging.error("Received SIGALARM. Ignoring and continuing on.")
Alex Miller0528d6f2013-01-11 10:49:48 -080082 sys.exit(1)
Alex Millerf1af17e2013-01-09 22:50:32 -080083
Dan Shicf4d2032015-03-12 15:04:21 -070084
85def _get_machines(parser):
86 """Get a list of machine names from command line arg -m or a file.
87
88 @param parser: Parser for the command line arguments.
89
90 @return: A list of machine names from command line arg -m or the
91 machines file specified in the command line arg -M.
92 """
93 if parser.options.machines:
94 machines = parser.options.machines.replace(',', ' ').strip().split()
95 else:
96 machines = []
97 machines_file = parser.options.machines_file
98 if machines_file:
99 machines = []
100 for m in open(machines_file, 'r').readlines():
101 # remove comments, spaces
102 m = re.sub('#.*', '', m).strip()
103 if m:
104 machines.append(m)
105 logging.debug('Read list of machines from file: %s', machines_file)
106 logging.debug('Machines: %s', ','.join(machines))
107
108 if machines:
109 for machine in machines:
110 if not machine or re.search('\s', machine):
111 parser.parser.error("Invalid machine: %s" % str(machine))
112 machines = list(set(machines))
113 machines.sort()
114 return machines
115
116
117def _stage_ssp(parser):
118 """Stage server-side package.
119
120 This function calls a control segment to stage server-side package based on
121 the job and autoserv command line option. The detail implementation could
122 be different for each host type. Currently, only CrosHost has
123 stage_server_side_package function defined.
124 The script returns None if no server-side package is available. However,
125 it may raise exception if it failed for reasons other than artifact (the
126 server-side package) not found.
127
128 @param parser: Command line arguments parser passed in the autoserv process.
129
130 @return: url of the staged server-side package. Return None if server-
131 side package is not found for the build.
132 """
Dan Shi36cfd832014-10-10 13:38:51 -0700133 # If test_source_build is not specified, default to use server-side test
134 # code from build specified in --image.
Dan Shicf4d2032015-03-12 15:04:21 -0700135 namespace = {'machines': _get_machines(parser),
Dan Shi36cfd832014-10-10 13:38:51 -0700136 'image': (parser.options.test_source_build or
137 parser.options.image),}
Dan Shicf4d2032015-03-12 15:04:21 -0700138 script_locals = {}
139 execfile(STAGE_SERVER_SIDE_PACKAGE_CONTROL_FILE, namespace, script_locals)
140 return script_locals['ssp_url']
141
142
Dan Shi37befda2015-12-07 13:16:56 -0800143def _run_with_ssp(job, container_name, job_id, results, parser, ssp_url):
Dan Shicf4d2032015-03-12 15:04:21 -0700144 """Run the server job with server-side packaging.
145
Dan Shi37befda2015-12-07 13:16:56 -0800146 @param job: The server job object.
Dan Shicf4d2032015-03-12 15:04:21 -0700147 @param container_name: Name of the container to run the test.
148 @param job_id: ID of the test job.
149 @param results: Folder to store results. This could be different from
150 parser.options.results:
151 parser.options.results can be set to None for results to be
152 stored in a temp folder.
153 results can be None for autoserv run requires no logging.
154 @param parser: Command line parser that contains the options.
155 @param ssp_url: url of the staged server-side package.
156 """
157 bucket = lxc.ContainerBucket()
158 control = (parser.args[0] if len(parser.args) > 0 and parser.args[0] != ''
159 else None)
Dan Shi37befda2015-12-07 13:16:56 -0800160 try:
161 test_container = bucket.setup_test(container_name, job_id, ssp_url,
162 results, control=control)
163 except Exception as e:
164 job.record('FAIL', None, None,
165 'Failed to setup container for test: %s. Check logs in '
166 'ssp_logs folder for more details.' % e)
167 raise
168
Dan Shicf4d2032015-03-12 15:04:21 -0700169 args = sys.argv[:]
170 args.remove('--require-ssp')
Dan Shi77b79a62015-07-29 16:22:05 -0700171 # --parent_job_id is only useful in autoserv running in host, not in
172 # container. Include this argument will cause test to fail for builds before
173 # CL 286265 was merged.
174 if '--parent_job_id' in args:
175 index = args.index('--parent_job_id')
176 args.remove('--parent_job_id')
177 # Remove the actual parent job id in command line arg.
178 del args[index]
Dan Shicf4d2032015-03-12 15:04:21 -0700179
180 # A dictionary of paths to replace in the command line. Key is the path to
181 # be replaced with the one in value.
182 paths_to_replace = {}
183 # Replace the control file path with the one in container.
184 if control:
185 container_control_filename = os.path.join(
186 lxc.CONTROL_TEMP_PATH, os.path.basename(control))
187 paths_to_replace[control] = container_control_filename
188 # Update result directory with the one in container.
189 if parser.options.results:
190 container_result_dir = os.path.join(lxc.RESULT_DIR_FMT % job_id)
191 paths_to_replace[parser.options.results] = container_result_dir
192 # Update parse_job directory with the one in container. The assumption is
193 # that the result folder to be parsed is always the same as the results_dir.
194 if parser.options.parse_job:
195 container_parse_dir = os.path.join(lxc.RESULT_DIR_FMT % job_id)
196 paths_to_replace[parser.options.parse_job] = container_result_dir
197
198 args = [paths_to_replace.get(arg, arg) for arg in args]
199
200 # Apply --use-existing-results, results directory is aready created and
201 # mounted in container. Apply this arg to avoid exception being raised.
202 if not '--use-existing-results' in args:
203 args.append('--use-existing-results')
204
205 # Make sure autoserv running in container using a different pid file.
206 if not '--pidfile-label' in args:
207 args.extend(['--pidfile-label', 'container_autoserv'])
208
Dan Shid1f51232015-04-18 00:29:14 -0700209 cmd_line = ' '.join(["'%s'" % arg if ' ' in arg else arg for arg in args])
Dan Shicf4d2032015-03-12 15:04:21 -0700210 logging.info('Run command in container: %s', cmd_line)
Dan Shi37bee222015-04-13 15:46:47 -0700211 success = False
Dan Shicf4d2032015-03-12 15:04:21 -0700212 try:
213 test_container.attach_run(cmd_line)
Dan Shi37bee222015-04-13 15:46:47 -0700214 success = True
Dan Shi9d3454e2015-12-08 09:16:08 -0800215 except Exception as e:
216 # If the test run inside container fails without generating any log,
217 # write a message to status.log to help troubleshooting.
218 debug_files = os.listdir(os.path.join(results, 'debug'))
219 if not debug_files:
220 job.record('FAIL', None, None,
221 'Failed to run test inside the container: %s. Check '
222 'logs in ssp_logs folder for more details.' % e)
223 raise
Dan Shicf4d2032015-03-12 15:04:21 -0700224 finally:
Dan Shi37bee222015-04-13 15:46:47 -0700225 counter_key = '%s.%s' % (lxc.STATS_KEY,
226 'success' if success else 'fail')
227 autotest_stats.Counter(counter_key).increment()
228 # metadata is uploaded separately so it can use http to upload.
229 metadata = {'drone': socket.gethostname(),
230 'job_id': job_id,
231 'success': success}
232 autotest_es.post(use_http=True,
233 type_str=lxc.CONTAINER_RUN_TEST_METADB_TYPE,
234 metadata=metadata)
Dan Shicf4d2032015-03-12 15:04:21 -0700235 test_container.destroy()
236
237
Dan Shi3f1b8a52015-04-21 11:11:06 -0700238def correct_results_folder_permission(results):
239 """Make sure the results folder has the right permission settings.
240
241 For tests running with server-side packaging, the results folder has the
242 owner of root. This must be changed to the user running the autoserv
243 process, so parsing job can access the results folder.
244 TODO(dshi): crbug.com/459344 Remove this function when test container can be
245 unprivileged container.
246
247 @param results: Path to the results folder.
248
249 """
250 if not results:
251 return
252
Dan Shi32649b82015-08-29 20:53:36 -0700253 try:
254 utils.run('sudo -n chown -R %s "%s"' % (os.getuid(), results))
255 utils.run('sudo -n chgrp -R %s "%s"' % (os.getgid(), results))
256 except error.CmdError as e:
257 metadata = {'error': str(e),
258 'result_folder': results,
259 'drone': socket.gethostname()}
260 autotest_es.post(use_http=True, type_str='correct_results_folder_failure',
261 metadata=metadata)
262 raise
Dan Shi3f1b8a52015-04-21 11:11:06 -0700263
264
Dan Shia06f3e22015-09-03 16:15:15 -0700265def _start_servod(machine):
266 """Try to start servod in moblab if it's not already running or running with
267 different board or port.
268
269 @param machine: Name of the dut used for test.
270 """
271 if not utils.is_moblab():
272 return
273
Dan Shi1cded882015-09-23 16:52:26 -0700274 logging.debug('Trying to start servod.')
Dan Shia06f3e22015-09-03 16:15:15 -0700275 try:
276 afe = frontend.AFE()
277 board = server_utils.get_board_from_afe(machine, afe)
278 hosts = afe.get_hosts(hostname=machine)
279 servo_host = hosts[0].attributes.get('servo_host', None)
280 servo_port = hosts[0].attributes.get('servo_port', 9999)
281 if not servo_host in ['localhost', '127.0.0.1']:
Dan Shi1cded882015-09-23 16:52:26 -0700282 logging.warn('Starting servod is aborted. The dut\'s servo_host '
283 'attribute is not set to localhost.')
Dan Shia06f3e22015-09-03 16:15:15 -0700284 return
285 except (urllib2.HTTPError, urllib2.URLError):
286 # Ignore error if RPC failed to get board
287 logging.error('Failed to get board name from AFE. Start servod is '
288 'aborted')
289 return
290
291 try:
292 pid = utils.run('pgrep servod').stdout
293 cmd_line = utils.run('ps -fp %s' % pid).stdout
294 if ('--board %s' % board in cmd_line and
295 '--port %s' % servo_port in cmd_line):
296 logging.debug('Servod is already running with given board and port.'
297 ' There is no need to restart servod.')
298 return
299 logging.debug('Servod is running with different board or port. '
300 'Stopping existing servod.')
301 utils.run('sudo stop servod')
302 except error.CmdError:
303 # servod is not running.
304 pass
305
306 try:
307 utils.run(START_SERVOD_CMD % (board, servo_port))
308 logging.debug('Servod is started')
309 except error.CmdError as e:
310 logging.error('Servod failed to be started, error: %s', e)
311
312
Dan Shic68fefb2015-04-07 10:10:52 -0700313def run_autoserv(pid_file_manager, results, parser, ssp_url, use_ssp):
Dan Shicf4d2032015-03-12 15:04:21 -0700314 """Run server job with given options.
315
316 @param pid_file_manager: PidFileManager used to monitor the autoserv process
317 @param results: Folder to store results.
318 @param parser: Parser for the command line arguments.
319 @param ssp_url: Url to server-side package.
Dan Shic68fefb2015-04-07 10:10:52 -0700320 @param use_ssp: Set to True to run with server-side packaging.
Dan Shicf4d2032015-03-12 15:04:21 -0700321 """
Dan Shiec1d47d2015-02-13 11:38:13 -0800322 if parser.options.warn_no_ssp:
Dan Shic68fefb2015-04-07 10:10:52 -0700323 # Post a warning in the log.
Dan Shiec1d47d2015-02-13 11:38:13 -0800324 logging.warn('Autoserv is required to run with server-side packaging. '
325 'However, no drone is found to support server-side '
326 'packaging. The test will be executed in a drone without '
327 'server-side packaging supported.')
328
jadmanski0afbb632008-06-06 21:10:57 +0000329 # send stdin to /dev/null
330 dev_null = os.open(os.devnull, os.O_RDONLY)
331 os.dup2(dev_null, sys.stdin.fileno())
332 os.close(dev_null)
mblighdbf37612007-11-24 19:38:11 +0000333
jadmanski0afbb632008-06-06 21:10:57 +0000334 # Create separate process group
335 os.setpgrp()
mbligh1d42d4e2007-11-05 22:42:00 +0000336
Dan Shicf4d2032015-03-12 15:04:21 -0700337 # Container name is predefined so the container can be destroyed in
338 # handle_sigterm.
339 job_or_task_id = job_directories.get_job_id_or_task_id(
340 parser.options.results)
341 container_name = (lxc.TEST_CONTAINER_NAME_FMT %
Dan Shid68d51c2015-04-21 17:00:42 -0700342 (job_or_task_id, time.time(), os.getpid()))
Dan Shicf4d2032015-03-12 15:04:21 -0700343
jadmanski0afbb632008-06-06 21:10:57 +0000344 # Implement SIGTERM handler
mblighc2299562009-07-02 19:00:36 +0000345 def handle_sigterm(signum, frame):
Simran Basi9d9b7292013-10-16 16:44:07 -0700346 logging.debug('Received SIGTERM')
mblighff7d61f2008-12-22 14:53:35 +0000347 if pid_file_manager:
348 pid_file_manager.close_file(1, signal.SIGTERM)
Simran Basi49e21e62013-10-17 12:40:33 -0700349 logging.debug('Finished writing to pid_file. Killing process.')
Dan Shi3f1b8a52015-04-21 11:11:06 -0700350
351 # Update results folder's file permission. This needs to be done ASAP
352 # before the parsing process tries to access the log.
353 if use_ssp and results:
354 correct_results_folder_permission(results)
355
Simran Basid6b83772014-01-06 16:31:30 -0800356 # TODO (sbasi) - remove the time.sleep when crbug.com/302815 is solved.
357 # This sleep allows the pending output to be logged before the kill
358 # signal is sent.
359 time.sleep(.1)
Dan Shic68fefb2015-04-07 10:10:52 -0700360 if use_ssp:
Dan Shicf4d2032015-03-12 15:04:21 -0700361 logging.debug('Destroy container %s before aborting the autoserv '
362 'process.', container_name)
Dan Shi3f1b8a52015-04-21 11:11:06 -0700363 metadata = {'drone': socket.gethostname(),
364 'job_id': job_or_task_id,
365 'container_name': container_name,
366 'action': 'abort',
367 'success': True}
Dan Shicf4d2032015-03-12 15:04:21 -0700368 try:
369 bucket = lxc.ContainerBucket()
370 container = bucket.get(container_name)
371 if container:
372 container.destroy()
373 else:
Dan Shi3f1b8a52015-04-21 11:11:06 -0700374 metadata['success'] = False
375 metadata['error'] = 'container not found'
Dan Shicf4d2032015-03-12 15:04:21 -0700376 logging.debug('Container %s is not found.', container_name)
377 except:
Dan Shi3f1b8a52015-04-21 11:11:06 -0700378 metadata['success'] = False
379 metadata['error'] = 'Exception: %s' % sys.exc_info()
Dan Shicf4d2032015-03-12 15:04:21 -0700380 # Handle any exception so the autoserv process can be aborted.
381 logging.error('Failed to destroy container %s. Error: %s',
382 container_name, sys.exc_info())
Dan Shi3f1b8a52015-04-21 11:11:06 -0700383 autotest_es.post(use_http=True,
384 type_str=lxc.CONTAINER_RUN_TEST_METADB_TYPE,
385 metadata=metadata)
Dan Shie4a4f9f2015-07-20 09:00:25 -0700386 # Try to correct the result file permission again after the
387 # container is destroyed, as the container might have created some
388 # new files in the result folder.
389 if results:
390 correct_results_folder_permission(results)
Dan Shicf4d2032015-03-12 15:04:21 -0700391
jadmanski0afbb632008-06-06 21:10:57 +0000392 os.killpg(os.getpgrp(), signal.SIGKILL)
mblighfaf0cd42007-11-19 16:00:24 +0000393
jadmanski0afbb632008-06-06 21:10:57 +0000394 # Set signal handler
mblighc2299562009-07-02 19:00:36 +0000395 signal.signal(signal.SIGTERM, handle_sigterm)
mbligha46678d2008-05-01 20:00:01 +0000396
Simran Basid6b83772014-01-06 16:31:30 -0800397 # faulthandler is only needed to debug in the Lab and is not avaliable to
398 # be imported in the chroot as part of VMTest, so Try-Except it.
399 try:
400 import faulthandler
401 faulthandler.register(signal.SIGTERM, all_threads=True, chain=True)
402 logging.debug('faulthandler registered on SIGTERM.')
403 except ImportError:
Christopher Grant4beca022015-06-16 15:14:47 -0400404 sys.exc_clear()
Simran Basid6b83772014-01-06 16:31:30 -0800405
David Rochberg8a60d1e2011-02-01 14:22:07 -0500406 # Ignore SIGTTOU's generated by output from forked children.
407 signal.signal(signal.SIGTTOU, signal.SIG_IGN)
408
Alex Millerf1af17e2013-01-09 22:50:32 -0800409 # If we received a SIGALARM, let's be loud about it.
410 signal.signal(signal.SIGALRM, log_alarm)
411
mbligha5f5e542009-12-30 16:57:49 +0000412 # Server side tests that call shell scripts often depend on $USER being set
413 # but depending on how you launch your autotest scheduler it may not be set.
414 os.environ['USER'] = getpass.getuser()
415
mblighb2bea302008-07-24 20:25:57 +0000416 label = parser.options.label
mbligh374f3412009-05-13 21:29:45 +0000417 group_name = parser.options.group_name
mblighb2bea302008-07-24 20:25:57 +0000418 user = parser.options.user
419 client = parser.options.client
420 server = parser.options.server
jadmanski0afbb632008-06-06 21:10:57 +0000421 install_before = parser.options.install_before
mblighb2bea302008-07-24 20:25:57 +0000422 install_after = parser.options.install_after
423 verify = parser.options.verify
424 repair = parser.options.repair
showard45ae8192008-11-05 19:32:53 +0000425 cleanup = parser.options.cleanup
Alex Millercb79ba72013-05-29 14:43:00 -0700426 provision = parser.options.provision
Dan Shi07e09af2013-04-12 09:31:29 -0700427 reset = parser.options.reset
Alex Miller667b5f22014-02-28 15:33:39 -0800428 job_labels = parser.options.job_labels
mblighb2bea302008-07-24 20:25:57 +0000429 no_tee = parser.options.no_tee
jadmanski0afbb632008-06-06 21:10:57 +0000430 parse_job = parser.options.parse_job
mblighe7d9c602009-07-02 19:02:33 +0000431 execution_tag = parser.options.execution_tag
432 if not execution_tag:
433 execution_tag = parse_job
jadmanski0afbb632008-06-06 21:10:57 +0000434 ssh_user = parser.options.ssh_user
435 ssh_port = parser.options.ssh_port
436 ssh_pass = parser.options.ssh_pass
jadmanskidef0c3c2009-03-25 20:07:10 +0000437 collect_crashinfo = parser.options.collect_crashinfo
mblighe0cbc912010-03-11 18:03:07 +0000438 control_filename = parser.options.control_filename
Scott Zawalski91493c82013-01-25 16:15:20 -0500439 test_retry = parser.options.test_retry
beepscb6f1e22013-06-28 19:14:10 -0700440 verify_job_repo_url = parser.options.verify_job_repo_url
Christopher Wileyf594c5e2013-07-03 18:25:30 -0700441 skip_crash_collection = parser.options.skip_crash_collection
Aviv Keshet18ee3142013-08-12 15:01:51 -0700442 ssh_verbosity = int(parser.options.ssh_verbosity)
Fang Deng6cc20de2013-09-06 15:47:32 -0700443 ssh_options = parser.options.ssh_options
Dan Shib669cbd2013-09-13 11:17:17 -0700444 no_use_packaging = parser.options.no_use_packaging
mbligha46678d2008-05-01 20:00:01 +0000445
mblighb2bea302008-07-24 20:25:57 +0000446 # can't be both a client and a server side test
447 if client and server:
Eric Li861b2d52011-02-04 14:50:35 -0800448 parser.parser.error("Can not specify a test as both server and client!")
mblighb2bea302008-07-24 20:25:57 +0000449
Alex Millercb79ba72013-05-29 14:43:00 -0700450 if provision and client:
451 parser.parser.error("Cannot specify provisioning and client!")
452
453 is_special_task = (verify or repair or cleanup or collect_crashinfo or
Dan Shi07e09af2013-04-12 09:31:29 -0700454 provision or reset)
Alex Millercb79ba72013-05-29 14:43:00 -0700455 if len(parser.args) < 1 and not is_special_task:
Eric Li861b2d52011-02-04 14:50:35 -0800456 parser.parser.error("Missing argument: control file")
mbligha46678d2008-05-01 20:00:01 +0000457
Aviv Keshet18ee3142013-08-12 15:01:51 -0700458 if ssh_verbosity > 0:
459 # ssh_verbosity is an integer between 0 and 3, inclusive
460 ssh_verbosity_flag = '-' + 'v' * ssh_verbosity
Fang Dengd1c2b732013-08-20 12:59:46 -0700461 else:
462 ssh_verbosity_flag = ''
Aviv Keshet18ee3142013-08-12 15:01:51 -0700463
showard45ae8192008-11-05 19:32:53 +0000464 # We have a control file unless it's just a verify/repair/cleanup job
jadmanski0afbb632008-06-06 21:10:57 +0000465 if len(parser.args) > 0:
466 control = parser.args[0]
467 else:
468 control = None
mbligha46678d2008-05-01 20:00:01 +0000469
Dan Shicf4d2032015-03-12 15:04:21 -0700470 machines = _get_machines(parser)
mbligh374f3412009-05-13 21:29:45 +0000471 if group_name and len(machines) < 2:
Dan Shicf4d2032015-03-12 15:04:21 -0700472 parser.parser.error('-G %r may only be supplied with more than one '
473 'machine.' % group_name)
mbligh374f3412009-05-13 21:29:45 +0000474
Christopher Wiley8a91f232013-07-09 11:02:27 -0700475 kwargs = {'group_name': group_name, 'tag': execution_tag,
Dan Shicf4d2032015-03-12 15:04:21 -0700476 'disable_sysinfo': parser.options.disable_sysinfo}
Dan Shi70647ca2015-07-16 22:52:35 -0700477 if parser.options.parent_job_id:
478 kwargs['parent_job_id'] = int(parser.options.parent_job_id)
mblighe0cbc912010-03-11 18:03:07 +0000479 if control_filename:
480 kwargs['control_filename'] = control_filename
jadmanski0afbb632008-06-06 21:10:57 +0000481 job = server_job.server_job(control, parser.args[1:], results, label,
482 user, machines, client, parse_job,
Fang Dengd1c2b732013-08-20 12:59:46 -0700483 ssh_user, ssh_port, ssh_pass,
Aviv Keshetc5947fa2013-09-04 14:06:29 -0700484 ssh_verbosity_flag, ssh_options,
485 test_retry, **kwargs)
Dan Shicf4d2032015-03-12 15:04:21 -0700486
showard75cdfee2009-06-10 17:40:41 +0000487 job.logging.start_logging()
mbligh4608b002010-01-05 18:22:35 +0000488 job.init_parser()
mbligha46678d2008-05-01 20:00:01 +0000489
mbligh161fe6f2008-06-19 16:26:04 +0000490 # perform checks
491 job.precheck()
492
jadmanski0afbb632008-06-06 21:10:57 +0000493 # run the job
494 exit_code = 0
Dan Shic1b8bdd2015-09-14 23:11:24 -0700495 auto_start_servod = _CONFIG.get_config_value(
496 'AUTOSERV', 'auto_start_servod', type=bool, default=False)
jadmanski0afbb632008-06-06 21:10:57 +0000497 try:
mbligh332000a2009-06-08 16:47:28 +0000498 try:
499 if repair:
Dan Shic1b8bdd2015-09-14 23:11:24 -0700500 if auto_start_servod and len(machines) == 1:
501 _start_servod(machines[0])
J. Richard Barnettec2d99cf2015-11-18 12:46:15 -0800502 job.repair(job_labels)
mbligh332000a2009-06-08 16:47:28 +0000503 elif verify:
Alex Miller667b5f22014-02-28 15:33:39 -0800504 job.verify(job_labels)
Alex Millercb79ba72013-05-29 14:43:00 -0700505 elif provision:
Alex Miller667b5f22014-02-28 15:33:39 -0800506 job.provision(job_labels)
Dan Shi07e09af2013-04-12 09:31:29 -0700507 elif reset:
Alex Miller667b5f22014-02-28 15:33:39 -0800508 job.reset(job_labels)
Fang Dengad78aca2014-10-02 18:15:46 -0700509 elif cleanup:
510 job.cleanup(job_labels)
mbligh332000a2009-06-08 16:47:28 +0000511 else:
Dan Shia06f3e22015-09-03 16:15:15 -0700512 if auto_start_servod and len(machines) == 1:
513 _start_servod(machines[0])
Dan Shic68fefb2015-04-07 10:10:52 -0700514 if use_ssp:
Dan Shicf4d2032015-03-12 15:04:21 -0700515 try:
Dan Shi37befda2015-12-07 13:16:56 -0800516 _run_with_ssp(job, container_name, job_or_task_id,
517 results, parser, ssp_url)
Dan Shicf4d2032015-03-12 15:04:21 -0700518 finally:
519 # Update the ownership of files in result folder.
Dan Shi3f1b8a52015-04-21 11:11:06 -0700520 correct_results_folder_permission(results)
Dan Shicf4d2032015-03-12 15:04:21 -0700521 else:
522 job.run(install_before, install_after,
523 verify_job_repo_url=verify_job_repo_url,
524 only_collect_crashinfo=collect_crashinfo,
525 skip_crash_collection=skip_crash_collection,
Dan Shib669cbd2013-09-13 11:17:17 -0700526 job_labels=job_labels,
527 use_packaging=(not no_use_packaging))
mbligh332000a2009-06-08 16:47:28 +0000528 finally:
529 while job.hosts:
530 host = job.hosts.pop()
531 host.close()
jadmanski0afbb632008-06-06 21:10:57 +0000532 except:
jadmanski27b37ea2008-10-29 23:54:31 +0000533 exit_code = 1
jadmanski0afbb632008-06-06 21:10:57 +0000534 traceback.print_exc()
mbligha46678d2008-05-01 20:00:01 +0000535
mblighff7d61f2008-12-22 14:53:35 +0000536 if pid_file_manager:
537 pid_file_manager.num_tests_failed = job.num_tests_failed
538 pid_file_manager.close_file(exit_code)
jadmanskie0dffc32008-12-15 17:30:30 +0000539 job.cleanup_parser()
showard21baa452008-10-21 00:08:39 +0000540
jadmanski27b37ea2008-10-29 23:54:31 +0000541 sys.exit(exit_code)
mbligha46678d2008-05-01 20:00:01 +0000542
543
Fang Deng042c1472014-10-23 13:56:41 -0700544def record_autoserv(options, duration_secs):
545 """Record autoserv end-to-end time in metadata db.
546
547 @param options: parser options.
548 @param duration_secs: How long autoserv has taken, in secs.
549 """
550 # Get machine hostname
551 machines = options.machines.replace(
552 ',', ' ').strip().split() if options.machines else []
553 num_machines = len(machines)
554 if num_machines > 1:
555 # Skip the case where atomic group is used.
556 return
557 elif num_machines == 0:
558 machines.append('hostless')
559
560 # Determine the status that will be reported.
561 s = job_overhead.STATUS
562 task_mapping = {
563 'reset': s.RESETTING, 'verify': s.VERIFYING,
564 'provision': s.PROVISIONING, 'repair': s.REPAIRING,
565 'cleanup': s.CLEANING, 'collect_crashinfo': s.GATHERING}
Dan Shi888cfca2015-07-31 15:49:00 -0700566 match = filter(lambda task: getattr(options, task, False) == True,
567 task_mapping)
Fang Deng042c1472014-10-23 13:56:41 -0700568 status = task_mapping[match[0]] if match else s.RUNNING
569 is_special_task = status not in [s.RUNNING, s.GATHERING]
Dan Shicf4d2032015-03-12 15:04:21 -0700570 job_or_task_id = job_directories.get_job_id_or_task_id(options.results)
Fang Deng042c1472014-10-23 13:56:41 -0700571 job_overhead.record_state_duration(
572 job_or_task_id, machines[0], status, duration_secs,
573 is_special_task=is_special_task)
574
575
mbligha46678d2008-05-01 20:00:01 +0000576def main():
Fang Deng042c1472014-10-23 13:56:41 -0700577 start_time = datetime.datetime.now()
Dan Shia1ecd5c2013-06-06 11:21:31 -0700578 # White list of tests with run time measurement enabled.
Dan Shia06f3e22015-09-03 16:15:15 -0700579 measure_run_time_tests_names = _CONFIG.get_config_value(
580 'AUTOSERV', 'measure_run_time_tests', type=str)
Dan Shia1ecd5c2013-06-06 11:21:31 -0700581 if measure_run_time_tests_names:
582 measure_run_time_tests = [t.strip() for t in
583 measure_run_time_tests_names.split(',')]
584 else:
585 measure_run_time_tests = []
jadmanski0afbb632008-06-06 21:10:57 +0000586 # grab the parser
587 parser = autoserv_parser.autoserv_parser
mbligha5cb4062009-02-17 15:53:39 +0000588 parser.parse_args()
mbligha46678d2008-05-01 20:00:01 +0000589
jadmanski0afbb632008-06-06 21:10:57 +0000590 if len(sys.argv) == 1:
591 parser.parser.print_help()
592 sys.exit(1)
mbligha6f13082008-06-05 23:53:46 +0000593
Dan Shicf4d2032015-03-12 15:04:21 -0700594 # If the job requires to run with server-side package, try to stage server-
595 # side package first. If that fails with error that autotest server package
Dan Shic68fefb2015-04-07 10:10:52 -0700596 # does not exist, fall back to run the job without using server-side
597 # packaging. If option warn_no_ssp is specified, that means autoserv is
598 # running in a drone does not support SSP, thus no need to stage server-side
599 # package.
Dan Shicf4d2032015-03-12 15:04:21 -0700600 ssp_url = None
Dan Shi0b754c52015-04-20 14:20:38 -0700601 ssp_url_warning = False
Dan Shic68fefb2015-04-07 10:10:52 -0700602 if (not parser.options.warn_no_ssp and parser.options.require_ssp):
Dan Shicf4d2032015-03-12 15:04:21 -0700603 ssp_url = _stage_ssp(parser)
Dan Shi0b754c52015-04-20 14:20:38 -0700604 # The build does not have autotest server package. Fall back to not
605 # to use server-side package. Logging is postponed until logging being
606 # set up.
607 ssp_url_warning = not ssp_url
Dan Shicf4d2032015-03-12 15:04:21 -0700608
showard75cdfee2009-06-10 17:40:41 +0000609 if parser.options.no_logging:
610 results = None
611 else:
612 results = parser.options.results
mbligh80e1eba2008-11-19 00:26:18 +0000613 if not results:
614 results = 'results.' + time.strftime('%Y-%m-%d-%H.%M.%S')
615 results = os.path.abspath(results)
showard566d3c02010-01-12 18:57:01 +0000616 resultdir_exists = False
617 for filename in ('control.srv', 'status.log', '.autoserv_execute'):
618 if os.path.exists(os.path.join(results, filename)):
619 resultdir_exists = True
mbligh4608b002010-01-05 18:22:35 +0000620 if not parser.options.use_existing_results and resultdir_exists:
mbligh80e1eba2008-11-19 00:26:18 +0000621 error = "Error: results directory already exists: %s\n" % results
622 sys.stderr.write(error)
623 sys.exit(1)
mbligha788dc42009-03-26 21:10:16 +0000624
625 # Now that we certified that there's no leftover results dir from
626 # previous jobs, lets create the result dir since the logging system
627 # needs to create the log file in there.
628 if not os.path.isdir(results):
629 os.makedirs(results)
showard75cdfee2009-06-10 17:40:41 +0000630
Dan Shic68fefb2015-04-07 10:10:52 -0700631 # Server-side packaging will only be used if it's required and the package
632 # is available. If warn_no_ssp is specified, it means that autoserv is
633 # running in a drone does not have SSP supported and a warning will be logs.
634 # Therefore, it should not run with SSP.
635 use_ssp = (not parser.options.warn_no_ssp and parser.options.require_ssp
636 and ssp_url)
637 if use_ssp:
Dan Shie28de552015-05-06 16:51:58 -0700638 log_dir = os.path.join(results, 'ssp_logs') if results else None
Dan Shicf4d2032015-03-12 15:04:21 -0700639 if log_dir and not os.path.exists(log_dir):
640 os.makedirs(log_dir)
641 else:
642 log_dir = results
Dan Shi3f1b8a52015-04-21 11:11:06 -0700643
showard75cdfee2009-06-10 17:40:41 +0000644 logging_manager.configure_logging(
Dan Shicf4d2032015-03-12 15:04:21 -0700645 server_logging_config.ServerLoggingConfig(),
646 results_dir=log_dir,
showard10d84172009-06-18 23:16:50 +0000647 use_console=not parser.options.no_tee,
648 verbose=parser.options.verbose,
649 no_console_prefix=parser.options.no_console_prefix)
Dan Shicf4d2032015-03-12 15:04:21 -0700650
Dan Shi0b754c52015-04-20 14:20:38 -0700651 if ssp_url_warning:
652 logging.warn(
653 'Autoserv is required to run with server-side packaging. '
654 'However, no server-side package can be found based on '
655 '`--image`, host attribute job_repo_url or host label of '
656 'cros-version. The test will be executed without '
657 'server-side packaging supported.')
658
showard75cdfee2009-06-10 17:40:41 +0000659 if results:
mbligha788dc42009-03-26 21:10:16 +0000660 logging.info("Results placed in %s" % results)
mbligh10717632008-11-19 00:21:57 +0000661
mbligh4608b002010-01-05 18:22:35 +0000662 # wait until now to perform this check, so it get properly logged
Dan Shicf4d2032015-03-12 15:04:21 -0700663 if (parser.options.use_existing_results and not resultdir_exists and
Dan Shiff78f112015-06-12 13:34:02 -0700664 not utils.is_in_container()):
mbligh4608b002010-01-05 18:22:35 +0000665 logging.error("No existing results directory found: %s", results)
666 sys.exit(1)
667
Dan Shicf4d2032015-03-12 15:04:21 -0700668 logging.debug('autoserv is running in drone %s.', socket.gethostname())
Aviv Keshet5c40ec62013-08-20 12:11:12 -0700669 logging.debug('autoserv command was: %s', ' '.join(sys.argv))
mbligh4608b002010-01-05 18:22:35 +0000670
Dan Shicf4d2032015-03-12 15:04:21 -0700671 if parser.options.write_pidfile and results:
mbligh4608b002010-01-05 18:22:35 +0000672 pid_file_manager = pidfile.PidFileManager(parser.options.pidfile_label,
673 results)
jadmanskid5ab8c52008-12-03 16:27:07 +0000674 pid_file_manager.open_file()
mblighff7d61f2008-12-22 14:53:35 +0000675 else:
676 pid_file_manager = None
mbligha46678d2008-05-01 20:00:01 +0000677
jadmanskif22fea82008-11-26 20:57:07 +0000678 autotest.BaseAutotest.set_install_in_tmpdir(
679 parser.options.install_in_tmpdir)
680
Dan Shia1ecd5c2013-06-06 11:21:31 -0700681 timer = None
682 try:
683 # Take the first argument as control file name, get the test name from
684 # the control file. If the test name exists in the list of tests with
685 # run time measurement enabled, start a timer to begin measurement.
686 if (len(parser.args) > 0 and parser.args[0] != '' and
687 parser.options.machines):
Dan Shibbc16132013-07-09 16:23:59 -0700688 try:
689 test_name = control_data.parse_control(parser.args[0],
690 raise_warnings=True).name
691 except control_data.ControlVariableException:
692 logging.debug('Failed to retrieve test name from control file.')
693 test_name = None
Dan Shia1ecd5c2013-06-06 11:21:31 -0700694 if test_name in measure_run_time_tests:
695 machines = parser.options.machines.replace(',', ' '
696 ).strip().split()
Dan Shi8eac5af2014-09-17 00:15:15 -0700697 try:
698 afe = frontend.AFE()
699 board = server_utils.get_board_from_afe(machines[0], afe)
Gabe Black1e1c41b2015-02-04 23:55:15 -0800700 timer = autotest_stats.Timer('autoserv_run_time.%s.%s' %
701 (board, test_name))
Dan Shi8eac5af2014-09-17 00:15:15 -0700702 timer.start()
703 except (urllib2.HTTPError, urllib2.URLError):
704 # Ignore error if RPC failed to get board
705 pass
Dan Shia1ecd5c2013-06-06 11:21:31 -0700706 except control_data.ControlVariableException as e:
707 logging.error(str(e))
jadmanski0afbb632008-06-06 21:10:57 +0000708 exit_code = 0
Prashanth B6285f6a2014-05-08 18:01:27 -0700709 # TODO(beeps): Extend this to cover different failure modes.
710 # Testing exceptions are matched against labels sent to autoserv. Eg,
711 # to allow only the hostless job to run, specify
712 # testing_exceptions: test_suite in the shadow_config. To allow both
713 # the hostless job and dummy_Pass to run, specify
714 # testing_exceptions: test_suite,dummy_Pass. You can figure out
715 # what label autoserv is invoked with by looking through the logs of a test
716 # for the autoserv command's -l option.
Dan Shia06f3e22015-09-03 16:15:15 -0700717 testing_exceptions = _CONFIG.get_config_value(
Prashanth B6285f6a2014-05-08 18:01:27 -0700718 'AUTOSERV', 'testing_exceptions', type=list, default=[])
Dan Shia06f3e22015-09-03 16:15:15 -0700719 test_mode = _CONFIG.get_config_value(
Prashanth B6285f6a2014-05-08 18:01:27 -0700720 'AUTOSERV', 'testing_mode', type=bool, default=False)
Prashanth Balasubramanianf8b83712014-11-06 15:58:21 -0800721 test_mode = (results_mocker and test_mode and not
722 any([ex in parser.options.label
723 for ex in testing_exceptions]))
724 is_task = (parser.options.verify or parser.options.repair or
725 parser.options.provision or parser.options.reset or
726 parser.options.cleanup or parser.options.collect_crashinfo)
jadmanski0afbb632008-06-06 21:10:57 +0000727 try:
728 try:
Prashanth B6285f6a2014-05-08 18:01:27 -0700729 if test_mode:
Prashanth Balasubramanianf8b83712014-11-06 15:58:21 -0800730 # The parser doesn't run on tasks anyway, so we can just return
731 # happy signals without faking results.
732 if not is_task:
733 machine = parser.options.results.split('/')[-1]
734
735 # TODO(beeps): The proper way to do this would be to
736 # refactor job creation so we can invoke job.record
737 # directly. To do that one needs to pipe the test_name
738 # through run_autoserv and bail just before invoking
739 # the server job. See the comment in
740 # puppylab/results_mocker for more context.
741 results_mocker.ResultsMocker(
Prashanth Balasubramanian22dd2262014-11-28 18:19:18 -0800742 test_name if test_name else 'unknown-test',
743 parser.options.results, machine
Prashanth Balasubramanianf8b83712014-11-06 15:58:21 -0800744 ).mock_results()
745 return
Prashanth B6285f6a2014-05-08 18:01:27 -0700746 else:
Dan Shic68fefb2015-04-07 10:10:52 -0700747 run_autoserv(pid_file_manager, results, parser, ssp_url,
748 use_ssp)
Aviv Keshet5c40ec62013-08-20 12:11:12 -0700749 except SystemExit as e:
jadmanski0afbb632008-06-06 21:10:57 +0000750 exit_code = e.code
Aviv Keshet5c40ec62013-08-20 12:11:12 -0700751 if exit_code:
752 logging.exception(e)
753 except Exception as e:
jadmanski0afbb632008-06-06 21:10:57 +0000754 # If we don't know what happened, we'll classify it as
755 # an 'abort' and return 1.
Aviv Keshet5c40ec62013-08-20 12:11:12 -0700756 logging.exception(e)
jadmanski0afbb632008-06-06 21:10:57 +0000757 exit_code = 1
758 finally:
mblighff7d61f2008-12-22 14:53:35 +0000759 if pid_file_manager:
760 pid_file_manager.close_file(exit_code)
Dan Shia1ecd5c2013-06-06 11:21:31 -0700761 if timer:
762 timer.stop()
Fang Deng042c1472014-10-23 13:56:41 -0700763 # Record the autoserv duration time. Must be called
764 # just before the system exits to ensure accuracy.
765 duration_secs = (datetime.datetime.now() - start_time).total_seconds()
766 record_autoserv(parser.options, duration_secs)
jadmanski0afbb632008-06-06 21:10:57 +0000767 sys.exit(exit_code)
mblighfaf0cd42007-11-19 16:00:24 +0000768
mblighbb421852008-03-11 22:36:16 +0000769
mbligha46678d2008-05-01 20:00:01 +0000770if __name__ == '__main__':
jadmanski0afbb632008-06-06 21:10:57 +0000771 main()