CPythonよりPyPyの方が遅かった話。

書き始めたRPythonコードをCPythonとPyPyでコンパイルしたら、表題のとおりになった話。

  • PyPy2.0.2
(_)ike-no-MacBook-Air% pypy -V
Python 2.7.3 (5acfe049a5b0, May 21 2013, 13:47:22)
[PyPy 2.0.2 with GCC 4.2.1 Compatible Apple LLVM 4.2 (clang-425.0.28)]
  • CPython
ike-no-MacBook-Air% python -V
Python 2.7.2

結果

PyPy

[Timer] Total: --- 69.8 s

CPython

[Timer] Total: --- 25.6 s

PyPy

(_)ike-no-MacBook-Air% make
python /Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/bin/rpython --opt=2 targetr12a.py
[translation:info] 2.7.3 (5acfe049a5b0, May 21 2013, 13:47:22)
[translation:info] [PyPy 2.0.2 with GCC 4.2.1 Compatible Apple LLVM 4.2 (clang-425.0.28)]
[platform:msg] Set platform with 'host' cc=None, using cc='clang'
[translation:info] Translating target as defined by targetr12a
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/gcctest.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/gcctest.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/gcctest.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/gcctest
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/gcctest.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/gcctest.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/gcctest.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/gcctest
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_0.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_0.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_0.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_0
[translation] translate.py configuration:
[translation] [translate]
[translation]     opt = 2
[translation]     targetspec = targetr12a
[translation] translation configuration:
[translation] [translation]
[translation]     gc = minimark
[translation]     gctransformer = framework
[translation]     list_comprehension_operations = True
[translation]     withsmallfuncsets = 5
[translation:info] Annotating&simplifying...
[d7] {translation-task
starting annotate
[translation:info] with policy: rpython.annotator.policy.AnnotatorPolicy
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_1.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_1.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_1.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_1
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_2.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_2.o
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_3.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_3.o
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_4.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_4.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_4.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_4
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_5.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_5.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_5.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_5
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_6.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_6.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_6.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_6
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_7.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_7.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_7.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_7
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_8.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_8.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_8.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_8
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_9.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_9.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_9.c:42:1: warning: expression result unused [-Wunused-value]
[platform:WARNING] utimes;
[platform:WARNING] ^~~~~~
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_9.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_9
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_10.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_10.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_10.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_10
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_11.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_11.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_11.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_11
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic -I/Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/translator/c /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_12.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_12.o
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic -I/Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/translator/c /Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/translator/c/src/thread.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/rpython/translator/c/src/thread.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_12.o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/rpython/translator/c/src/thread.o -arch x86_64 -mmacosx-version-min=10.5 -Wl,-exported_symbols_list,/var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/dynamic-symbols-0 -I/Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/translator/c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_12
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_13.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_13.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_13.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_13
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_14.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_14.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_14.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_14
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_15.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_15.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_15.c:50:1: warning: expression result unused [-Wunused-value]
[platform:WARNING] ftime;
[platform:WARNING] ^~~~~
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_15.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_15
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_16.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_16.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_16.c:50:1: warning: expression result unused [-Wunused-value]
[platform:WARNING] gettimeofday;
[platform:WARNING] ^~~~~~~~~~~~
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_16.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_16
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_17.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_17.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_17.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_17
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_18.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_18.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_18.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_18
...+++++++++++++++*****[19c] translation-task}

