lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 1 | import md5, thread, subprocess, time, string, random, socket, os, signal, pty |
| 2 | import select, re, logging |
lmr | 3f0b0cc | 2009-06-10 02:25:23 +0000 | [diff] [blame] | 3 | from autotest_lib.client.bin import utils |
| 4 | from autotest_lib.client.common_lib import error |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 5 | |
| 6 | """ |
| 7 | KVM test utility functions. |
| 8 | |
| 9 | @copyright: 2008-2009 Red Hat Inc. |
| 10 | """ |
| 11 | |
| 12 | |
| 13 | def get_sub_dict(dict, name): |
| 14 | """ |
| 15 | Return a "sub-dict" corresponding to a specific object. |
| 16 | |
| 17 | Operate on a copy of dict: for each key that ends with the suffix |
| 18 | "_" + name, strip the suffix from the key, and set the value of |
| 19 | the stripped key to that of the key. Return the resulting dict. |
| 20 | |
| 21 | @param name: Suffix of the key we want to set the value. |
| 22 | """ |
| 23 | suffix = "_" + name |
| 24 | new_dict = dict.copy() |
| 25 | for key in dict.keys(): |
| 26 | if key.endswith(suffix): |
| 27 | new_key = key.split(suffix)[0] |
| 28 | new_dict[new_key] = dict[key] |
| 29 | return new_dict |
| 30 | |
| 31 | |
| 32 | def get_sub_dict_names(dict, keyword): |
| 33 | """ |
| 34 | Return a list of "sub-dict" names that may be extracted with get_sub_dict. |
| 35 | |
| 36 | This function may be modified to change the behavior of all functions that |
| 37 | deal with multiple objects defined in dicts (e.g. VMs, images, NICs). |
| 38 | |
| 39 | @param keyword: A key in dict (e.g. "vms", "images", "nics"). |
| 40 | """ |
| 41 | names = dict.get(keyword) |
| 42 | if names: |
| 43 | return names.split() |
| 44 | else: |
| 45 | return [] |
| 46 | |
| 47 | |
| 48 | # Functions for working with the environment (a dict-like object) |
| 49 | |
| 50 | def is_vm(obj): |
| 51 | """ |
| 52 | Tests whether a given object is a VM object. |
| 53 | |
| 54 | @param obj: Python object (pretty much everything on python). |
| 55 | """ |
| 56 | return obj.__class__.__name__ == "VM" |
| 57 | |
| 58 | |
| 59 | def env_get_all_vms(env): |
| 60 | """ |
| 61 | Return a list of all VM objects on a given environment. |
| 62 | |
| 63 | @param env: Dictionary with environment items. |
| 64 | """ |
| 65 | vms = [] |
| 66 | for obj in env.values(): |
| 67 | if is_vm(obj): |
| 68 | vms.append(obj) |
| 69 | return vms |
| 70 | |
| 71 | |
| 72 | def env_get_vm(env, name): |
| 73 | """ |
| 74 | Return a VM object by its name. |
| 75 | |
| 76 | @param name: VM name. |
| 77 | """ |
| 78 | return env.get("vm__%s" % name) |
| 79 | |
| 80 | |
| 81 | def env_register_vm(env, name, vm): |
| 82 | """ |
| 83 | Register a given VM in a given env. |
| 84 | |
| 85 | @param env: Environment where we will register the VM. |
| 86 | @param name: VM name. |
| 87 | @param vm: VM object. |
| 88 | """ |
| 89 | env["vm__%s" % name] = vm |
| 90 | |
| 91 | |
| 92 | def env_unregister_vm(env, name): |
| 93 | """ |
| 94 | Remove a given VM from a given env. |
| 95 | |
| 96 | @param env: Environment where we will un-register the VM. |
| 97 | @param name: VM name. |
| 98 | """ |
| 99 | del env["vm__%s" % name] |
| 100 | |
| 101 | |
| 102 | # Utility functions for dealing with external processes |
| 103 | |
| 104 | def pid_exists(pid): |
| 105 | """ |
| 106 | Return True if a given PID exists. |
| 107 | |
| 108 | @param pid: Process ID number. |
| 109 | """ |
| 110 | try: |
| 111 | os.kill(pid, 0) |
| 112 | return True |
| 113 | except: |
| 114 | return False |
| 115 | |
| 116 | |
| 117 | def safe_kill(pid, signal): |
| 118 | """ |
| 119 | Attempt to send a signal to a given process that may or may not exist. |
| 120 | |
| 121 | @param signal: Signal number. |
| 122 | """ |
| 123 | try: |
| 124 | os.kill(pid, signal) |
| 125 | return True |
| 126 | except: |
| 127 | return False |
| 128 | |
| 129 | |
lmr | 3f0b0cc | 2009-06-10 02:25:23 +0000 | [diff] [blame] | 130 | def get_latest_kvm_release_tag(release_dir): |
| 131 | """ |
| 132 | Fetches the latest release tag for KVM. |
| 133 | |
| 134 | @param release_dir: KVM source forge download location. |
| 135 | """ |
| 136 | try: |
| 137 | page_url = os.path.join(release_dir, "showfiles.php") |
| 138 | local_web_page = utils.unmap_url("/", page_url, "/tmp") |
| 139 | f = open(local_web_page, "r") |
| 140 | data = f.read() |
| 141 | f.close() |
| 142 | rx = re.compile("package_id=(\d+).*\>kvm\<", re.IGNORECASE) |
| 143 | matches = rx.findall(data) |
| 144 | package_id = matches[0] |
| 145 | #package_id = 209008 |
| 146 | rx = re.compile("package_id=%s.*release_id=\d+\">(\d+)" % package_id, |
| 147 | re.IGNORECASE) |
| 148 | matches = rx.findall(data) |
| 149 | return matches[0] # the first match contains the latest release tag |
| 150 | except Exception, e: |
| 151 | message = "Could not fetch latest KVM release tag: %s" % str(e) |
| 152 | logging.error(message) |
| 153 | raise error.TestError(message) |
| 154 | |
| 155 | |
| 156 | def get_git_branch(repository, branch, srcdir, commit=None, lbranch=None): |
| 157 | """ |
| 158 | Retrieves a given git code repository. |
| 159 | |
| 160 | @param repository: Git repository URL |
| 161 | """ |
| 162 | logging.info("Fetching git [REP '%s' BRANCH '%s' TAG '%s'] -> %s", |
| 163 | repository, branch, commit, srcdir) |
| 164 | if not os.path.exists(srcdir): |
| 165 | os.makedirs(srcdir) |
| 166 | os.chdir(srcdir) |
| 167 | |
| 168 | if os.path.exists(".git"): |
| 169 | utils.system("git reset --hard") |
| 170 | else: |
| 171 | utils.system("git init") |
| 172 | |
| 173 | if not lbranch: |
| 174 | lbranch = branch |
| 175 | |
| 176 | utils.system("git fetch -q -f -u -t %s %s:%s" % |
| 177 | (repository, branch, lbranch)) |
| 178 | utils.system("git checkout %s" % lbranch) |
| 179 | if commit: |
| 180 | utils.system("git checkout %s" % commit) |
| 181 | |
| 182 | h = utils.system_output('git log --pretty=format:"%H" -1') |
| 183 | desc = utils.system_output("git describe") |
| 184 | logging.info("Commit hash for %s is %s (%s)" % (repository, h.strip(), |
| 185 | desc)) |
| 186 | return srcdir |
| 187 | |
| 188 | |
| 189 | def unload_module(module_name): |
| 190 | """ |
| 191 | Removes a module. Handles dependencies. If even then it's not possible |
| 192 | to remove one of the modules, it will trhow an error.CmdError exception. |
| 193 | |
| 194 | @param module_name: Name of the module we want to remove. |
| 195 | """ |
| 196 | l_raw = utils.system_output("/sbin/lsmod").splitlines() |
| 197 | lsmod = [x for x in l_raw if x.split()[0] == module_name] |
| 198 | if len(lsmod) > 0: |
| 199 | line_parts = lsmod[0].split() |
| 200 | if len(line_parts) == 4: |
| 201 | submodules = line_parts[3].split(",") |
| 202 | for submodule in submodules: |
| 203 | unload_module(submodule) |
| 204 | utils.system("/sbin/modprobe -r %s" % module_name) |
| 205 | logging.info("Module %s unloaded" % module_name) |
| 206 | else: |
| 207 | logging.info("Module %s is already unloaded" % module_name) |
| 208 | |
| 209 | |
| 210 | def check_kvm_source_dir(source_dir): |
| 211 | """ |
| 212 | Inspects the kvm source directory and verifies its disposition. In some |
| 213 | occasions build may be dependant on the source directory disposition. |
| 214 | The reason why the return codes are numbers is that we might have more |
| 215 | changes on the source directory layout, so it's not scalable to just use |
| 216 | strings like 'old_repo', 'new_repo' and such. |
| 217 | |
| 218 | @param source_dir: Source code path that will be inspected. |
| 219 | """ |
| 220 | os.chdir(source_dir) |
| 221 | has_qemu_dir = os.path.isdir('qemu') |
| 222 | has_kvm_dir = os.path.isdir('kvm') |
| 223 | if has_qemu_dir and not has_kvm_dir: |
| 224 | logging.debug("qemu directory detected, source dir layout 1") |
| 225 | return 1 |
| 226 | if has_kvm_dir and not has_qemu_dir: |
| 227 | logging.debug("kvm directory detected, source dir layout 2") |
| 228 | return 2 |
| 229 | else: |
| 230 | raise error.TestError("Unknown source dir layout, cannot proceed.") |
| 231 | |
| 232 | |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 233 | # The following are a class and functions used for SSH, SCP and Telnet |
| 234 | # communication with guests. |
| 235 | |
| 236 | class kvm_spawn: |
| 237 | """ |
| 238 | This class is used for spawning and controlling a child process. |
| 239 | """ |
| 240 | |
| 241 | def __init__(self, command, linesep="\n"): |
| 242 | """ |
| 243 | Initialize the class and run command as a child process. |
| 244 | |
| 245 | @param command: Command that will be run. |
| 246 | @param linesep: Line separator for the given platform. |
| 247 | """ |
| 248 | self.exitstatus = None |
| 249 | self.linesep = linesep |
| 250 | (pid, fd) = pty.fork() |
| 251 | if pid == 0: |
| 252 | os.execv("/bin/sh", ["/bin/sh", "-c", command]) |
| 253 | else: |
| 254 | self.pid = pid |
| 255 | self.fd = fd |
| 256 | |
| 257 | |
| 258 | def set_linesep(self, linesep): |
| 259 | """ |
| 260 | Sets the line separator string (usually "\\n"). |
| 261 | |
| 262 | @param linesep: Line separator character. |
| 263 | """ |
| 264 | self.linesep = linesep |
| 265 | |
| 266 | |
| 267 | def is_responsive(self, timeout=5.0): |
| 268 | """ |
| 269 | Return True if the session is responsive. |
| 270 | |
| 271 | Send a newline to the child process (e.g. SSH or Telnet) and read some |
| 272 | output using read_nonblocking. |
| 273 | If all is OK, some output should be available (e.g. the shell prompt). |
| 274 | In that case return True. Otherwise return False. |
| 275 | |
| 276 | @param timeout: Timeout that will happen before we consider the |
| 277 | process unresponsive |
| 278 | """ |
| 279 | self.read_nonblocking(timeout=0.1) |
| 280 | self.sendline() |
| 281 | output = self.read_nonblocking(timeout=timeout) |
| 282 | if output.strip(): |
| 283 | return True |
| 284 | return False |
| 285 | |
| 286 | |
| 287 | def poll(self): |
| 288 | """ |
| 289 | If the process exited, return its exit status. Otherwise return None. |
| 290 | The exit status is stored for use in subsequent calls. |
| 291 | """ |
| 292 | if self.exitstatus != None: |
| 293 | return self.exitstatus |
| 294 | pid, status = os.waitpid(self.pid, os.WNOHANG) |
| 295 | if pid: |
| 296 | self.exitstatus = os.WEXITSTATUS(status) |
| 297 | return self.exitstatus |
| 298 | else: |
| 299 | return None |
| 300 | |
| 301 | |
| 302 | def close(self): |
| 303 | """ |
| 304 | Close the session (close the process filedescriptors and kills the |
| 305 | process ID), and return the exit status. |
| 306 | """ |
| 307 | try: |
| 308 | os.close(self.fd) |
| 309 | os.kill(self.pid, signal.SIGTERM) |
| 310 | except OSError: |
| 311 | pass |
| 312 | return self.poll() |
| 313 | |
| 314 | |
| 315 | def sendline(self, str=""): |
| 316 | """ |
| 317 | Sends a string followed by a line separator to the child process. |
| 318 | |
| 319 | @param str: String that will be sent to the child process. |
| 320 | """ |
| 321 | try: |
| 322 | os.write(self.fd, str + self.linesep) |
| 323 | except OSError: |
| 324 | pass |
| 325 | |
| 326 | |
| 327 | def read_nonblocking(self, timeout=1.0): |
| 328 | """ |
| 329 | Read from child until there is nothing to read for timeout seconds. |
| 330 | |
| 331 | @param timeout: Time (seconds) of wait before we give up reading from |
| 332 | the child process. |
| 333 | """ |
| 334 | data = "" |
| 335 | while True: |
| 336 | r, w, x = select.select([self.fd], [], [], timeout) |
| 337 | if self.fd in r: |
| 338 | try: |
| 339 | data += os.read(self.fd, 1024) |
| 340 | except OSError: |
| 341 | return data |
| 342 | else: |
| 343 | return data |
| 344 | |
| 345 | |
| 346 | def match_patterns(self, str, patterns): |
| 347 | """ |
| 348 | Match str against a list of patterns. |
| 349 | |
| 350 | Return the index of the first pattern that matches a substring of str. |
| 351 | None and empty strings in patterns are ignored. |
| 352 | If no match is found, return None. |
| 353 | |
| 354 | @param patterns: List of strings (regular expression patterns). |
| 355 | """ |
| 356 | for i in range(len(patterns)): |
| 357 | if not patterns[i]: |
| 358 | continue |
| 359 | exp = re.compile(patterns[i]) |
| 360 | if exp.search(str): |
| 361 | return i |
| 362 | |
| 363 | |
| 364 | def read_until_output_matches(self, patterns, filter=lambda(x):x, |
| 365 | timeout=30.0, internal_timeout=1.0, |
| 366 | print_func=None): |
| 367 | """ |
| 368 | Read using read_nonblocking until a match is found using match_patterns, |
| 369 | or until timeout expires. Before attempting to search for a match, the |
| 370 | data is filtered using the filter function provided. |
| 371 | |
| 372 | @brief: Read from child using read_nonblocking until a pattern |
| 373 | matches. |
| 374 | @param patterns: List of strings (regular expression patterns) |
| 375 | @param filter: Function to apply to the data read from the child before |
| 376 | attempting to match it against the patterns (should take and |
| 377 | return a string) |
| 378 | @param timeout: The duration (in seconds) to wait until a match is |
| 379 | found |
| 380 | @param internal_timeout: The timeout to pass to read_nonblocking |
| 381 | @param print_func: A function to be used to print the data being read |
| 382 | (should take a string parameter) |
| 383 | @return: Tuple containing the match index (or None if no match was |
| 384 | found) and the data read so far. |
| 385 | """ |
| 386 | match = None |
| 387 | data = "" |
| 388 | |
| 389 | end_time = time.time() + timeout |
| 390 | while time.time() < end_time: |
| 391 | # Read data from child |
| 392 | newdata = self.read_nonblocking(internal_timeout) |
| 393 | # Print it if necessary |
| 394 | if print_func and newdata: |
| 395 | map(print_func, newdata.splitlines()) |
| 396 | data += newdata |
| 397 | |
| 398 | done = False |
| 399 | # Look for patterns |
| 400 | match = self.match_patterns(filter(data), patterns) |
| 401 | if match != None: |
| 402 | done = True |
| 403 | # Check if child has died |
| 404 | if self.poll() != None: |
lmr | 3f0b0cc | 2009-06-10 02:25:23 +0000 | [diff] [blame] | 405 | logging.debug("Process terminated with status %d", self.poll()) |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 406 | done = True |
| 407 | # Are we done? |
| 408 | if done: break |
| 409 | |
| 410 | # Print some debugging info |
| 411 | if match == None and self.poll() != 0: |
lmr | 3f0b0cc | 2009-06-10 02:25:23 +0000 | [diff] [blame] | 412 | logging.debug("Timeout elapsed or process terminated. Output: %s", |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 413 | format_str_for_message(data.strip())) |
| 414 | |
| 415 | return (match, data) |
| 416 | |
| 417 | |
| 418 | def get_last_word(self, str): |
| 419 | """ |
| 420 | Return the last word in str. |
| 421 | |
| 422 | @param str: String that will be analyzed. |
| 423 | """ |
| 424 | if str: |
| 425 | return str.split()[-1] |
| 426 | else: |
| 427 | return "" |
| 428 | |
| 429 | |
| 430 | def get_last_line(self, str): |
| 431 | """ |
| 432 | Return the last non-empty line in str. |
| 433 | |
| 434 | @param str: String that will be analyzed. |
| 435 | """ |
| 436 | last_line = "" |
| 437 | for line in str.splitlines(): |
| 438 | if line != "": |
| 439 | last_line = line |
| 440 | return last_line |
| 441 | |
| 442 | |
| 443 | def read_until_last_word_matches(self, patterns, timeout=30.0, |
| 444 | internal_timeout=1.0, print_func=None): |
| 445 | """ |
| 446 | Read using read_nonblocking until the last word of the output matches |
| 447 | one of the patterns (using match_patterns), or until timeout expires. |
| 448 | |
| 449 | @param patterns: A list of strings (regular expression patterns) |
| 450 | @param timeout: The duration (in seconds) to wait until a match is |
| 451 | found |
| 452 | @param internal_timeout: The timeout to pass to read_nonblocking |
| 453 | @param print_func: A function to be used to print the data being read |
| 454 | (should take a string parameter) |
| 455 | @return: A tuple containing the match index (or None if no match was |
| 456 | found) and the data read so far. |
| 457 | """ |
| 458 | return self.read_until_output_matches(patterns, self.get_last_word, |
| 459 | timeout, internal_timeout, |
| 460 | print_func) |
| 461 | |
| 462 | |
| 463 | def read_until_last_line_matches(self, patterns, timeout=30.0, |
| 464 | internal_timeout=1.0, print_func=None): |
| 465 | """ |
| 466 | Read using read_nonblocking until the last non-empty line of the output |
| 467 | matches one of the patterns (using match_patterns), or until timeout |
| 468 | expires. Return a tuple containing the match index (or None if no match |
| 469 | was found) and the data read so far. |
| 470 | |
| 471 | @brief: Read using read_nonblocking until the last non-empty line |
| 472 | matches a pattern. |
| 473 | |
| 474 | @param patterns: A list of strings (regular expression patterns) |
| 475 | @param timeout: The duration (in seconds) to wait until a match is |
| 476 | found |
| 477 | @param internal_timeout: The timeout to pass to read_nonblocking |
| 478 | @param print_func: A function to be used to print the data being read |
| 479 | (should take a string parameter) |
| 480 | """ |
| 481 | return self.read_until_output_matches(patterns, self.get_last_line, |
| 482 | timeout, internal_timeout, |
| 483 | print_func) |
| 484 | |
| 485 | |
| 486 | def set_prompt(self, prompt): |
| 487 | """ |
| 488 | Set the prompt attribute for later use by read_up_to_prompt. |
| 489 | |
| 490 | @param: String that describes the prompt contents. |
| 491 | """ |
| 492 | self.prompt = prompt |
| 493 | |
| 494 | |
| 495 | def read_up_to_prompt(self, timeout=30.0, internal_timeout=1.0, |
| 496 | print_func=None): |
| 497 | """ |
| 498 | Read using read_nonblocking until the last non-empty line of the output |
| 499 | matches the prompt regular expression set by set_prompt, or until |
| 500 | timeout expires. |
| 501 | |
| 502 | @brief: Read using read_nonblocking until the last non-empty line |
| 503 | matches the prompt. |
| 504 | |
| 505 | @param timeout: The duration (in seconds) to wait until a match is |
| 506 | found |
| 507 | @param internal_timeout: The timeout to pass to read_nonblocking |
| 508 | @param print_func: A function to be used to print the data being |
| 509 | read (should take a string parameter) |
| 510 | |
| 511 | @return: A tuple containing True/False indicating whether the prompt |
| 512 | was found, and the data read so far. |
| 513 | """ |
| 514 | (match, output) = self.read_until_last_line_matches([self.prompt], |
| 515 | timeout, |
| 516 | internal_timeout, |
| 517 | print_func) |
| 518 | if match == None: |
| 519 | return (False, output) |
| 520 | else: |
| 521 | return (True, output) |
| 522 | |
| 523 | |
| 524 | def set_status_test_command(self, status_test_command): |
| 525 | """ |
| 526 | Set the command to be sent in order to get the last exit status. |
| 527 | |
| 528 | @param status_test_command: Command that will be sent to get the last |
| 529 | exit status. |
| 530 | """ |
| 531 | self.status_test_command = status_test_command |
| 532 | |
| 533 | |
| 534 | def get_command_status_output(self, command, timeout=30.0, |
| 535 | internal_timeout=1.0, print_func=None): |
| 536 | """ |
| 537 | Send a command and return its exit status and output. |
| 538 | |
| 539 | @param command: Command to send |
| 540 | @param timeout: The duration (in seconds) to wait until a match is |
| 541 | found |
| 542 | @param internal_timeout: The timeout to pass to read_nonblocking |
| 543 | @param print_func: A function to be used to print the data being read |
| 544 | (should take a string parameter) |
| 545 | |
| 546 | @return: A tuple (status, output) where status is the exit status or |
| 547 | None if no exit status is available (e.g. timeout elapsed), and |
| 548 | output is the output of command. |
| 549 | """ |
| 550 | # Print some debugging info |
| 551 | logging.debug("Sending command: %s" % command) |
| 552 | |
| 553 | # Read everything that's waiting to be read |
| 554 | self.read_nonblocking(0.1) |
| 555 | |
| 556 | # Send the command and get its output |
| 557 | self.sendline(command) |
| 558 | (match, output) = self.read_up_to_prompt(timeout, internal_timeout, |
| 559 | print_func) |
| 560 | if not match: |
| 561 | return (None, "\n".join(output.splitlines()[1:])) |
| 562 | output = "\n".join(output.splitlines()[1:-1]) |
| 563 | |
| 564 | # Send the 'echo ...' command to get the last exit status |
| 565 | self.sendline(self.status_test_command) |
| 566 | (match, status) = self.read_up_to_prompt(10.0, internal_timeout) |
| 567 | if not match: |
| 568 | return (None, output) |
| 569 | status = int("\n".join(status.splitlines()[1:-1]).strip()) |
| 570 | |
| 571 | # Print some debugging info |
| 572 | if status != 0: |
lmr | a10d17c | 2009-06-10 19:58:09 +0000 | [diff] [blame] | 573 | logging.debug("Command failed; status: %d, output:%s", status, |
| 574 | format_str_for_message(output.strip())) |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 575 | |
| 576 | return (status, output) |
| 577 | |
| 578 | |
| 579 | def get_command_status(self, command, timeout=30.0, internal_timeout=1.0, |
| 580 | print_func=None): |
| 581 | """ |
| 582 | Send a command and return its exit status. |
| 583 | |
| 584 | @param command: Command to send |
| 585 | @param timeout: The duration (in seconds) to wait until a match is |
| 586 | found |
| 587 | @param internal_timeout: The timeout to pass to read_nonblocking |
| 588 | @param print_func: A function to be used to print the data being read |
| 589 | (should take a string parameter) |
| 590 | |
| 591 | @return: Exit status or None if no exit status is available (e.g. |
| 592 | timeout elapsed). |
| 593 | """ |
| 594 | (status, output) = self.get_command_status_output(command, timeout, |
| 595 | internal_timeout, |
| 596 | print_func) |
| 597 | return status |
| 598 | |
| 599 | |
| 600 | def get_command_output(self, command, timeout=30.0, internal_timeout=1.0, |
| 601 | print_func=None): |
| 602 | """ |
| 603 | Send a command and return its output. |
| 604 | |
| 605 | @param command: Command to send |
| 606 | @param timeout: The duration (in seconds) to wait until a match is |
| 607 | found |
| 608 | @param internal_timeout: The timeout to pass to read_nonblocking |
| 609 | @param print_func: A function to be used to print the data being read |
| 610 | (should take a string parameter) |
| 611 | """ |
| 612 | (status, output) = self.get_command_status_output(command, timeout, |
| 613 | internal_timeout, |
| 614 | print_func) |
| 615 | return output |
| 616 | |
| 617 | |
| 618 | def remote_login(command, password, prompt, linesep="\n", timeout=10): |
| 619 | """ |
| 620 | Log into a remote host (guest) using SSH or Telnet. Run the given command |
| 621 | using kvm_spawn and provide answers to the questions asked. If timeout |
| 622 | expires while waiting for output from the child (e.g. a password prompt |
| 623 | or a shell prompt) -- fail. |
| 624 | |
| 625 | @brief: Log into a remote host (guest) using SSH or Telnet. |
| 626 | |
| 627 | @param command: The command to execute (e.g. "ssh root@localhost") |
| 628 | @param password: The password to send in reply to a password prompt |
| 629 | @param prompt: The shell prompt that indicates a successful login |
| 630 | @param linesep: The line separator to send instead of "\\n" |
| 631 | (sometimes "\\r\\n" is required) |
| 632 | @param timeout: The maximal time duration (in seconds) to wait for each |
| 633 | step of the login procedure (i.e. the "Are you sure" prompt, the |
| 634 | password prompt, the shell prompt, etc) |
| 635 | |
| 636 | @return Return the kvm_spawn object on success and None on failure. |
| 637 | """ |
| 638 | sub = kvm_spawn(command, linesep) |
| 639 | sub.set_prompt(prompt) |
| 640 | |
| 641 | password_prompt_count = 0 |
| 642 | |
| 643 | logging.debug("Trying to login...") |
| 644 | |
| 645 | while True: |
| 646 | (match, text) = sub.read_until_last_line_matches( |
lmr | 3ca79fe | 2009-06-10 19:24:26 +0000 | [diff] [blame] | 647 | [r"[Aa]re you sure", r"[Pp]assword:\s*$", r"^\s*[Ll]ogin:\s*$", |
| 648 | r"[Cc]onnection.*closed", r"[Cc]onnection.*refused", prompt], |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 649 | timeout=timeout, internal_timeout=0.5) |
| 650 | if match == 0: # "Are you sure you want to continue connecting" |
| 651 | logging.debug("Got 'Are you sure...'; sending 'yes'") |
| 652 | sub.sendline("yes") |
| 653 | continue |
| 654 | elif match == 1: # "password:" |
| 655 | if password_prompt_count == 0: |
| 656 | logging.debug("Got password prompt; sending '%s'" % password) |
| 657 | sub.sendline(password) |
| 658 | password_prompt_count += 1 |
| 659 | continue |
| 660 | else: |
| 661 | logging.debug("Got password prompt again") |
| 662 | sub.close() |
| 663 | return None |
| 664 | elif match == 2: # "login:" |
| 665 | logging.debug("Got unexpected login prompt") |
| 666 | sub.close() |
| 667 | return None |
| 668 | elif match == 3: # "Connection closed" |
| 669 | logging.debug("Got 'Connection closed'") |
| 670 | sub.close() |
| 671 | return None |
lmr | 3ca79fe | 2009-06-10 19:24:26 +0000 | [diff] [blame] | 672 | elif match == 4: # "Connection refused" |
lmr | 0d2ed1f | 2009-07-01 03:23:18 +0000 | [diff] [blame^] | 673 | logging.debug("Got 'Connection refused'") |
lmr | 3ca79fe | 2009-06-10 19:24:26 +0000 | [diff] [blame] | 674 | sub.close() |
| 675 | return None |
| 676 | elif match == 5: # prompt |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 677 | logging.debug("Got shell prompt -- logged in") |
| 678 | return sub |
| 679 | else: # match == None |
lmr | 3ca79fe | 2009-06-10 19:24:26 +0000 | [diff] [blame] | 680 | logging.debug("Timeout elapsed or process terminated") |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 681 | sub.close() |
| 682 | return None |
| 683 | |
| 684 | |
| 685 | def remote_scp(command, password, timeout=300, login_timeout=10): |
| 686 | """ |
| 687 | Run the given command using kvm_spawn and provide answers to the questions |
| 688 | asked. If timeout expires while waiting for the transfer to complete , |
| 689 | fail. If login_timeout expires while waiting for output from the child |
| 690 | (e.g. a password prompt), fail. |
| 691 | |
| 692 | @brief: Transfer files using SCP, given a command line. |
| 693 | |
| 694 | @param command: The command to execute |
| 695 | (e.g. "scp -r foobar root@localhost:/tmp/"). |
| 696 | @param password: The password to send in reply to a password prompt. |
| 697 | @param timeout: The time duration (in seconds) to wait for the transfer |
| 698 | to complete. |
| 699 | @param login_timeout: The maximal time duration (in seconds) to wait for |
| 700 | each step of the login procedure (i.e. the "Are you sure" prompt or the |
| 701 | password prompt) |
| 702 | |
| 703 | @return: True if the transfer succeeds and False on failure. |
| 704 | """ |
| 705 | sub = kvm_spawn(command) |
| 706 | |
| 707 | password_prompt_count = 0 |
| 708 | _timeout = login_timeout |
| 709 | |
| 710 | logging.debug("Trying to login...") |
| 711 | |
| 712 | while True: |
| 713 | (match, text) = sub.read_until_last_line_matches( |
lmr | 3ca79fe | 2009-06-10 19:24:26 +0000 | [diff] [blame] | 714 | [r"[Aa]re you sure", r"[Pp]assword:\s*$", r"lost connection"], |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 715 | timeout=_timeout, internal_timeout=0.5) |
| 716 | if match == 0: # "Are you sure you want to continue connecting" |
| 717 | logging.debug("Got 'Are you sure...'; sending 'yes'") |
| 718 | sub.sendline("yes") |
| 719 | continue |
| 720 | elif match == 1: # "password:" |
| 721 | if password_prompt_count == 0: |
| 722 | logging.debug("Got password prompt; sending '%s'" % password) |
| 723 | sub.sendline(password) |
| 724 | password_prompt_count += 1 |
| 725 | _timeout = timeout |
| 726 | continue |
| 727 | else: |
| 728 | logging.debug("Got password prompt again") |
| 729 | sub.close() |
| 730 | return False |
| 731 | elif match == 2: # "lost connection" |
| 732 | logging.debug("Got 'lost connection'") |
| 733 | sub.close() |
| 734 | return False |
| 735 | else: # match == None |
| 736 | logging.debug("Timeout or process terminated") |
| 737 | sub.close() |
| 738 | return sub.poll() == 0 |
| 739 | |
| 740 | |
| 741 | def scp_to_remote(host, port, username, password, local_path, remote_path, |
| 742 | timeout=300): |
| 743 | """ |
| 744 | Copy files to a remote host (guest). |
| 745 | |
| 746 | @param host: Hostname of the guest |
| 747 | @param username: User that will be used to copy the files |
| 748 | @param password: Host's password |
| 749 | @param local_path: Path on the local machine where we are copying from |
| 750 | @param remote_path: Path on the remote machine where we are copying to |
| 751 | @param timeout: Time in seconds that we will wait before giving up to |
| 752 | copy the files. |
| 753 | |
| 754 | @return: True on success and False on failure. |
| 755 | """ |
lmr | d16a67d | 2009-06-10 19:52:59 +0000 | [diff] [blame] | 756 | command = ("scp -o UserKnownHostsFile=/dev/null -r -P %s %s %s@%s:%s" % |
| 757 | (port, local_path, username, host, remote_path)) |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 758 | return remote_scp(command, password, timeout) |
| 759 | |
| 760 | |
| 761 | def scp_from_remote(host, port, username, password, remote_path, local_path, |
| 762 | timeout=300): |
| 763 | """ |
| 764 | Copy files from a remote host (guest). |
| 765 | |
| 766 | @param host: Hostname of the guest |
| 767 | @param username: User that will be used to copy the files |
| 768 | @param password: Host's password |
| 769 | @param local_path: Path on the local machine where we are copying from |
| 770 | @param remote_path: Path on the remote machine where we are copying to |
| 771 | @param timeout: Time in seconds that we will wait before giving up to copy |
| 772 | the files. |
| 773 | |
| 774 | @return: True on success and False on failure. |
| 775 | """ |
lmr | d16a67d | 2009-06-10 19:52:59 +0000 | [diff] [blame] | 776 | command = ("scp -o UserKnownHostsFile=/dev/null -r -P %s %s@%s:%s %s" % |
| 777 | (port, username, host, remote_path, local_path)) |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 778 | return remote_scp(command, password, timeout) |
| 779 | |
| 780 | |
| 781 | def ssh(host, port, username, password, prompt, timeout=10): |
| 782 | """ |
| 783 | Log into a remote host (guest) using SSH. |
| 784 | |
| 785 | @param host: Hostname of the guest |
| 786 | @param username: User that will be used to log into the host. |
| 787 | @param password: Host's password |
| 788 | @timeout: Time in seconds that we will wait before giving up on logging |
| 789 | into the host. |
| 790 | |
| 791 | @return: kvm_spawn object on success and None on failure. |
| 792 | """ |
lmr | d16a67d | 2009-06-10 19:52:59 +0000 | [diff] [blame] | 793 | command = ("ssh -o UserKnownHostsFile=/dev/null -p %s %s@%s" % |
| 794 | (port, username, host)) |
lmr | 6f669ce | 2009-05-31 19:02:42 +0000 | [diff] [blame] | 795 | return remote_login(command, password, prompt, "\n", timeout) |
| 796 | |
| 797 | |
| 798 | def telnet(host, port, username, password, prompt, timeout=10): |
| 799 | """ |
| 800 | Log into a remote host (guest) using Telnet. |
| 801 | |
| 802 | @param host: Hostname of the guest |
| 803 | @param username: User that will be used to log into the host. |
| 804 | @param password: Host's password |
| 805 | @timeout: Time in seconds that we will wait before giving up on logging |
| 806 | into the host. |
| 807 | |
| 808 | @return: kvm_spawn object on success and None on failure. |
| 809 | """ |
| 810 | command = "telnet -l %s %s %s" % (username, host, port) |
| 811 | return remote_login(command, password, prompt, "\r\n", timeout) |
| 812 | |
| 813 | |
| 814 | # The following are functions used for running commands in the background. |
| 815 | |
| 816 | def track_process(sub, status_output=None, term_func=None, stdout_func=None, |
| 817 | prefix=""): |
| 818 | """ |
| 819 | Read lines from the stdout pipe of the subprocess. Pass each line to |
| 820 | stdout_func prefixed by prefix. Place the lines in status_output[1]. |
| 821 | When the subprocess exits, call term_func. Place the exit status in |
| 822 | status_output[0]. |
| 823 | |
| 824 | @brief Track a subprocess and report its output and termination. |
| 825 | |
| 826 | @param sub: An object returned by subprocess.Popen |
| 827 | @param status_output: A list in which the exit status and output are to be |
| 828 | stored. |
| 829 | @param term_func: A function to call when the process terminates |
| 830 | (should take no parameters) |
| 831 | @param stdout_func: A function to call with each line of output from the |
| 832 | subprocess (should take a string parameter) |
| 833 | |
| 834 | @param prefix -- a string to pre-pend to each line of the output, before |
| 835 | passing it to stdout_func |
| 836 | """ |
| 837 | while True: |
| 838 | # Read a single line from stdout |
| 839 | text = sub.stdout.readline() |
| 840 | # If the subprocess exited... |
| 841 | if text == "": |
| 842 | # Get exit code |
| 843 | status = sub.wait() |
| 844 | # Report it |
| 845 | if status_output: |
| 846 | status_output[0] = status |
| 847 | # Call term_func |
| 848 | if term_func: |
| 849 | term_func() |
| 850 | return |
| 851 | # Report the text |
| 852 | if status_output: |
| 853 | status_output[1] += text |
| 854 | # Call stdout_func with the returned text |
| 855 | if stdout_func: |
| 856 | text = prefix + text.strip() |
| 857 | # We need to sanitize the text before passing it to the logging |
| 858 | # system |
| 859 | text = text.decode('utf-8', 'replace') |
| 860 | stdout_func(text) |
| 861 | |
| 862 | |
| 863 | def run_bg(command, term_func=None, stdout_func=None, prefix="", timeout=1.0): |
| 864 | """ |
| 865 | Run command as a subprocess. Call stdout_func with each line of output from |
| 866 | the subprocess (prefixed by prefix). Call term_func when the subprocess |
| 867 | terminates. If timeout expires and the subprocess is still running, return. |
| 868 | |
| 869 | @brief: Run a subprocess in the background and collect its output and |
| 870 | exit status. |
| 871 | |
| 872 | @param command: The shell command to execute |
| 873 | @param term_func: A function to call when the process terminates |
| 874 | (should take no parameters) |
| 875 | @param stdout_func: A function to call with each line of output from |
| 876 | the subprocess (should take a string parameter) |
| 877 | @param prefix: A string to pre-pend to each line of the output, before |
| 878 | passing it to stdout_func |
| 879 | @param timeout: Time duration (in seconds) to wait for the subprocess to |
| 880 | terminate before returning |
| 881 | |
| 882 | @return: A 3-tuple containing the exit status (None if the subprocess is |
| 883 | still running), the PID of the subprocess (None if the subprocess |
| 884 | terminated), and the output collected so far. |
| 885 | """ |
| 886 | # Start the process |
| 887 | sub = subprocess.Popen(command, shell=True, stdout=subprocess.PIPE, |
| 888 | stderr=subprocess.STDOUT) |
| 889 | # Start the tracking thread |
| 890 | status_output = [None, ""] |
| 891 | thread.start_new_thread(track_process, (sub, status_output, term_func, |
| 892 | stdout_func, prefix)) |
| 893 | # Wait up to timeout secs for the process to exit |
| 894 | end_time = time.time() + timeout |
| 895 | while time.time() < end_time: |
| 896 | # If the process exited, return |
| 897 | if status_output[0] != None: |
| 898 | return (status_output[0], None, status_output[1]) |
| 899 | # Otherwise, sleep for a while |
| 900 | time.sleep(0.1) |
| 901 | # Report the PID and the output collected so far |
| 902 | return (None, sub.pid, status_output[1]) |
| 903 | |
| 904 | |
| 905 | # The following are utility functions related to ports. |
| 906 | |
| 907 | def is_sshd_running(host, port, timeout=10.0): |
| 908 | """ |
| 909 | Connect to the given host and port and wait for output. |
| 910 | Return True if the given host and port are responsive. |
| 911 | |
| 912 | @param host: Host's hostname |
| 913 | @param port: Host's port |
| 914 | @param timeout: Time (seconds) before we giving up on checking the SSH |
| 915 | daemon. |
| 916 | |
| 917 | @return: If output is available, return True. If timeout expires and no |
| 918 | output was available, return False. |
| 919 | """ |
| 920 | try: |
| 921 | # Try to connect |
| 922 | #s = socket.socket(socket.AF_INET, socket.SOCK_STREAM) |
| 923 | s = socket.socket() |
| 924 | s.connect((host, port)) |
| 925 | except socket.error: |
| 926 | # Can't connect -- return False |
| 927 | s.close() |
| 928 | logging.debug("Could not connect") |
| 929 | return False |
| 930 | s.setblocking(False) |
| 931 | # Wait up to 'timeout' seconds |
| 932 | end_time = time.time() + timeout |
| 933 | while time.time() < end_time: |
| 934 | try: |
| 935 | time.sleep(0.1) |
| 936 | # Try to receive some text |
| 937 | str = s.recv(1024) |
| 938 | if len(str) > 0: |
| 939 | s.shutdown(socket.SHUT_RDWR) |
| 940 | s.close() |
| 941 | logging.debug("Success! got string %r" % str) |
| 942 | return True |
| 943 | except socket.error: |
| 944 | # No text was available; try again |
| 945 | pass |
| 946 | # Timeout elapsed and no text was received |
| 947 | s.shutdown(socket.SHUT_RDWR) |
| 948 | s.close() |
| 949 | logging.debug("Timeout") |
| 950 | return False |
| 951 | |
| 952 | |
| 953 | def is_port_free(port): |
| 954 | """ |
| 955 | Return True if the given port is available for use. |
| 956 | |
| 957 | @param port: Port number |
| 958 | """ |
| 959 | try: |
| 960 | s = socket.socket() |
| 961 | #s.setsockopt(socket.SOL_SOCKET, socket.SO_REUSEADDR, 1) |
| 962 | s.bind(("localhost", port)) |
| 963 | free = True |
| 964 | except socket.error: |
| 965 | free = False |
| 966 | s.close() |
| 967 | return free |
| 968 | |
| 969 | |
| 970 | def find_free_port(start_port, end_port): |
| 971 | """ |
| 972 | Return a free port in the range [start_port, end_port). |
| 973 | |
| 974 | @param start_port: First port that will be checked. |
| 975 | @param end_port: Port immediately after the last one that will be checked. |
| 976 | """ |
| 977 | for i in range(start_port, end_port): |
| 978 | if is_port_free(i): |
| 979 | return i |
| 980 | return None |
| 981 | |
| 982 | |
| 983 | def find_free_ports(start_port, end_port, count): |
| 984 | """ |
| 985 | Return count free ports in the range [start_port, end_port). |
| 986 | |
| 987 | @count: Initial number of ports known to be free in the range. |
| 988 | @param start_port: First port that will be checked. |
| 989 | @param end_port: Port immediately after the last one that will be checked. |
| 990 | """ |
| 991 | ports = [] |
| 992 | i = start_port |
| 993 | while i < end_port and count > 0: |
| 994 | if is_port_free(i): |
| 995 | ports.append(i) |
| 996 | count -= 1 |
| 997 | i += 1 |
| 998 | return ports |
| 999 | |
| 1000 | |
| 1001 | # The following are miscellaneous utility functions. |
| 1002 | |
| 1003 | def generate_random_string(length): |
| 1004 | """ |
| 1005 | Return a random string using alphanumeric characters. |
| 1006 | |
| 1007 | @length: length of the string that will be generated. |
| 1008 | """ |
| 1009 | str = "" |
| 1010 | chars = string.letters + string.digits |
| 1011 | while length > 0: |
| 1012 | str += random.choice(chars) |
| 1013 | length -= 1 |
| 1014 | return str |
| 1015 | |
| 1016 | |
| 1017 | def format_str_for_message(str): |
| 1018 | """ |
| 1019 | Format str so that it can be appended to a message. |
| 1020 | If str consists of one line, prefix it with a space. |
| 1021 | If str consists of multiple lines, prefix it with a newline. |
| 1022 | |
| 1023 | @param str: string that will be formatted. |
| 1024 | """ |
| 1025 | num_lines = len(str.splitlines()) |
| 1026 | if num_lines == 0: |
| 1027 | return "" |
| 1028 | elif num_lines == 1: |
| 1029 | return " " + str |
| 1030 | else: |
| 1031 | return "\n" + str |
| 1032 | |
| 1033 | |
| 1034 | def wait_for(func, timeout, first=0.0, step=1.0, text=None): |
| 1035 | """ |
| 1036 | If func() evaluates to True before timeout expires, return the |
| 1037 | value of func(). Otherwise return None. |
| 1038 | |
| 1039 | @brief: Wait until func() evaluates to True. |
| 1040 | |
| 1041 | @param timeout: Timeout in seconds |
| 1042 | @param first: Time to sleep before first attempt |
| 1043 | @param steps: Time to sleep between attempts in seconds |
| 1044 | @param text: Text to print while waiting, for debug purposes |
| 1045 | """ |
| 1046 | start_time = time.time() |
| 1047 | end_time = time.time() + timeout |
| 1048 | |
| 1049 | time.sleep(first) |
| 1050 | |
| 1051 | while time.time() < end_time: |
| 1052 | if text: |
| 1053 | logging.debug("%s (%f secs)" % (text, time.time() - start_time)) |
| 1054 | |
| 1055 | output = func() |
| 1056 | if output: |
| 1057 | return output |
| 1058 | |
| 1059 | time.sleep(step) |
| 1060 | |
| 1061 | logging.debug("Timeout elapsed") |
| 1062 | return None |
| 1063 | |
| 1064 | |
| 1065 | def md5sum_file(filename, size=None): |
| 1066 | """ |
| 1067 | Calculate the md5sum of filename. |
| 1068 | If size is not None, limit to first size bytes. |
| 1069 | Throw exception if something is wrong with filename. |
| 1070 | Can be also implemented with bash one-liner (assuming size%1024==0): |
| 1071 | dd if=filename bs=1024 count=size/1024 | md5sum - |
| 1072 | |
| 1073 | @param filename: Path of the file that will have its md5sum calculated. |
| 1074 | @param returns: md5sum of the file. |
| 1075 | """ |
| 1076 | chunksize = 4096 |
| 1077 | fsize = os.path.getsize(filename) |
| 1078 | if not size or size>fsize: |
| 1079 | size = fsize |
| 1080 | f = open(filename, 'rb') |
| 1081 | o = md5.new() |
| 1082 | while size > 0: |
| 1083 | if chunksize > size: |
| 1084 | chunksize = size |
| 1085 | data = f.read(chunksize) |
| 1086 | if len(data) == 0: |
| 1087 | logging.debug("Nothing left to read but size=%d" % size) |
| 1088 | break |
| 1089 | o.update(data) |
| 1090 | size -= len(data) |
| 1091 | f.close() |
| 1092 | return o.hexdigest() |