2016-10-11 11:47:09 +02:00
|
|
|
import signal
|
|
|
|
import os
|
2018-03-21 12:35:51 +01:00
|
|
|
import sys
|
2016-10-28 13:20:27 +02:00
|
|
|
import traceback
|
2017-08-08 04:33:53 +02:00
|
|
|
from log import RED, single_line_delim, double_line_delim
|
2017-09-20 08:26:30 +02:00
|
|
|
from debug import spawn_gdb
|
2018-03-23 10:50:11 +01:00
|
|
|
from subprocess import check_output, CalledProcessError
|
2018-03-28 15:32:10 +02:00
|
|
|
from util import check_core_path
|
2016-10-11 11:47:09 +02:00
|
|
|
|
|
|
|
|
|
|
|
class Hook(object):
|
|
|
|
"""
|
|
|
|
Generic hooks before/after API/CLI calls
|
|
|
|
"""
|
|
|
|
|
2016-10-28 13:20:27 +02:00
|
|
|
def __init__(self, logger):
|
|
|
|
self.logger = logger
|
|
|
|
|
2016-10-11 11:47:09 +02:00
|
|
|
def before_api(self, api_name, api_args):
|
|
|
|
"""
|
|
|
|
Function called before API call
|
|
|
|
Emit a debug message describing the API name and arguments
|
|
|
|
|
|
|
|
@param api_name: name of the API
|
|
|
|
@param api_args: tuple containing the API arguments
|
|
|
|
"""
|
2016-10-28 13:20:27 +02:00
|
|
|
self.logger.debug("API: %s (%s)" %
|
|
|
|
(api_name, api_args), extra={'color': RED})
|
2016-10-11 11:47:09 +02:00
|
|
|
|
|
|
|
def after_api(self, api_name, api_args):
|
|
|
|
"""
|
|
|
|
Function called after API call
|
|
|
|
|
|
|
|
@param api_name: name of the API
|
|
|
|
@param api_args: tuple containing the API arguments
|
|
|
|
"""
|
|
|
|
pass
|
|
|
|
|
|
|
|
def before_cli(self, cli):
|
|
|
|
"""
|
|
|
|
Function called before CLI call
|
|
|
|
Emit a debug message describing the CLI
|
|
|
|
|
|
|
|
@param cli: CLI string
|
|
|
|
"""
|
2016-10-28 13:20:27 +02:00
|
|
|
self.logger.debug("CLI: %s" % (cli), extra={'color': RED})
|
2016-10-11 11:47:09 +02:00
|
|
|
|
|
|
|
def after_cli(self, cli):
|
|
|
|
"""
|
|
|
|
Function called after CLI call
|
|
|
|
"""
|
|
|
|
pass
|
|
|
|
|
|
|
|
|
|
|
|
class VppDiedError(Exception):
|
|
|
|
pass
|
|
|
|
|
|
|
|
|
|
|
|
class PollHook(Hook):
|
|
|
|
""" Hook which checks if the vpp subprocess is alive """
|
|
|
|
|
|
|
|
def __init__(self, testcase):
|
|
|
|
self.testcase = testcase
|
2016-10-28 13:20:27 +02:00
|
|
|
self.logger = testcase.logger
|
2016-10-11 11:47:09 +02:00
|
|
|
|
|
|
|
def on_crash(self, core_path):
|
2016-11-02 09:25:05 +01:00
|
|
|
if self.testcase.debug_core:
|
2018-03-14 18:14:49 +01:00
|
|
|
# notify parent process that we're handling a core file
|
|
|
|
open('%s/_core_handled' % self.testcase.tempdir, 'a').close()
|
2017-09-20 08:26:30 +02:00
|
|
|
spawn_gdb(self.testcase.vpp_bin, core_path, self.logger)
|
|
|
|
else:
|
2018-03-23 10:50:11 +01:00
|
|
|
self.logger.error("Core file present, debug with: gdb %s %s" %
|
|
|
|
(self.testcase.vpp_bin, core_path))
|
2018-03-28 15:32:10 +02:00
|
|
|
check_core_path(self.logger, core_path)
|
2018-03-23 10:50:11 +01:00
|
|
|
self.logger.error("Running `file %s':" % core_path)
|
|
|
|
try:
|
|
|
|
info = check_output(["file", core_path])
|
|
|
|
self.logger.error(info)
|
|
|
|
except CalledProcessError as e:
|
|
|
|
self.logger.error(
|
|
|
|
"Could not run `file' utility on core-file, "
|
|
|
|
"rc=%s" % e.returncode)
|
|
|
|
pass
|
2016-10-11 11:47:09 +02:00
|
|
|
|
|
|
|
def poll_vpp(self):
|
|
|
|
"""
|
|
|
|
Poll the vpp status and throw an exception if it's not running
|
|
|
|
:raises VppDiedError: exception if VPP is not running anymore
|
|
|
|
"""
|
2016-11-24 01:59:16 +01:00
|
|
|
if self.testcase.vpp_dead:
|
2016-10-11 11:47:09 +02:00
|
|
|
# already dead, nothing to do
|
|
|
|
return
|
|
|
|
|
|
|
|
self.testcase.vpp.poll()
|
|
|
|
if self.testcase.vpp.returncode is not None:
|
|
|
|
signaldict = dict(
|
|
|
|
(k, v) for v, k in reversed(sorted(signal.__dict__.items()))
|
|
|
|
if v.startswith('SIG') and not v.startswith('SIG_'))
|
2016-09-29 14:43:44 +02:00
|
|
|
|
|
|
|
if self.testcase.vpp.returncode in signaldict:
|
|
|
|
s = signaldict[abs(self.testcase.vpp.returncode)]
|
|
|
|
else:
|
|
|
|
s = "unknown"
|
2017-01-04 12:58:53 +01:00
|
|
|
msg = "VPP subprocess died unexpectedly with returncode %d [%s]" %\
|
|
|
|
(self.testcase.vpp.returncode, s)
|
2016-10-28 13:20:27 +02:00
|
|
|
self.logger.critical(msg)
|
2016-10-11 11:47:09 +02:00
|
|
|
core_path = self.testcase.tempdir + '/core'
|
|
|
|
if os.path.isfile(core_path):
|
|
|
|
self.on_crash(core_path)
|
|
|
|
self.testcase.vpp_dead = True
|
|
|
|
raise VppDiedError(msg)
|
|
|
|
|
2016-09-29 14:43:44 +02:00
|
|
|
def before_api(self, api_name, api_args):
|
2016-10-11 11:47:09 +02:00
|
|
|
"""
|
2016-09-29 14:43:44 +02:00
|
|
|
Check if VPP died before executing an API
|
2016-10-11 11:47:09 +02:00
|
|
|
|
|
|
|
:param api_name: name of the API
|
|
|
|
:param api_args: tuple containing the API arguments
|
|
|
|
:raises VppDiedError: exception if VPP is not running anymore
|
|
|
|
|
|
|
|
"""
|
2016-09-29 14:43:44 +02:00
|
|
|
super(PollHook, self).before_api(api_name, api_args)
|
2016-10-11 11:47:09 +02:00
|
|
|
self.poll_vpp()
|
|
|
|
|
2016-09-29 14:43:44 +02:00
|
|
|
def before_cli(self, cli):
|
2016-10-11 11:47:09 +02:00
|
|
|
"""
|
2016-09-29 14:43:44 +02:00
|
|
|
Check if VPP died before executing a CLI
|
2016-10-11 11:47:09 +02:00
|
|
|
|
|
|
|
:param cli: CLI string
|
|
|
|
:raises Exception: exception if VPP is not running anymore
|
|
|
|
|
|
|
|
"""
|
2016-09-29 14:43:44 +02:00
|
|
|
super(PollHook, self).before_cli(cli)
|
2016-10-11 11:47:09 +02:00
|
|
|
self.poll_vpp()
|
2016-10-28 13:20:27 +02:00
|
|
|
|
|
|
|
|
|
|
|
class StepHook(PollHook):
|
|
|
|
""" Hook which requires user to press ENTER before doing any API/CLI """
|
|
|
|
|
|
|
|
def __init__(self, testcase):
|
|
|
|
self.skip_stack = None
|
|
|
|
self.skip_num = None
|
|
|
|
self.skip_count = 0
|
|
|
|
super(StepHook, self).__init__(testcase)
|
|
|
|
|
|
|
|
def skip(self):
|
|
|
|
if self.skip_stack is None:
|
|
|
|
return False
|
|
|
|
stack = traceback.extract_stack()
|
|
|
|
counter = 0
|
|
|
|
skip = True
|
|
|
|
for e in stack:
|
|
|
|
if counter > self.skip_num:
|
|
|
|
break
|
|
|
|
if e[0] != self.skip_stack[counter][0]:
|
|
|
|
skip = False
|
|
|
|
if e[1] != self.skip_stack[counter][1]:
|
|
|
|
skip = False
|
|
|
|
counter += 1
|
|
|
|
if skip:
|
|
|
|
self.skip_count += 1
|
|
|
|
return True
|
|
|
|
else:
|
|
|
|
print("%d API/CLI calls skipped in specified stack "
|
|
|
|
"frame" % self.skip_count)
|
|
|
|
self.skip_count = 0
|
|
|
|
self.skip_stack = None
|
|
|
|
self.skip_num = None
|
|
|
|
return False
|
|
|
|
|
|
|
|
def user_input(self):
|
|
|
|
print('number\tfunction\tfile\tcode')
|
|
|
|
counter = 0
|
|
|
|
stack = traceback.extract_stack()
|
|
|
|
for e in stack:
|
|
|
|
print('%02d.\t%s\t%s:%d\t[%s]' % (counter, e[2], e[0], e[1], e[3]))
|
|
|
|
counter += 1
|
|
|
|
print(single_line_delim)
|
|
|
|
print("You can enter a number of stack frame chosen from above")
|
|
|
|
print("Calls in/below that stack frame will be not be stepped anymore")
|
|
|
|
print(single_line_delim)
|
|
|
|
while True:
|
2018-03-21 12:35:51 +01:00
|
|
|
choice = sys.stdin.readline(
|
|
|
|
"Enter your choice, if any, and press ENTER to continue "
|
|
|
|
"running the testcase...")
|
2016-10-28 13:20:27 +02:00
|
|
|
if choice == "":
|
|
|
|
choice = None
|
|
|
|
try:
|
|
|
|
if choice is not None:
|
|
|
|
num = int(choice)
|
2018-03-21 12:35:51 +01:00
|
|
|
except TypeError:
|
2016-10-28 13:20:27 +02:00
|
|
|
print("Invalid input")
|
|
|
|
continue
|
|
|
|
if choice is not None and (num < 0 or num >= len(stack)):
|
|
|
|
print("Invalid choice")
|
|
|
|
continue
|
|
|
|
break
|
|
|
|
if choice is not None:
|
|
|
|
self.skip_stack = stack
|
|
|
|
self.skip_num = num
|
|
|
|
|
|
|
|
def before_cli(self, cli):
|
|
|
|
""" Wait for ENTER before executing CLI """
|
|
|
|
if self.skip():
|
|
|
|
print("Skip pause before executing CLI: %s" % cli)
|
|
|
|
else:
|
|
|
|
print(double_line_delim)
|
|
|
|
print("Test paused before executing CLI: %s" % cli)
|
|
|
|
print(single_line_delim)
|
|
|
|
self.user_input()
|
|
|
|
super(StepHook, self).before_cli(cli)
|
|
|
|
|
|
|
|
def before_api(self, api_name, api_args):
|
|
|
|
""" Wait for ENTER before executing API """
|
|
|
|
if self.skip():
|
|
|
|
print("Skip pause before executing API: %s (%s)"
|
|
|
|
% (api_name, api_args))
|
|
|
|
else:
|
|
|
|
print(double_line_delim)
|
|
|
|
print("Test paused before executing API: %s (%s)"
|
|
|
|
% (api_name, api_args))
|
|
|
|
print(single_line_delim)
|
|
|
|
self.user_input()
|
|
|
|
super(StepHook, self).before_api(api_name, api_args)
|