import os import sys import shutil import tempfile import logging import subprocess import re import csv from contextlib import contextmanager from glob import glob from pty import openpty import xml.etree.ElementTree as ET prev_dir = os.path.dirname(os.path.dirname(os.path.dirname(os.path.abspath(__file__)))) if prev_dir not in sys.path: sys.path.insert(0, prev_dir) from kibot.misc import (error_level_to_name) COVERAGE_SCRIPT = 'python3-coverage' KICAD_PCB_EXT = '.kicad_pcb' KICAD_VERSION_5_99 = 5099000 KICAD_VERSION_5_1_7 = 5001007 MODE_SCH = 1 MODE_PCB = 0 # Defined as True to collect real world queries ADD_QUERY_TO_KNOWN = False ng_ver = os.environ.get('KIAUS_USE_NIGHTLY') if ng_ver: # Path to the Python module sys.path.insert(0, '/usr/lib/kicad-nightly/lib/python3/dist-packages') import pcbnew m = re.search(r'(\d+)\.(\d+)\.(\d+)', pcbnew.GetBuildVersion()) logging.debug(pcbnew.GetBuildVersion()) kicad_major = int(m.group(1)) kicad_minor = int(m.group(2)) kicad_patch = int(m.group(3)) kicad_version = kicad_major*1000000+kicad_minor*1000+kicad_patch if kicad_version >= KICAD_VERSION_5_99: BOARDS_DIR = '../board_samples/kicad_6' REF_DIR = 'tests/reference/6_0_0' KICAD_SCH_EXT = '.kicad_sch' # Now these layers can be renamed. # KiCad 6 takes the freedom to give them more descriptive names ... DEF_ADHES = 'Adhesive' DEF_CRTYD = 'Courtyard' DEF_SILKS = 'Silkscreen' DEF_CMTSU = 'User_Comments' DEF_DWGSU = 'User_Drawings' DEF_ECO1U = 'User_Eco1' DEF_ECO2U = 'User_Eco2' else: BOARDS_DIR = '../board_samples/kicad_5' KICAD_SCH_EXT = '.sch' DEF_ADHES = 'Adhes' DEF_CRTYD = 'CrtYd' DEF_SILKS = 'SilkS' DEF_CMTSU = 'Cmts_User' DEF_DWGSU = 'Dwgs_User' DEF_ECO1U = 'Eco1_User' DEF_ECO2U = 'Eco2_User' if kicad_version >= KICAD_VERSION_5_1_7: # 5.1.8 uses the same references as 5.1.7 REF_DIR = 'tests/reference/5_1_7' else: REF_DIR = 'tests/reference/5_1_6' logging.debug('Detected KiCad v{}.{}.{} ({})'.format(kicad_major, kicad_minor, kicad_patch, kicad_version)) def quote(s): return '"'+s+'"' def usable_cmd(cmd): return ' '.join(cmd) @contextmanager def cover_it(cov): # Start coverage cov.load() cov.start() yield # Stop coverage cov.stop() cov.save() class TestContext(object): def __init__(self, test_dir, test_name, board_name, yaml_name, sub_dir, yaml_compressed=False, add_cfg_kmajor=False): self.kicad_version = kicad_version if add_cfg_kmajor: major = kicad_major if kicad_minor == 99: # KiCad 5.99 is 6.0.0 alpha major = 6 yaml_name += str(major) if not hasattr(self, 'mode'): # We are using PCBs self.mode = MODE_PCB # The name used for the test output dirs and other logging self.test_name = test_name # The name of the PCB board file self.board_name = board_name # The actual board file that will be loaded self._get_board_file() # The YAML file we'll use self._get_yaml_name(yaml_name, yaml_compressed) # The actual output dir for this run self._set_up_output_dir(test_dir) # Where are we expecting to get the outputs (inside test_name) self.sub_dir = sub_dir # stdout and stderr from the run self.out = None self.err = None self.proc = None def get_board_dir(self): this_dir = os.path.dirname(os.path.realpath(__file__)) return os.path.join(this_dir, BOARDS_DIR) def _get_board_file(self): self.board_file = os.path.abspath(os.path.join(self.get_board_dir(), self.board_name + KICAD_PCB_EXT)) self.sch_file = os.path.abspath(os.path.join(self.get_board_dir(), self.board_name + KICAD_SCH_EXT)) logging.info('KiCad file: '+self.board_file) if self.mode == MODE_PCB: assert os.path.isfile(self.board_file) else: assert os.path.isfile(self.sch_file) def _get_yaml_dir(self): this_dir = os.path.dirname(os.path.realpath(__file__)) return os.path.join(this_dir, '../yaml_samples') def _get_yaml_name(self, name, yaml_compressed): self.yaml_file = os.path.abspath(os.path.join(self._get_yaml_dir(), name+'.kibot.yaml')) if yaml_compressed: self.yaml_file += '.gz' if not os.path.isfile(self.yaml_file): self.yaml_file = self.yaml_file.replace('.kibot.', '.kiplot.') logging.info('YAML file: '+self.yaml_file) assert os.path.isfile(self.yaml_file) def _set_up_output_dir(self, test_dir): if test_dir: self.output_dir = os.path.join(test_dir, self.test_name) os.makedirs(self.output_dir, exist_ok=True) self._del_dir_after = False else: # create a tmp dir self.output_dir = tempfile.mkdtemp(prefix='tmp-kibot-'+self.test_name+'-') self._del_dir_after = True logging.info('Output dir: '+self.output_dir) def clean_up(self, keep_project=False): logging.debug('Clean-up') if self._del_dir_after: logging.debug('Removing dir') shutil.rmtree(self.output_dir) # We don't have a project, and we don't want one pro = os.path.join(self.get_board_dir(), self.board_name+'.pro') if os.path.isfile(pro) and not keep_project: os.remove(pro) # We don't have a footprint cache, and we don't want one fp_cache = os.path.join(self.get_board_dir(), 'fp-info-cache') if os.path.isfile(fp_cache): os.remove(fp_cache) def get_out_path(self, filename): return os.path.join(self.output_dir, filename) def get_gerber_job_filename(self): return os.path.join(self.sub_dir, self.board_name+'-job.gbrjob') def get_gerber_filename(self, layer_slug, ext='.gbr'): return os.path.join(self.sub_dir, self.board_name+'-'+layer_slug+ext) def get_pos_top_filename(self): return os.path.join(self.sub_dir, self.board_name+'-top_pos.pos') def get_pos_bot_filename(self): return os.path.join(self.sub_dir, self.board_name+'-bottom_pos.pos') def get_pos_both_filename(self): return os.path.join(self.sub_dir, self.board_name+'-both_pos.pos') def get_pos_top_csv_filename(self): return os.path.join(self.sub_dir, self.board_name+'-top_pos.csv') def get_pos_bot_csv_filename(self): return os.path.join(self.sub_dir, self.board_name+'-bottom_pos.csv') def get_pos_both_csv_filename(self): return os.path.join(self.sub_dir, self.board_name+'-both_pos.csv') def get_pth_drl_filename(self): return os.path.join(self.sub_dir, self.board_name+'-PTH.drl') def get_pth_gbr_drl_filename(self): return os.path.join(self.sub_dir, self.board_name+'-PTH-drl.gbr') def get_pth_pdf_drl_filename(self): return os.path.join(self.sub_dir, self.board_name+'-PTH-drl_map.pdf') def get_npth_drl_filename(self): return os.path.join(self.sub_dir, self.board_name+'-NPTH.drl') def get_npth_gbr_drl_filename(self): return os.path.join(self.sub_dir, self.board_name+'-NPTH-drl.gbr') def get_npth_pdf_drl_filename(self): return os.path.join(self.sub_dir, self.board_name+'-NPTH-drl_map.pdf') def expect_out_file(self, filename): file = self.get_out_path(filename) assert os.path.isfile(file), file assert os.path.getsize(file) > 0 logging.debug(filename+' OK') return file def dont_expect_out_file(self, filename): file = self.get_out_path(filename) assert not os.path.isfile(file) def create_dummy_out_file(self, filename): file = self.get_out_path(filename) with open(file, 'w') as f: f.write('Dummy file\n') def do_run(self, cmd, ret_val=None, use_a_tty=False, chdir_out=False): cmd_base = [COVERAGE_SCRIPT, 'run', '-a'] if chdir_out: cwd = os.getcwd() cmd_base.append('--rcfile='+os.path.join(cwd, '.coveragerc')) os.environ['COVERAGE_FILE'] = os.path.join(cwd, '.coverage') cmd = cmd_base+cmd logging.debug(cmd) out_filename = self.get_out_path('output.txt') err_filename = self.get_out_path('error.txt') if use_a_tty: # This is used to test the coloured logs, we need stderr to be a TTY master, slave = openpty() f_err = slave f_out = slave else: # Redirect stdout and stderr to files f_out = os.open(out_filename, os.O_RDWR | os.O_CREAT) f_err = os.open(err_filename, os.O_RDWR | os.O_CREAT) # Run the process if chdir_out: cwd = os.getcwd() os.chdir(self.output_dir) process = subprocess.Popen(cmd, stdout=f_out, stderr=f_err) if chdir_out: os.chdir(cwd) del os.environ['COVERAGE_FILE'] ret_code = process.wait() logging.debug('ret_code '+str(ret_code)) if use_a_tty: self.err = os.read(master, 10000) self.err = self.err.decode() self.out = self.err exp_ret = 0 if ret_val is None else ret_val assert ret_code == exp_ret, 'ret_code: {} ({}) expected {}'.format(ret_code, error_level_to_name[ret_code], exp_ret) if use_a_tty: os.close(master) os.close(slave) with open(out_filename, 'w') as f: f.write(self.out) with open(err_filename, 'w') as f: f.write(self.out) else: # Read stdout os.lseek(f_out, 0, os.SEEK_SET) self.out = os.read(f_out, 1000000) os.close(f_out) self.out = self.out.decode() # Read stderr os.lseek(f_err, 0, os.SEEK_SET) self.err = os.read(f_err, 1000000) os.close(f_err) self.err = self.err.decode() def run(self, ret_val=None, extra=None, use_a_tty=False, filename=None, no_out_dir=False, no_board_file=False, no_yaml_file=False, chdir_out=False, no_verbose=False, extra_debug=False, do_locale=False, kicost=False): logging.debug('Running '+self.test_name) # Change the command to be local and add the board and output arguments cmd = [os.path.abspath(os.path.dirname(os.path.abspath(__file__))+'/../../src/kibot')] if not no_verbose: # One is enough, 2 can generate tons of data when loading libs cmd.append('-v') if extra_debug: cmd.append('-vvv') if not no_board_file: if self.mode == MODE_PCB: cmd = cmd+['-b', filename if filename else self.board_file] else: cmd = cmd+['-e', filename if filename else self.sch_file] if not no_yaml_file: cmd = cmd+['-c', self.yaml_file] if not no_out_dir: cmd = cmd+['-d', self.output_dir] if extra is not None: cmd = cmd+extra # Do we need a custom locale? old_LOCPATH = None old_LANG = None if do_locale: # Setup an Spanish for Argentina using UTF-8 locale old_LOCPATH = os.environ.get('LOCPATH') old_LANG = os.environ.get('LANG') os.environ['LOCPATH'] = os.path.abspath('tests/data') os.environ['LANG'] = do_locale logging.debug('LOCPATH='+os.environ['LOCPATH']) logging.debug('LANG='+os.environ['LANG']) # KiCost fake environment setup if kicost: # Always fake the currency rates os.environ['KICOST_CURRENCY_RATES'] = 'tests/data/currency_rates.xml' if ADD_QUERY_TO_KNOWN: queries_file = 'tests/data/kitspace_queries.txt' os.environ['KICOST_LOG_HTTP'] = queries_file with open(queries_file, 'at') as f: f.write('# ' + self.board_name + '\n') server = None else: os.environ['KICOST_KITSPACE_URL'] = 'http://localhost:8000' fo = open(self.get_out_path('server_stdout.txt'), 'at') fe = open(self.get_out_path('server_stderr.txt'), 'at') server = subprocess.Popen('./tests/utils/dummy-web-server.py', stdout=fo, stderr=fe) try: self.do_run(cmd, ret_val, use_a_tty, chdir_out) finally: # Always kill the fake web server if kicost and server is not None: server.terminate() fo.close() fe.close() # Do we need to restore the locale? if do_locale: if old_LOCPATH: os.environ['LOCPATH'] = old_LOCPATH else: del os.environ['LOCPATH'] if old_LANG: os.environ['LANG'] = old_LANG else: del os.environ['LANG'] def search_out(self, text): m = re.search(text, self.out, re.MULTILINE) assert m is not None logging.debug('output match: `{}` OK'.format(text)) return m def search_err(self, text, invert=False): if isinstance(text, list): res = [] for t in text: m = re.search(t, self.err, re.MULTILINE) if invert: assert m is None, t logging.debug('error no match: `{}` OK'.format(t)) else: assert m is not None, t logging.debug('error match: `{}` (`{}`) OK'.format(t, m.group(0))) res.append(m) return res m = re.search(text, self.err, re.MULTILINE) if invert: assert m is None, text logging.debug('error no match: `{}` OK'.format(text)) else: assert m is not None, text logging.debug('error match: `{}` (`{}`) OK'.format(text, m.group(0))) return m def search_in_file(self, file, texts): logging.debug('Searching in "'+file+'" output') with open(self.get_out_path(file)) as f: txt = f.read() res = [] for t in texts: msg = '- r"'+t+'"' m = re.search(t, txt, re.MULTILINE) assert m, msg logging.debug(msg+' OK') # logging.debug(' '+m.group(0)) res.append(m.groups()) return res def search_not_in_file(self, file, texts): logging.debug('Searching not in "'+file+'" output') with open(self.get_out_path(file)) as f: txt = f.read() for t in texts: msg = '- r"'+t+'"' m = re.search(t, txt, re.MULTILINE) assert m is None, msg logging.debug(msg+' OK') # logging.debug(' '+m.group(0)) def compare_image(self, image, reference=None, diff='diff.png', ref_out_dir=False, fuzz='5%'): """ For images and single page PDFs """ if reference is None: reference = image if ref_out_dir: reference = self.get_out_path(reference) else: reference = os.path.join(REF_DIR, reference) image = self.get_out_path(image) png_ref = None if reference[-3:] == 'svg': png_ref = reference[:-3]+'png' subprocess.check_call(['rsvg-convert', '-d', '300', '-p', '300', '-o', png_ref, reference]) reference = png_ref png_image = None if image[-3:] == 'svg': png_image = image[:-3]+'png' subprocess.check_call(['rsvg-convert', '-d', '300', '-p', '300', '-o', png_image, image]) image = png_image cmd = ['compare', # Tolerate 5 % error in color '-fuzz', fuzz, # Count how many pixels differ '-metric', 'AE', image, reference, # Avoid the part where KiCad version is printed '-crop', '100%x87%+0+0', '+repage', '-colorspace', 'RGB', self.get_out_path(diff)] logging.debug('Comparing images with: '+usable_cmd(cmd)) res = subprocess.check_output(cmd, stderr=subprocess.STDOUT) # m = re.match(r'([\d\.e-]+) \(([\d\.e-]+)\)', res.decode()) # assert m # logging.debug('MSE={} ({})'.format(m.group(1), m.group(2))) ae = int(res.decode()) logging.debug('AE=%d' % ae) if png_ref: os.remove(png_ref) if png_image: os.remove(png_image) assert ae == 0 def compare_pdf(self, gen, reference=None, diff='diff-{}.png'): """ For multi-page PDFs """ if reference is None: reference = gen logging.debug('Comparing PDFs: '+gen+' vs '+reference) # Split the reference logging.debug('Splitting '+reference) cmd = ['convert', '-density', '150', os.path.join(REF_DIR, reference), self.get_out_path('ref-%d.png')] subprocess.check_call(cmd) # Split the generated logging.debug('Splitting '+gen) cmd = ['convert', '-density', '150', self.get_out_path(gen), self.get_out_path('gen-%d.png')] subprocess.check_call(cmd) # Chek number of pages ref_pages = glob(self.get_out_path('ref-*.png')) gen_pages = glob(self.get_out_path('gen-*.png')) logging.debug('Pages {} vs {}'.format(len(gen_pages), len(ref_pages))) assert len(ref_pages) == len(gen_pages) # Compare each page for page in range(len(ref_pages)): self.compare_image('gen-'+str(page)+'.png', 'ref-'+str(page)+'.png', diff.format(page), ref_out_dir=True) def compare_txt(self, text, reference=None, diff='diff.txt'): if reference is None: reference = text cmd = ['/bin/sh', '-c', 'diff -ub '+os.path.join(REF_DIR, reference)+' ' + self.get_out_path(text)+' > '+self.get_out_path(diff)] logging.debug('Comparing texts with: '+usable_cmd(cmd)) res = subprocess.call(cmd) assert res == 0, res def filter_txt(self, file, pattern, repl): fname = self.get_out_path(file) with open(fname) as f: txt = f.read() with open(fname, 'w') as f: f.write(re.sub(pattern, repl, txt)) def expect_gerber_flash_at(self, file, res, pos): """ Check for a gerber flash at a given point (it's hard to check that aperture is right without a real gerber parser """ if res == 6: # 4.6 mult = 1000000 else: # 4.5 mult = 100000 repat = r'^X{x}Y{y}D03\*$'.format(x=int(pos[0]*mult), y=int(pos[1]*mult)) self.search_in_file(file, [repat]) logging.debug("Gerber flash found: "+repat) def expect_gerber_has_apertures(self, file, ap_list): ap_matches = [] for ap in ap_list: # find the circular aperture for the outline ap_matches.append(r'%AD(.*)'+ap+r'\*%') grps = self.search_in_file(file, ap_matches) aps = [] for grp in grps: ap_no = grp[0] assert ap_no is not None # apertures from D10 to D999 assert len(ap_no) in [2, 3] aps.append(ap_no) logging.debug("Found apertures {}".format(aps)) return aps def load_csv(self, filename, delimiter=','): rows = [] with open(self.expect_out_file(os.path.join(self.sub_dir, filename))) as csvfile: reader = csv.reader(csvfile, delimiter=delimiter) header = next(reader) for r in reader: if not r: break rows.append(r) # Collect info info = [] for r in reader: if r: info.append(r) return rows, header, info def load_html(self, filename): file = self.expect_out_file(os.path.join(self.sub_dir, filename)) with open(file) as f: html = f.read() rows = [] headers = [] sh_head = {} for cl, body in re.findall(r'