python testrunner/pypyjit_tests.py in dir d:\pypy_stuff\buildbot64\slave\pypy-c-jit-win-x86-64\build (timeout 4000 secs) watching logfiles {'pytestLog': 'pypyjit_new.log'} argv: ['python', 'testrunner/pypyjit_tests.py'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\matti\AppData\Roaming ASL.LOG=Destination=file CHOCOLATEYINSTALL=C:\ProgramData\chocolatey CHOCOLATEYLASTPATHUPDATE=133185086718935289 CHOCOLATEYTOOLSLOCATION=C:\tools CLINK_DIR=C:\Program Files (x86)\clink\0.4.9 COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=DESKTOP-RYZEN COMSPEC=C:\WINDOWS\system32\cmd.exe CONDA_BAT=d:\miniconda\condabin\conda.bat CONDA_EXE=d:\miniconda\Scripts\conda.exe CONDA_SHLVL=0 CUDA_PATH=C:\Program Files\NVIDIA GPU Computing Toolkit\CUDA\v11.7 CUDA_PATH_V11_7=C:\Program Files\NVIDIA GPU Computing Toolkit\CUDA\v11.7 DRIVERDATA=C:\Windows\System32\Drivers\DriverData LOCALAPPDATA=C:\Users\matti\AppData\Local NUMBER_OF_PROCESSORS=2 NVTOOLSEXT_PATH=C:\Program Files\NVIDIA Corporation\NvToolsExt\ OS=Windows_NT PATH=d:\CPython27\lib\site-packages\pywin32_system32;d:\pypy_stuff\pypy\externals\bin;D:\CPython27;D:\pypy_stuff\pypy2.7-v7.3.18\Scripts;D:\pypy_stuff\pypy2.7-v7.3.18;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files\TortoiseHg\;C:\Program Files\Git\cmd;C:\ProgramData\chocolatey\bin;C:\WINDOWS\System32\OpenSSH PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=AMD64 Family 23 Model 113 Stepping 0, AuthenticAMD PROCESSOR_LEVEL=23 PROCESSOR_REVISION=7100 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=%ProgramFiles%\WindowsPowerShell\Modules;C:\WINDOWS\system32\WindowsPowerShell\v1.0\Modules PUBLIC=C:\Users\Public PWD=d:\pypy_stuff\buildbot64\slave\pypy-c-jit-win-x86-64\build PYPY_ENABLE_WINCONSOLEIO=1 PYTEST_XDIST_AUTO_NUM_WORKERS=4 RTOOLS40_HOME=C:\rtools40 RTOOLS43_HOME=C:\rtools43 RTOOLS44_HOME=C:\rtools44 SYSTEMDRIVE=C: SYSTEMROOT=C:\WINDOWS TEMP=D:\SystemTemp TMP=D:\SystemTemp TMPDIR=d:\systemtemp\pytest USERDOMAIN=DESKTOP-RYZEN USERNAME=matti USERPROFILE=C:\Users\matti VS140COMNTOOLS=C:\Program Files (x86)\Microsoft Visual Studio 14.0\Common7\Tools\ WINDIR=C:\WINDOWS using PTY: False ============================= test session starts ============================= platform win32 -- Python 2.7.18[pypy-8.0.0-alpha], pytest-2.9.2, py-1.4.29, pluggy-0.3.1 pytest-2.9.2 from d:\pypy_stuff\buildbot64\slave\pypy-c-jit-win-x86-64\build\pytest.pyc rootdir: d:\pypy_stuff\buildbot64\slave\pypy-c-jit-win-x86-64\build, inifile: pytest.ini collected 1207 items pypy\module\pypyjit\test_pypy_c\test_00_model.py ......................... pypy\module\pypyjit\test_pypy_c\test_alloc.py ................................................... pypy\module\pypyjit\test_pypy_c\test_array.py ....... pypy\module\pypyjit\test_pypy_c\test_boolrewrite.py ...................................................................................................................................................................................................................................................................................................................................... pypy\module\pypyjit\test_pypy_c\test_buffers.py .. pypy\module\pypyjit\test_pypy_c\test_bug.py s pypy\module\pypyjit\test_pypy_c\test_call.py .......................... pypy\module\pypyjit\test_pypy_c\test_containers.py ...................... pypy\module\pypyjit\test_pypy_c\test_cprofile.py . pypy\module\pypyjit\test_pypy_c\test_exception.py ..... pypy\module\pypyjit\test_pypy_c\test_ffi.py s..s.ss... pypy\module\pypyjit\test_pypy_c\test_generators.py ... pypy\module\pypyjit\test_pypy_c\test_getframe.py .. pypy\module\pypyjit\test_pypy_c\test_globals.py . pypy\module\pypyjit\test_pypy_c\test_import.py .. pypy\module\pypyjit\test_pypy_c\test_instance.py ................ pypy\module\pypyjit\test_pypy_c\test_intbound.py .................................................................................................................................................................................................................................................................................. pypy\module\pypyjit\test_pypy_c\test_jitlogparser.py s pypy\module\pypyjit\test_pypy_c\test_math.py FFs.. pypy\module\pypyjit\test_pypy_c\test_micronumpy.py ssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssssss pypy\module\pypyjit\test_pypy_c\test_min_max.py ... pypy\module\pypyjit\test_pypy_c\test_misc.py ................F...... pypy\module\pypyjit\test_pypy_c\test_shift.py ........................................................................................................................................................................................................................... pypy\module\pypyjit\test_pypy_c\test_string.py ................ pypy\module\pypyjit\test_pypy_c\test_struct.py ...... pypy\module\pypyjit\test_pypy_c\test_thread.py ... pypy\module\pypyjit\test_pypy_c\test_weakref.py . ================================== FAILURES =================================== ______________________________ TestMath.test_log ______________________________ self = <pypy.module.pypyjit.test_pypy_c.test_math.TestMath object at 0x00000242f73b4de8> def test_log(self): def main(n): import math i = 1 s = 0.0 while i < n: s += math.log(i) - math.log10(i) i += 1 return s log = self.run(main, [500]) assert round(log.result, 6) == round(main(500), 6) loop, = log.loops_by_filename(self.filepath) > assert loop.match(""" i2 = int_lt(i0, i1) guard_true(i2, descr=...) guard_not_invalidated(descr=...) f1 = cast_int_to_float(i0) i3 = float_le(f1, 0.0) guard_false(i3, descr=...) f2 = call_f(ConstClass(log), f1, descr=<Callf . f EF=2>) f3 = call_f(ConstClass(log10), f1, descr=<Callf . f EF=2>) f4 = float_sub(f2, f3) f5 = float_add(f0, f4) i4 = int_add(i0, 1) --TICK-- jump(..., descr=...) """) pypy\module\pypyjit\test_pypy_c\test_math.py:19: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ pypy\module\pypyjit\test_pypy_c\model.py:186: in match return matcher.match(expected_src, **kwds) pypy\module\pypyjit\test_pypy_c\model.py:527: in match self.match_loop(expected_ops, ignore_ops) pypy\module\pypyjit\test_pypy_c\model.py:503: in match_loop self.match_op(op, exp_op) pypy\module\pypyjit\test_pypy_c\model.py:420: in match_op self._assert(self.match_var(arg, exp_arg), "variable mismatch: %r instead of %r" % (arg, exp_arg)) _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ self = <pypy.module.pypyjit.test_pypy_c.model.OpMatcher object at 0x00000242f7ddef38> cond = False message = "variable mismatch: 'ConstClass(ccall_log)' instead of 'ConstClass(log)'" def _assert(self, cond, message): if not cond: > raise InvalidMatch(message, frame=sys._getframe(1)) E InvalidMatch: variable mismatch: 'ConstClass(ccall_log)' instead of 'ConstClass(log)' pypy\module\pypyjit\test_pypy_c\model.py:405: InvalidMatch ---------------------------- Captured stdout call ----------------------------- @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@ Loops don't match ================= loop id = None ("variable mismatch: 'ConstClass(ccall_log)' instead of 'ConstClass(log)'",) <could not determine information> Ignore ops: [] Got: i56 = int_lt(i51, i31) guard_true(i56, descr=<Guard0x1c07acd6260>) guard_not_invalidated(descr=<Guard0x1c07acd0fe0>) f57 = cast_int_to_float(i51) i59 = float_le(f57, 0.000000) guard_false(i59, descr=<Guard0x1c07acd1040>) ===== HERE ===== f61 = call_f(ConstClass(ccall_log), f57, descr=<Callf 8 f EF=2>) f63 = call_f(ConstClass(ccall_log10), f57, descr=<Callf 8 f EF=2>) f64 = float_sub(f61, f63) f65 = float_add(f49, f64) i67 = int_add(i51, 1) i69 = getfield_raw_i(140710487889200, descr=<FieldS pypysig_long_struct_inner.c_value 0>) i71 = int_lt(i69, 0) guard_false(i71, descr=<Guard0x1c07acd62a8>) jump(p0, p1, p6, p7, p10, p12, i67, f65, i31, descr=TargetToken(1926205620320)) Expected: i2 = int_lt(i0, i1) guard_true(i2, descr=...) guard_not_invalidated(descr=...) f1 = cast_int_to_float(i0) i3 = float_le(f1, 0.0) guard_false(i3, descr=...) f2 = call_f(ConstClass(log), f1, descr=<Callf . f EF=2>) f3 = call_f(ConstClass(log10), f1, descr=<Callf . f EF=2>) f4 = float_sub(f2, f3) f5 = float_add(f0, f4) i4 = int_add(i0, 1) guard_not_invalidated? ticker0 = getfield_raw_i(#, descr=<FieldS pypysig_long_struct_inner.c_value .*>) ticker_cond0 = int_lt(ticker0, 0) guard_false(ticker_cond0, descr=...) jump(..., descr=...) ____________________________ TestMath.test_sin_cos ____________________________ self = <pypy.module.pypyjit.test_pypy_c.test_math.TestMath object at 0x00000242f640f440> def test_sin_cos(self): def main(n): import math i = 1 s = 0.0 while i < n: s += math.sin(i) - math.cos(i) i += 1 return s log = self.run(main, [500]) assert round(log.result, 6) == round(main(500), 6) loop, = log.loops_by_filename(self.filepath) > assert loop.match(""" i2 = int_lt(i0, i1) guard_true(i2, descr=...) guard_not_invalidated(descr=...) f1 = cast_int_to_float(i0) i6 = --ISINF--(f1) guard_false(i6, descr=...) f2 = call_f(ConstClass(sin), f1, descr=<Callf . f EF=0>) f3 = call_f(ConstClass(cos), f1, descr=<Callf . f EF=0>) f4 = float_sub(f2, f3) f5 = float_add(f0, f4) i7 = int_add(i0, 1) --TICK-- jump(..., descr=) """) pypy\module\pypyjit\test_pypy_c\test_math.py:48: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ pypy\module\pypyjit\test_pypy_c\model.py:186: in match return matcher.match(expected_src, **kwds) pypy\module\pypyjit\test_pypy_c\model.py:527: in match self.match_loop(expected_ops, ignore_ops) pypy\module\pypyjit\test_pypy_c\model.py:503: in match_loop self.match_op(op, exp_op) pypy\module\pypyjit\test_pypy_c\model.py:420: in match_op self._assert(self.match_var(arg, exp_arg), "variable mismatch: %r instead of %r" % (arg, exp_arg)) _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ self = <pypy.module.pypyjit.test_pypy_c.model.OpMatcher object at 0x00000242f820b830> cond = False message = "variable mismatch: 'ConstClass(ccall_sin)' instead of 'ConstClass(sin)'" def _assert(self, cond, message): if not cond: > raise InvalidMatch(message, frame=sys._getframe(1)) E InvalidMatch: variable mismatch: 'ConstClass(ccall_sin)' instead of 'ConstClass(sin)' pypy\module\pypyjit\test_pypy_c\model.py:405: InvalidMatch ---------------------------- Captured stdout call ----------------------------- @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@ Loops don't match ================= loop id = None ("variable mismatch: 'ConstClass(ccall_sin)' instead of 'ConstClass(sin)'",) <could not determine information> Ignore ops: [] Got: i57 = int_lt(i52, i31) guard_true(i57, descr=<Guard0x19349d86260>) guard_not_invalidated(descr=<Guard0x19349d80dd0>) f58 = cast_int_to_float(i52) f60 = float_add(f58, 11235582092889474423308157442431404585112356118389416079589380072358292237843810195794279832650471001320007117491962084853674360550901038905802964414967132773610493339054092829768888725077880882465817684505312860552384417646403930092119569408801702322709406917786643639996702871154982269052209770601514008576.000000) i61 = float_eq(f60, f58) guard_false(i61, descr=<Guard0x19349d80e30>) ===== HERE ===== f63 = call_f(ConstClass(ccall_sin), f58, descr=<Callf 8 f EF=2>) f65 = call_f(ConstClass(ccall_cos), f58, descr=<Callf 8 f EF=2>) f66 = float_sub(f63, f65) f67 = float_add(f50, f66) i69 = int_add(i52, 1) i71 = getfield_raw_i(140710487889200, descr=<FieldS pypysig_long_struct_inner.c_value 0>) i73 = int_lt(i71, 0) guard_false(i73, descr=<Guard0x19349d862a8>) jump(p0, p1, p6, p7, p10, p12, i69, f67, i31, descr=TargetToken(1732110729312)) Expected: i2 = int_lt(i0, i1) guard_true(i2, descr=...) guard_not_invalidated(descr=...) f1 = cast_int_to_float(i0) f1\B999 = float_add(f1, ...) i6 = float_eq(f1\B999, f1) guard_false(i6, descr=...) f2 = call_f(ConstClass(sin), f1, descr=<Callf . f EF=0>) f3 = call_f(ConstClass(cos), f1, descr=<Callf . f EF=0>) f4 = float_sub(f2, f3) f5 = float_add(f0, f4) i7 = int_add(i0, 1) guard_not_invalidated? ticker0 = getfield_raw_i(#, descr=<FieldS pypysig_long_struct_inner.c_value .*>) ticker_cond0 = int_lt(ticker0, 0) guard_false(ticker_cond0, descr=...) jump(..., descr=) ______________________ TestMisc.test_stat_result_virtual ______________________ self = <pypy.module.pypyjit.test_pypy_c.test_misc.TestMisc object at 0x00000242f9707ad0> def test_stat_result_virtual(self): def main(n): import os res = 0 for i in range(n): res += os.path.islink(__file__) # ID: islink return res log = self.run(main, [3000]) loop, = log.loops_by_id("islink") opnames = log.opnames(loop.allops()) # one left (used to be 20+) > assert opnames.count('new_with_vtable') == 1 E assert 0 == 1 E + where 0 = <bound method list.count of ['int_lt', 'guard_false', 'int_ge', 'guard_false',...nvalidated', 'force_token', 'getfield_raw_i', 'int_lt', 'guard_false', 'jump']>('new_with_vtable') E + where <bound method list.count of ['int_lt', 'guard_false', 'int_ge', 'guard_false',...nvalidated', 'force_token', 'getfield_raw_i', 'int_lt', 'guard_false', 'jump']> = ['int_lt', 'guard_false', 'int_ge', 'guard_false', 'int_add', 'setfield_gc', ...].count pypy\module\pypyjit\test_pypy_c\test_misc.py:438: AssertionError =========================== short test summary info =========================== FAIL pypy/module/pypyjit/test_pypy_c/test_math.py::TestMath::()::test_log FAIL pypy/module/pypyjit/test_pypy_c/test_math.py::TestMath::()::test_sin_cos FAIL pypy/module/pypyjit/test_pypy_c/test_misc.py::TestMisc::()::test_stat_result_virtual ============= 3 failed, 1041 passed, 163 skipped in 81.25 seconds ============= program finished with exit code 1 elapsedTime=82.054000