[translation:info] RTyping...
[19c] {translation-task
starting rtype_lltype
...+++++++++++++++*************************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###################################################%###########%%
[rtyper] specializing: 100 / 602 blocks   (16%)
...+++++++++++++++*************************%%%%%%%%%%%
[rtyper] specializing: 200 / 839 blocks   (23%)
[rtyper] specializing: 300 / 839 blocks   (35%)
[rtyper] specializing: 400 / 839 blocks   (47%)
[rtyper] specializing: 500 / 839 blocks   (59%)
.
[rtyper] specializing: 600 / 844 blocks   (71%)
[rtyper] specializing: 700 / 844 blocks   (82%)
[rtyper] specializing: 800 / 844 blocks   (94%)
[rtyper] -=- specialized 844 blocks -=-
...+++++++++++++++*********
[rtyper] specializing: 900 / 1027 blocks   (87%)
[rtyper] specializing: 1000 / 1027 blocks   (97%)
..
[rtyper] -=- specialized 187 more blocks -=-
...
[rtyper] -=- specialized 7 more blocks -=-
[5f2] translation-task}
[translation:info] lltype back-end optimisations...
[5f2] {translation-task
starting backendopt_lltype
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
...+++++++++++++++*************************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###################################################%###########%%%##%**************
.++++++++++++++*
[backendopt:inlining] inlined 315 callsites.
[backendopt:malloc] starting malloc removal
.++++++++++++++*****************
[backendopt:malloc] removed 118 simple mallocs in total
[backendopt:mergeifblocks] starting to merge if blocks
[8ac] translation-task}
[translation:info] inserting stack checks...
[8ac] {translation-task
starting stackcheckinsertion_lltype
.+
[rtyper] -=- specialized 7 more blocks -=-
[translation:info] inserted 0 stack checks.
[8ba] translation-task}
[translation:info] Creating database for generating c source...
[8ba] {translation-task
starting database_c
.++++++++++
[rtyper] -=- specialized 25 more blocks -=-
.++++++++++++++*********************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###################################################################%%#%%*************
++++++++++++*******************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###################################################################%%%%%%%%
[rtyper:WARNING] prebuilt instance <rpython.memory.gctypelayout.GCData object at 0x000000010a2d9c90> has no attribute 'root_stack_top'
[rtyper:WARNING] prebuilt instance <rpython.memory.gctypelayout.GCData object at 0x000000010a2d9c90> has no attribute 'root_stack_base'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'young_objects_with_light_finalizers'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'initial_cleanup'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'young_rawmalloced_objects'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'rawmalloced_total_size'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'next_major_collection_initial'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'old_objects_with_light_finalizers'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_debug_pending'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_list_rpy'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'tmpstack'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_callback2_arg4'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_debug_seen'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_callback2_arg2'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_callback2_arg3'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'nursery_objects_shadows'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'young_objects_with_weakrefs'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'old_objects_with_weakrefs'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'next_major_collection_threshold'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'old_rawmalloced_objects'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'objects_to_trace'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'objects_with_finalizers'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_count_rpy'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_callback2_arg0'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute '_callback2_arg1'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'finalizer_lock_count'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x000000010a2d9948> has no attribute 'run_finalizers'
+
[rtyper] specializing: 1100 / 2574 blocks   (42%)
+++++
[rtyper] specializing: 1300 / 2588 blocks   (50%)
+++++++++++
[rtyper] specializing: 1500 / 2620 blocks   (57%)
++++++++++++*****
[rtyper] specializing: 1700 / 2656 blocks   (64%)
+++++++
[rtyper] specializing: 1900 / 2656 blocks   (71%)
++++++++++
[rtyper] specializing: 2100 / 2656 blocks   (79%)
+++
[rtyper] specializing: 2300 / 2660 blocks   (86%)
++++++
[rtyper] specializing: 2500 / 2660 blocks   (93%)
+++
[rtyper] specializing: 2600 / 2668 blocks   (97%)
[rtyper] -=- specialized 1598 more blocks -=-
+++++++++[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_19.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_19.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_19.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_19
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_20.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_20.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_20.c:44:1: warning: implicit declaration of function 'mremap' is invalid in C99 [-Wimplicit-function-declaration]
[platform:WARNING] mremap(NULL, 0, 0, 0);
[platform:WARNING] ^
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_20.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_20
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_21.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_21.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_21.c:45:20: warning: implicit declaration of function 'getpagesize' is invalid in C99 [-Wimplicit-function-declaration]
[platform:WARNING]         long int result = getpagesize();
[platform:WARNING]                           ^
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_21.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/platcheck_21
+++********
[rtyper] specializing: 2700 / 2941 blocks   (91%)
++++
[rtyper] specializing: 2900 / 2956 blocks   (98%)
+
[rtyper] -=- specialized 290 more blocks -=-
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
++++++++++++*******************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###################################################################%%%%%%%%%*********
++++++++++*****************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%##############
[backendopt:inlining] inlined 1001 callsites.
[backendopt:malloc] starting malloc removal
+++++
[backendopt:malloc] removed 26 simple mallocs in total
[backendopt:mergeifblocks] starting to merge if blocks
+++++++
[rtyper:WARNING] prebuilt instance Ellipsis has no attribute 'errno'
[rtyper] -=- specialized 15 more blocks -=-
++
[rtyper] specializing: 3000 / 3006 blocks   (99%)
[rtyper] -=- specialized 33 more blocks -=-
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
+++
[backendopt:inlining] inlined 4 callsites.
[backendopt:malloc] starting malloc removal
[backendopt:malloc] removed 0 simple mallocs in total
[backendopt:mergeifblocks] starting to merge if blocks
[c:database] GC transformer: finished helpers
[c:database] GC transformer: finished tables
[gctransform:info] assigned 51 typeids
[gctransform:info] added 100 push/pop stack root instructions
[gctransform:info] inserted 9 write barrier calls
[gctransform:info] inserted 8 write_barrier_from_array calls
[gctransform:info] found 2 static roots
[c]      622 nodes  [ array: 109  framework rtti: 19  func: 181  group: 1  struct: 312 ]
[c:database] Completed
[translation:info] database for generating C source was created
[1702] translation-task}
[translation:info] Generating c source...
[1702] {translation-task
starting source_c
[c:writing] structdef.h
[c:writing] forwarddecl.h
[c:writing] preimpl.h
[c:writing] data_r12a_main.c
[c:writing] data_rpython_memory_gc_env.c
[c:writing] data_rpython_memory_gc_minimark.c
[c:writing] data_rpython_memory_gctransform_framework.c
[c:writing] data_rpython_rlib_rdtoa.c
[c:writing] data_rpython_rtyper_lltypesystem_rclass.c
[c:writing] data_rpython_rtyper_lltypesystem_rdict.c
[c:writing] nonfuncnodes.c
[c:writing] data_rpython_memory_gc_minimark_1.c
[c:writing] data_rpython_rlib_entrypoint.c
[c:writing] data_rpython_rtyper_lltypesystem_rffi.c
[c:writing] data_rpython_rtyper_module_ll_os.c
[c:writing] implement.c
[c:writing] r12a_main.c
[c:writing] rpython_memory_gc_base.c
[c:writing] rpython_memory_gc_env.c
[c:writing] rpython_memory_gc_minimark.c
[c:writing] rpython_memory_gc_minimarkpage.c
[c:writing] rpython_memory_gctransform_framework.c
[c:writing] rpython_memory_gctransform_shadowstack.c
[c:writing] rpython_memory_gctransform_transform.c
[c:writing] rpython_memory_lldict.c
[c:writing] rpython_memory_support.c
[c:writing] rpython_rlib_entrypoint.c
[c:writing] rpython_rlib_rdtoa.c
[c:writing] rpython_rlib_rgc.c
[c:writing] rpython_rlib_rposix.c
[c:writing] rpython_rtyper_exceptiondata.c
[c:writing] rpython_rtyper_lltypesystem_ll_str.c
[c:writing] rpython_rtyper_lltypesystem_rbuilder.c
[c:writing] rpython_rtyper_lltypesystem_rclass.c
[c:writing] rpython_rtyper_lltypesystem_rdict.c
[c:writing] rpython_rtyper_lltypesystem_rffi.c
[c:writing] rpython_rtyper_lltypesystem_rlist.c
[c:writing] rpython_rtyper_lltypesystem_rstr.c
[c:writing] rpython_rtyper_module_ll_os.c
[c:writing] rpython_rtyper_module_ll_os_environ.c
[c:writing] rpython_rtyper_module_ll_os_stat.c
[c:writing] rpython_rtyper_rlist.c
[c:writing] rpython_rtyper_rrange.c
[c:writing] rpython_rtyper_rstr.c
[c:writing] rpython_translator_c_extfunc.c
[c:writing] rpython_translator_exceptiontransform.c
[translation:info] written: /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/testing_1/testing_1.c
[1a7d] translation-task}
[translation:info] Compiling c source...
[1a7d] {translation-task
starting compile_c
[platform:execute] make -j 4 in /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45/testing_1
[platform:WARNING] rpython_rtyper_lltypesystem_rffi.c:28:12: warning: implicit declaration of function 'sysctlbyname' is invalid in C99 [-Wimplicit-function-declaration]
[platform:WARNING]         l_v8272 = sysctlbyname(l_v8271, l_stararg1_0, l_stararg2_3, ((void *) NULL), l_stararg4_0);
[platform:WARNING]                   ^
[platform:WARNING] 1 warning generated.
[translation:info] usession directory: /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-45
[translation:info] created: /Users/rokujyouhitoma/workspace/r12a/bin/r12a
[1a80] translation-task}
[Timer] Timings:
[Timer] annotate                       ---  3.0 s
[Timer] rtype_lltype                   --- 11.1 s
[Timer] backendopt_lltype              ---  7.1 s
[Timer] stackcheckinsertion_lltype     ---  0.1 s
[Timer] database_c                     --- 37.0 s
[Timer] source_c                       ---  8.9 s
[Timer] compile_c                      ---  2.5 s
[Timer] =========================================
[Timer] Total:                         --- 69.8 s

CPython

ike-no-MacBook-Air% make      
python /Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/bin/rpython --opt=2 targetr12a.py
[translation:info] 2.7.2 (default, Jun 20 2012, 16:23:33)
[translation:info] [GCC 4.2.1 Compatible Apple Clang 4.0 (tags/Apple/clang-418.0.60)]
[platform:msg] Set platform with 'host' cc=None, using cc='clang'
[translation:info] Translating target as defined by targetr12a
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/gcctest.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/gcctest.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/gcctest.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/gcctest
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/gcctest.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/gcctest.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/gcctest.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/gcctest
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_0.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_0.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_0.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_0
[translation] translate.py configuration:
[translation] [translate]
[translation]     opt = 2
[translation]     targetspec = targetr12a
[translation] translation configuration:
[translation] [translation]
[translation]     gc = minimark
[translation]     gctransformer = framework
[translation]     list_comprehension_operations = True
[translation]     withsmallfuncsets = 5
[translation:info] Annotating&simplifying...
[65] {translation-task
starting annotate
[translation:info] with policy: rpython.annotator.policy.AnnotatorPolicy
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_1.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_1.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_1.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_1
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_2.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_2.o
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_3.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_3.o
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_4.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_4.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_4.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_4
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_5.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_5.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_5.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_5
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_6.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_6.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_6.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_6
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_7.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_7.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_7.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_7
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_8.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_8.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_8.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_8
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_9.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_9.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_9.c:42:1: warning: expression result unused [-Wunused-value]
[platform:WARNING] utimes;
[platform:WARNING] ^~~~~~
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_9.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_9
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_10.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_10.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_10.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_10
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_11.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_11.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_11.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_11
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic -I/Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/translator/c /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_12.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_12.o
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic -I/Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/translator/c /Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/translator/c/src/thread.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/rpython/translator/c/src/thread.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_12.o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/rpython/translator/c/src/thread.o -arch x86_64 -mmacosx-version-min=10.5 -Wl,-exported_symbols_list,/var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/dynamic-symbols-0 -I/Users/rokujyouhitoma/workspace/bitbucket.org/pypy.origin/rpython/translator/c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_12
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_13.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_13.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_13.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_13
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_14.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_14.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_14.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_14
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_15.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_15.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_15.c:50:1: warning: expression result unused [-Wunused-value]
[platform:WARNING] ftime;
[platform:WARNING] ^~~~~
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_15.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_15
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_16.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_16.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_16.c:50:1: warning: expression result unused [-Wunused-value]
[platform:WARNING] gettimeofday;
[platform:WARNING] ^~~~~~~~~~~~
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_16.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_16
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_17.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_17.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_17.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_17
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_18.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_18.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_18.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_18
...+++++++++++++++*****[a3] translation-task}

[translation:info] RTyping...
[a3] {translation-task
starting rtype_lltype
...+++++++++++++++*************************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###################################################%###########%%%##%**************
.++++++++++++++*****
[rtyper] specializing: 100 / 789 blocks   (12%)
.++++++++++++++*
[rtyper] specializing: 200 / 839 blocks   (23%)
[rtyper] specializing: 300 / 839 blocks   (35%)
.
[rtyper] specializing: 400 / 844 blocks   (47%)
[rtyper] specializing: 500 / 844 blocks   (59%)
[rtyper] specializing: 600 / 844 blocks   (71%)
[rtyper] specializing: 700 / 844 blocks   (82%)
[rtyper] specializing: 800 / 844 blocks   (94%)
[rtyper] -=- specialized 844 blocks -=-
.++++++++++++++************
[rtyper] specializing: 900 / 1027 blocks   (87%)
.+
[rtyper] specializing: 1000 / 1031 blocks   (96%)
[rtyper] -=- specialized 187 more blocks -=-
.++
[rtyper] -=- specialized 7 more blocks -=-
[1da] translation-task}
[translation:info] lltype back-end optimisations...
[1da] {translation-task
starting backendopt_lltype
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
.++++++++++++++*********************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###################################################################%%#%%*************
++++++++++++****
[backendopt:inlining] inlined 321 callsites.
[backendopt:malloc] starting malloc removal
++++++++++++*******************%
[backendopt:malloc] removed 118 simple mallocs in total
[backendopt:mergeifblocks] starting to merge if blocks
[258] translation-task}
[translation:info] inserting stack checks...
[258] {translation-task
starting stackcheckinsertion_lltype
++
[rtyper] -=- specialized 7 more blocks -=-
[translation:info] inserted 0 stack checks.
[25b] translation-task}
[translation:info] Creating database for generating c source...
[25b] {translation-task
starting database_c
+++++++++++
[rtyper] -=- specialized 25 more blocks -=-
++++++++++++*******************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###################################################################%%%%%%%%%*********
++++++++++*****************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%##########################################################################%%%%%%%%%%%%
[rtyper] specializing: 1100 / 2574 blocks   (42%)
++
[rtyper:WARNING] prebuilt instance <rpython.memory.gctypelayout.GCData object at 0x10698f090> has no attribute 'root_stack_top'
[rtyper:WARNING] prebuilt instance <rpython.memory.gctypelayout.GCData object at 0x10698f090> has no attribute 'root_stack_base'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'young_objects_with_light_finalizers'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'initial_cleanup'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'young_rawmalloced_objects'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'rawmalloced_total_size'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'next_major_collection_initial'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'old_objects_with_light_finalizers'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_debug_pending'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_list_rpy'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'tmpstack'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_callback2_arg4'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_debug_seen'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'finalizer_lock_count'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_callback2_arg3'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'nursery_objects_shadows'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'young_objects_with_weakrefs'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'old_objects_with_weakrefs'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'next_major_collection_threshold'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'old_rawmalloced_objects'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'objects_to_trace'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'objects_with_finalizers'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_count_rpy'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_callback2_arg0'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_callback2_arg1'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute '_callback2_arg2'
[rtyper:WARNING] prebuilt instance <rpython.memory.gc.minimark.MiniMarkGC object at 0x10698f0d0> has no attribute 'run_finalizers'
+++++
[rtyper] specializing: 1300 / 2593 blocks   (50%)
++++++++++******
[rtyper] specializing: 1500 / 2632 blocks   (56%)
++++++
[rtyper] specializing: 1700 / 2636 blocks   (64%)
++++++++
[rtyper] specializing: 1900 / 2645 blocks   (71%)
+++++
[rtyper] specializing: 2100 / 2656 blocks   (79%)
+++++++
[rtyper] specializing: 2300 / 2660 blocks   (86%)
++++++
[rtyper] specializing: 2500 / 2660 blocks   (93%)
+++
[rtyper] specializing: 2600 / 2660 blocks   (97%)
++
[rtyper] -=- specialized 1598 more blocks -=-
++++++++++*[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_19.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_19.o
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_19.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_19
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_20.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_20.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_20.c:44:1: warning: implicit declaration of function 'mremap' is invalid in C99 [-Wimplicit-function-declaration]
[platform:WARNING] mremap(NULL, 0, 0, 0);
[platform:WARNING] ^
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_20.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_20
[platform:execute] clang -c -arch x86_64 -O3 -fomit-frame-pointer -mmacosx-version-min=10.5 -mdynamic-no-pic /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_21.c -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_21.o
[platform:WARNING] /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_21.c:45:20: warning: implicit declaration of function 'getpagesize' is invalid in C99 [-Wimplicit-function-declaration]
[platform:WARNING]         long int result = getpagesize();
[platform:WARNING]                           ^
[platform:WARNING] 1 warning generated.
[platform:execute] clang /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_21.o -arch x86_64 -mmacosx-version-min=10.5 -o /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/platcheck_21
********
[rtyper] specializing: 2700 / 2926 blocks   (92%)
++++
[rtyper] specializing: 2900 / 2942 blocks   (98%)
++
[rtyper] -=- specialized 290 more blocks -=-
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
++++++++++*****************%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%##########################################################################%%%%%%%%%%%%%******
++++++++****************#%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%###########
[backendopt:inlining] inlined 994 callsites.
[backendopt:malloc] starting malloc removal
+++++
[backendopt:malloc] removed 26 simple mallocs in total
[backendopt:mergeifblocks] starting to merge if blocks
+++++++
[rtyper:WARNING] prebuilt instance Ellipsis has no attribute 'errno'
[rtyper] -=- specialized 15 more blocks -=-
++
[rtyper] specializing: 3000 / 3006 blocks   (99%)
[rtyper] -=- specialized 33 more blocks -=-
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
+++
[backendopt:inlining] inlined 4 callsites.
[backendopt:malloc] starting malloc removal
[backendopt:malloc] removed 0 simple mallocs in total
[backendopt:mergeifblocks] starting to merge if blocks
[c:database] GC transformer: finished helpers
[c:database] GC transformer: finished tables
[gctransform:info] assigned 51 typeids
[gctransform:info] added 100 push/pop stack root instructions
[gctransform:info] inserted 9 write barrier calls
[gctransform:info] inserted 8 write_barrier_from_array calls
[gctransform:info] found 2 static roots
[c]      622 nodes  [ array: 109  framework rtti: 19  func: 181  group: 1  struct: 312 ]
[c:database] Completed
[translation:info] database for generating C source was created
[757] translation-task}
[translation:info] Generating c source...
[757] {translation-task
starting source_c
[c:writing] structdef.h
[c:writing] forwarddecl.h
[c:writing] preimpl.h
[c:writing] data_r12a_main.c
[c:writing] data_rpython_memory_gc_env.c
[c:writing] data_rpython_memory_gc_minimark.c
[c:writing] data_rpython_memory_gctransform_framework.c
[c:writing] data_rpython_rlib_rdtoa.c
[c:writing] data_rpython_rtyper_lltypesystem_rclass.c
[c:writing] data_rpython_rtyper_lltypesystem_rdict.c
[c:writing] nonfuncnodes.c
[c:writing] data_rpython_memory_gc_minimark_1.c
[c:writing] data_rpython_rlib_entrypoint.c
[c:writing] data_rpython_rtyper_lltypesystem_rffi.c
[c:writing] data_rpython_rtyper_module_ll_os.c
[c:writing] implement.c
[c:writing] r12a_main.c
[c:writing] rpython_memory_gc_base.c
[c:writing] rpython_memory_gc_env.c
[c:writing] rpython_memory_gc_minimark.c
[c:writing] rpython_memory_gc_minimarkpage.c
[c:writing] rpython_memory_gctransform_framework.c
[c:writing] rpython_memory_gctransform_shadowstack.c
[c:writing] rpython_memory_gctransform_transform.c
[c:writing] rpython_memory_lldict.c
[c:writing] rpython_memory_support.c
[c:writing] rpython_rlib_entrypoint.c
[c:writing] rpython_rlib_rdtoa.c
[c:writing] rpython_rlib_rgc.c
[c:writing] rpython_rlib_rposix.c
[c:writing] rpython_rtyper_exceptiondata.c
[c:writing] rpython_rtyper_lltypesystem_ll_str.c
[c:writing] rpython_rtyper_lltypesystem_rbuilder.c
[c:writing] rpython_rtyper_lltypesystem_rclass.c
[c:writing] rpython_rtyper_lltypesystem_rdict.c
[c:writing] rpython_rtyper_lltypesystem_rffi.c
[c:writing] rpython_rtyper_lltypesystem_rlist.c
[c:writing] rpython_rtyper_lltypesystem_rstr.c
[c:writing] rpython_rtyper_module_ll_os.c
[c:writing] rpython_rtyper_module_ll_os_environ.c
[c:writing] rpython_rtyper_module_ll_os_stat.c
[c:writing] rpython_rtyper_rlist.c
[c:writing] rpython_rtyper_rrange.c
[c:writing] rpython_rtyper_rstr.c
[c:writing] rpython_translator_c_extfunc.c
[c:writing] rpython_translator_exceptiontransform.c
[translation:info] written: /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/testing_1/testing_1.c
[8fa] translation-task}
[translation:info] Compiling c source...
[8fa] {translation-task
starting compile_c
[platform:execute] make -j 4 in /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46/testing_1
[platform:WARNING] rpython_rtyper_lltypesystem_rffi.c:28:12: warning: implicit declaration of function 'sysctlbyname' is invalid in C99 [-Wimplicit-function-declaration]
[platform:WARNING]         l_v8273 = sysctlbyname(l_v8274, l_stararg1_0, l_stararg2_0, ((void *) NULL), l_stararg4_0);
[platform:WARNING]                   ^
[platform:WARNING] 1 warning generated.
[translation:info] usession directory: /var/folders/lc/vw5blb150gxd3_xwxj2k3s080000gn/T/usession-default-46
[translation:info] created: /Users/rokujyouhitoma/workspace/r12a/bin/r12a
[8fb] translation-task}
[Timer] Timings:
[Timer] annotate                       ---  1.6 s
[Timer] rtype_lltype                   ---  3.1 s
[Timer] backendopt_lltype              ---  1.3 s
[Timer] stackcheckinsertion_lltype     ---  0.0 s
[Timer] database_c                     --- 13.0 s
[Timer] source_c                       ---  4.2 s
[Timer] compile_c                      ---  2.4 s
[Timer] =========================================
[Timer] Total:                         --- 25.6 s

一言

何が原因でしょうね...ひとまず、原因究明よりCPythonで続きする。コードでかくなってきたら逆転するかもだから、コード増やす。