Loading...
1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 32 33 34 35 36 37 38 39 40 41 42 43 44 45 46 47 48 49 50 51 52 53 54 55 56 57 58 59 60 61 62 63 64 65 66 67 68 69 70 71 72 73 74 75 76 77 78 79 80 81 82 83 84 85 86 87 88 89 90 91 92 93 94 95 96 97 98 99 100 101 102 103 104 105 106 107 108 109 110 111 112 113 114 115 116 117 118 119 120 121 122 123 124 125 126 127 128 129 130 131 132 133 134 135 136 137 138 139 140 141 142 143 144 145 146 147 148 149 150 151 152 153 154 155 156 157 158 159 160 161 162 163 164 165 166 167 168 169 170 171 172 173 174 175 176 177 178 179 180 181 182 183 184 185 186 187 188 189 190 191 192 193 194 195 196 197 198 199 200 201 202 203 204 205 206 207 208 209 210 211 212 213 214 215 216 217 218 219 220 221 222 223 224 225 226 227 228 229 230 231 232 233 234 235 236 237 238 239 240 241 242 243 244 245 246 247 248 249 250 251 252 253 254 255 256 257 258 259 260 261 262 263 264 265 266 267 268 269 270 271 272 273 274 275 276 277 278 279 280 281 282 283 284 285 286 287 288 289 290 291 292 293 294 295 296 297 298 299 300 301 302 303 304 305 306 307 308 309 310 311 312 313 314 315 316 317 318 319 320 321 322 323 324 325 326 327 328 329 330 331 332 333 334 335 336 337 338 339 340 341 342 343 344 345 | # SPDX-License-Identifier: GPL-2.0 # Copyright (c) 2015-2016, NVIDIA CORPORATION. All rights reserved. """ Logic to spawn a sub-process and interact with its stdio. """ import io import os import re import pty import pytest import signal import select import sys import termios import time import traceback # Character to send (twice) to exit the terminal EXIT_CHAR = 0x1d # FS (Ctrl + ]) class Timeout(Exception): """An exception sub-class that indicates that a timeout occurred.""" class BootFail(Exception): """An exception sub-class that indicates that a boot failure occurred. This is used when a bad pattern is seen when waiting for the boot prompt. It is regarded as fatal, to avoid trying to boot the again and again to no avail. """ class Unexpected(Exception): """An exception sub-class that indicates that unexpected test was seen.""" def handle_exception(ubconfig, console, log, err, name, fatal, output=''): """Handle an exception from the console Exceptions can occur when there is unexpected output or due to the board crashing or hanging. Some exceptions are likely fatal, where retrying will just chew up time to no available. In those cases it is best to cause further tests be skipped. Args: ubconfig (ArbitraryAttributeContainer): ubconfig object log (Logfile): Place to log errors console (ConsoleBase): Console to clean up, if fatal err (Exception): Exception which was thrown name (str): Name of problem, to log fatal (bool): True to abort all tests output (str): Extra output to report on boot failure. This can show the target's console output as it tried to boot """ msg = f'{name}: ' if fatal: msg += 'Marking connection bad - no other tests will run' else: msg += 'Assuming that lab is healthy' print(msg) log.error(msg) log.error(f'Error: {err}') if output: msg += f'; output {output}' if fatal: ubconfig.connection_ok = False console.cleanup_spawn() pytest.exit(msg) class Spawn: """Represents the stdio of a freshly created sub-process. Commands may be sent to the process, and responses waited for. Members: output: accumulated output from expect() """ def __init__(self, args, cwd=None, decode_signal=False): """Spawn (fork/exec) the sub-process. Args: args: array of processs arguments. argv[0] is the command to execute. cwd: the directory to run the process in, or None for no change. decode_signal (bool): True to indicate the exception number when something goes wrong Returns: Nothing. """ self.decode_signal = decode_signal self.waited = False self.exit_code = 0 self.exit_info = '' self.buf = '' self.output = '' self.logfile_read = None self.before = '' self.after = '' self.timeout = None # http://stackoverflow.com/questions/7857352/python-regex-to-match-vt100-escape-sequences self.re_vt100 = re.compile(r'(\x1b\[|\x9b)[^@-_]*[@-_]|\x1b[@-_]', re.I) (self.pid, self.fd) = pty.fork() if self.pid == 0: try: # For some reason, SIGHUP is set to SIG_IGN at this point when # run under "go" (www.go.cd). Perhaps this happens under any # background (non-interactive) system? signal.signal(signal.SIGHUP, signal.SIG_DFL) if cwd: os.chdir(cwd) os.execvp(args[0], args) except: print('CHILD EXECEPTION:') traceback.print_exc() finally: os._exit(255) old = None try: isatty = False try: isatty = os.isatty(sys.stdout.fileno()) # with --capture=tee-sys we cannot call fileno() except io.UnsupportedOperation as exc: pass if isatty: new = termios.tcgetattr(self.fd) old = new new[3] = new[3] & ~(termios.ICANON | termios.ISIG) new[3] = new[3] & ~termios.ECHO new[6][termios.VMIN] = 0 new[6][termios.VTIME] = 0 termios.tcsetattr(self.fd, termios.TCSANOW, new) self.poll = select.poll() self.poll.register(self.fd, select.POLLIN | select.POLLPRI | select.POLLERR | select.POLLHUP | select.POLLNVAL) except: if old: termios.tcsetattr(self.fd, termios.TCSANOW, old) self.close() raise def kill(self, sig): """Send unix signal "sig" to the child process. Args: sig: The signal number to send. Returns: Nothing. """ os.kill(self.pid, sig) def checkalive(self): """Determine whether the child process is still running. Returns: tuple: True if process is alive, else False 0 if process is alive, else exit code of process string describing what happened ('' or 'status/signal n') """ if self.waited: return False, self.exit_code, self.exit_info w = os.waitpid(self.pid, os.WNOHANG) if w[0] == 0: return True, 0, 'running' status = w[1] if os.WIFEXITED(status): self.exit_code = os.WEXITSTATUS(status) self.exit_info = 'status %d' % self.exit_code elif os.WIFSIGNALED(status): signum = os.WTERMSIG(status) self.exit_code = -signum self.exit_info = 'signal %d (%s)' % (signum, signal.Signals(signum).name) self.waited = True return False, self.exit_code, self.exit_info def isalive(self): """Determine whether the child process is still running. Args: None. Returns: Boolean indicating whether process is alive. """ return self.checkalive()[0] def send(self, data): """Send data to the sub-process's stdin. Args: data: The data to send to the process. Returns: Nothing. """ os.write(self.fd, data.encode(errors='replace')) def receive(self, num_bytes): """Receive data from the sub-process's stdin. Args: num_bytes (int): Maximum number of bytes to read Returns: str: The data received Raises: ValueError if U-Boot died """ try: c = os.read(self.fd, num_bytes).decode(errors='replace') except OSError as err: # With sandbox, try to detect when U-Boot exits when it # shouldn't and explain why. This is much more friendly than # just dying with an I/O error if self.decode_signal and err.errno == 5: # I/O error alive, _, info = self.checkalive() if alive: raise err raise ValueError('U-Boot exited with %s' % info) raise return c def expect(self, patterns): """Wait for the sub-process to emit specific data. This function waits for the process to emit one pattern from the supplied list of patterns, or for a timeout to occur. Args: patterns: A list of strings or regex objects that we expect to see in the sub-process' stdout. Returns: The index within the patterns array of the pattern the process emitted. Notable exceptions: Timeout, if the process did not emit any of the patterns within the expected time. """ for pi in range(len(patterns)): if type(patterns[pi]) == type(''): patterns[pi] = re.compile(patterns[pi]) tstart_s = time.time() try: while True: earliest_m = None earliest_pi = None for pi in range(len(patterns)): pattern = patterns[pi] m = pattern.search(self.buf) if not m: continue if earliest_m and m.start() >= earliest_m.start(): continue earliest_m = m earliest_pi = pi if earliest_m: pos = earliest_m.start() posafter = earliest_m.end() self.before = self.buf[:pos] self.after = self.buf[pos:posafter] self.output += self.buf[:posafter] self.buf = self.buf[posafter:] return earliest_pi tnow_s = time.time() if self.timeout: tdelta_ms = (tnow_s - tstart_s) * 1000 poll_maxwait = self.timeout - tdelta_ms if tdelta_ms > self.timeout: raise Timeout() else: poll_maxwait = None events = self.poll.poll(poll_maxwait) if not events: raise Timeout() c = self.receive(1024) if self.logfile_read: self.logfile_read.write(c) self.buf += c # count=0 is supposed to be the default, which indicates # unlimited substitutions, but in practice the version of # Python in Ubuntu 14.04 appears to default to count=2! self.buf = self.re_vt100.sub('', self.buf, count=1000000) finally: if self.logfile_read: self.logfile_read.flush() def close(self): """Close the stdio connection to the sub-process. This also waits a reasonable time for the sub-process to stop running. Args: None. Returns: str: Type of closure completed """ # For Labgrid-sjg, ask it is exit gracefully, so it can transition the # board to the final state (like 'off') before exiting. if os.environ.get('USE_LABGRID_SJG'): self.send(chr(EXIT_CHAR) * 2) # Wait about 10 seconds for Labgrid to close and power off the board for _ in range(100): if not self.isalive(): return 'normal' time.sleep(0.1) # That didn't work, so try closing the PTY os.close(self.fd) for _ in range(100): if not self.isalive(): return 'break' time.sleep(0.1) return 'timeout' def get_expect_output(self): """Return the output read by expect() Returns: The output processed by expect(), as a string. """ return self.output |