rlib/rvmprof/test/test_rvmprof.py::TestEnable::()::test
self = <rpython.rlib.rvmprof.test.test_rvmprof.TestEnable object at 0x0000000121bf28e0>
def test(self):
from vmprof import read_profile
assert self.entry_point(10**4, 0.1, 0) == 99990000
assert self.tmpfile.check()
self.tmpfile.remove()
#
assert self.rpy_entry_point(10**4, 0.5, 0) == 99990000
assert self.tmpfile.check()
prof = read_profile(self.tmpfilename)
tree = prof.get_tree()
assert tree.name == 'py:code:52:test_enable'
> assert self.approx_equal(tree.count, 0.5/self.SAMPLING_INTERVAL)
E assert <bound method TestEnable.approx_equal of <rpython.rlib.rvmprof.test.test_rvmprof.TestEnable object at 0x0000000121bf28e0>>(1, (0.5 / 0.004))
E + where <bound method TestEnable.approx_equal of <rpython.rlib.rvmprof.test.test_rvmprof.TestEnable object at 0x0000000121bf28e0>> = <rpython.rlib.rvmprof.test.test_rvmprof.TestEnable object at 0x0000000121bf28e0>.approx_equal
E + and 1 = 1
E + where 1 = <Node: py:code:52:test_enable (1) []>.count
E + and 0.004 = <rpython.rlib.rvmprof.test.test_rvmprof.TestEnable object at 0x0000000121bf28e0>.SAMPLING_INTERVAL
rlib/rvmprof/test/test_rvmprof.py:140: AssertionError
---------- Captured stderr setup ----------
[flowgraph] (rpython.translator.c.test.test_genc:66)entry_point
[translation:info] Annotating&simplifying...
[c583f8a6abdbc00] {translation-task
starting annotate
[translation:info] with policy: rpython.annotator.policy.AnnotatorPolicy
[flowgraph] (rpython.rlib.rvmprof.test.test_rvmprof:102)RVMProfSamplingTest.entry_point
[flowgraph] (rpython.rlib.rvmprof.test.test_rvmprof:16)MyCode.__init__
[flowgraph] (rpython.rlib.rvmprof:17)register_code
[flowgraph] (rpython.rlib.rvmprof.rvmprof:59)VMProf.register_code
[flowgraph] (rpython.rlib.rweaklist:46)WeakCodeObjectList.add_handle
[flowgraph] (rpython.rlib.rweaklist:24)WeakCodeObjectList.reserve_next_handle_index
[flowgraph] (rpython.rlib.rweaklist:51)WeakCodeObjectList.store_handle
[flowgraph] (rpython.rlib.rposix:461)open
[flowgraph] (rpython.rlib.rposix:385)_as_bytes0
[flowgraph] (rpython.rlib.rposix:371)_as_bytes
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)open
[flowgraph] (rpython.rtyper.lltypesystem.rffi:926)get_nonmovingbuffer_ll_final_null
[flowgraph] (rpython.rtyper.lltypesystem.rffi:873)get_nonmovingbuffer_ll
[flowgraph] (rpython.rlib.objectmodel:315)we_are_translated_to_c
[flowgraph] (rpython.rtyper.lltypesystem.rstr:116)copy_string_to_raw
[flowgraph] (rpython.rtyper.lltypesystem.rstr:63)_get_raw_buf
[flowgraph] (rpython.rtyper.lltypesystem.rstr:57)_str_ofs
[flowgraph] (rpython.rtyper.lltypesystem.llmemory:411)sizeof
[flowgraph] (rpython.rtyper.lltypesystem.rffi:3)ccall_open
[flowgraph] (rpython.rlib.rgil:160)release
[flowgraph] (rpython.rlib.rposix:151)_errno_before
[flowgraph] (rpython.rlib.rthread:349)getraw
[flowgraph] (rpython.rlib.rthread:349)getraw
[flowgraph] (rpython.rlib.rposix:170)_errno_after
[flowgraph] (rpython.rlib.rthread:364)setraw
[flowgraph] (rpython.rlib.rthread:364)setraw
[flowgraph] (rpython.rlib.rgil:171)acquire
[flowgraph] (rpython.rlib.rthread:282)gc_thread_run
[flowgraph] (rpython.rtyper.lltypesystem.rffi:937)free_nonmovingbuffer_ll
[flowgraph] (rpython.rlib.rposix:430)handle_posix_error
[flowgraph] (rpython.rlib.rarithmetic:139)widen
[flowgraph] (rpython.rlib.rposix:113)get_saved_errno
[flowgraph] (rpython.rlib.rvmprof:35)enable
[flowgraph] (rpython.rlib.rvmprof.rvmprof:131)VMProf.enable
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)vmprof_init
[flowgraph] (rpython.rtyper.lltypesystem.rffi:3)ccall_vmprof_init
[flowgraph] (rpython.rtyper.lltypesystem.rffi:854)charp2str
[flowgraph] (rpython.rtyper.lltypesystem.rffi:1030)charpsize2str
[flowgraph] (?:2)mallocstr
[flowgraph] (rpython.rtyper.lltypesystem.rstr:36)mallocstr
[flowgraph] (rpython.rlib.rvmprof.rvmprof:117)gather_all_code_objs
[flowgraph] (rpython.rlib.rweaklist:21)WeakCodeObjectList.get_all_handles
[flowgraph] (rpython.rlib.rvmprof.rvmprof:51)<lambda>
[flowgraph] (rpython.rlib.rvmprof.test.test_rvmprof:19)MyCode.get_name
[flowgraph] (rpython.rlib.rvmprof.rvmprof:169)VMProf._write_code_registration
[flowgraph] (rpython.rtyper.lltypesystem.rstr:145)copy_raw_to_string
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)vmprof_register_virtual_function
[flowgraph] (rpython.rtyper.lltypesystem.rffi:3)ccall_vmprof_register_virtual_function
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)vmprof_enable
[flowgraph] (rpython.rtyper.lltypesystem.rffi:3)ccall_vmprof_enable
[flowgraph] (rpython.rlib.rposix:151)_errno_before
[flowgraph] (rpython.rlib.rposix:170)_errno_after
[flowgraph] (rpython.rlib.rvmprof.rvmprof:27)VMProfError.__init__
[flowgraph] (rpython.rlib.rposix:1182)strerror
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)strerror
[flowgraph] (rpython.rlib.rtime:146)time
[flowgraph] (rpython.rlib.rtime:101)decode_timeval
[flowgraph] (rpython.rtyper.lltypesystem.rffi:1374)getintfield
[flowgraph] (rpython.rtyper.lltypesystem.rffi:1374)getintfield
[flowgraph] (rpython.rlib.rvmprof.rvmprof:224)TestEnable.main_rvmprof
[flowgraph] (rpython.rlib.rvmprof.test.test_rvmprof:122)<lambda>
[flowgraph] (rpython.rlib.rvmprof:38)disable
[flowgraph] (rpython.rlib.rvmprof.rvmprof:156)VMProf.disable
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)vmprof_disable
[flowgraph] (rpython.rtyper.lltypesystem.rffi:3)ccall_vmprof_disable
[flowgraph] (rpython.rlib.rposix:151)_errno_before
[flowgraph] (rpython.rlib.rposix:170)_errno_after
[flowgraph] (rpython.rlib.rvmprof.rvmprof:220)decorated_jitted_function
[flowgraph] (rpython.rlib.rvmprof.test.test_rvmprof:122)main
[flowgraph] (rpython.rlib.rvmprof.cintf:187)enter_code
[flowgraph] (rpython.rlib.rthread:356)get_or_make_raw
[flowgraph] (rpython.rlib.rthread:364)setraw
[flowgraph] (rpython.rlib.rvmprof.cintf:196)leave_code
[flowgraph] (rpython.rlib.rposix:508)close
[flowgraph] (rpython.rlib.rposix:268)SuppressIPH.__init__
[flowgraph] (rpython.rlib.rposix:271)SuppressIPH.__enter__
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)close
[flowgraph] (rpython.rlib.rposix:274)SuppressIPH.__exit__
[flowgraph] (rpython.rtyper.lltypesystem.rffi:2)ccall_close
[flowgraph] (rpython.rlib.rposix:151)_errno_before
[flowgraph] (rpython.rlib.rposix:170)_errno_after
[flowgraph] (rpython.rlib.rposix:430)handle_posix_error
[flowgraph] (rpython.flowspace.specialcase:76)rpython_print_item
[flowgraph] (rpython.translator.c.test.test_genc:39)llrepr_out
[flowgraph] (rpython.flowspace.specialcase:95)rpython_print_newline
[flowgraph] (rpython.flowspace.specialcase:85)rpython_print_end
[flowgraph] (rpython.rlib.rposix:500)write
[flowgraph] (rpython.rtyper.lltypesystem.rffi:1427)scoped_nonmovingbuffer.__init__
[flowgraph] (rpython.rtyper.lltypesystem.rffi:1431)scoped_nonmovingbuffer.__enter__
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)write
[flowgraph] (rpython.rtyper.lltypesystem.rffi:1433)scoped_nonmovingbuffer.__exit__
[flowgraph] (rpython.rtyper.lltypesystem.rffi:3)ccall_write
[flowgraph] (rpython.rlib.rposix:151)_errno_before
[flowgraph] (rpython.rlib.rposix:170)_errno_after
[flowgraph] (rpython.rlib.rposix:430)handle_posix_error
[flowgraph] (?:1)memo__get_vmprof_0
[flowgraph] (?:1)memo_offsetof_0
[flowgraph] (?:1)memo_itemoffsetof_0
[flowgraph] (?:1)memo__sizeof_none_0
[flowgraph] (?:1)memo__isfunctype_0
[flowgraph] (?:1)memo_itemoffsetof_0
[flowgraph] (?:1)memo__should_widen_type_0
[flowgraph] (?:1)memo__isfunctype_0
[flowgraph] (?:1)memo__isfunctype_0
[flowgraph] (?:1)memo__isfunctype_0
[c583f8a7ed78480] translation-task}
[translation:info] usession directory: /tmp/buildbot-arm64/usession-main-6799
[translation:info] already done: Annotating&simplifying
[translation:info] RTyping...
[c583f8a7ed9a500] {translation-task
starting rtype_lltype
[flowgraph] (rpython.rtyper.rclass:1170)ll_runtime_type_info
[flowgraph] (rpython.rtyper.rlist:688)ll_getitem_nonneg
[flowgraph] (rpython.rtyper.rlist:717)ll_getitem_fast
[flowgraph] (rpython.rtyper.lltypesystem.rlist:372)ll_getitem_fast
[flowgraph] (rpython.rtyper.lltypesystem.rlist:369)ll_items
[flowgraph] (rpython.rtyper.lltypesystem.rstr:1058)ll_int
[flowgraph] (rpython.rtyper.lltypesystem.rstr:601)ll_streq
[flowgraph] (rpython.rtyper.rstr:425)ll_str
[flowgraph] (?:1)memo_ll_constant_0
[flowgraph] (rpython.rtyper.rlist:633)ll_pop_default
[flowgraph] (rpython.rtyper.lltypesystem.rlist:365)ll_length
[flowgraph] (rpython.rtyper.lltypesystem.rlist:372)ll_getitem_fast
[flowgraph] (rpython.rtyper.lltypesystem.rlist:369)ll_items
[flowgraph] (rpython.rtyper.rlist:539)ll_null_item
[flowgraph] (rpython.rtyper.lltypesystem.rlist:295)_ll_list_resize_le
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rlib.jit:1300)conditional_call
[flowgraph] (?:11)_ll_list_resize_hint_really_look_inside_iff
[flowgraph] (rpython.rtyper.lltypesystem.rlist:198)<lambda>
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rtyper.lltypesystem.rlist:198)_ll_list_resize_hint_really
[flowgraph] (rpython.rtyper.lltypesystem.rlist:351)_ll_new_empty_item_array
[flowgraph] (?:2)ll_arraycopy
[flowgraph] (rpython.rlib.rgc:362)ll_arraycopy
[flowgraph] (rpython.rlib.rgc:342)copy_item
[flowgraph] (rpython.rtyper.lltypesystem.llmemory:411)sizeof
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (?:2)_ll_list_resize_hint_really_trampoline
[flowgraph] (rpython.rtyper.lltypesystem.rlist:198)_ll_list_resize_hint_really
[flowgraph] (?:1)memo__ll_prebuilt_empty_array_0
[flowgraph] (?:1)memo__contains_gcptr_0
[flowgraph] (?:1)memo_itemoffsetof_0
[flowgraph] (?:1)memo__sizeof_none_0
[flowgraph] (rpython.rtyper.rlist:580)ll_len_foldable
[flowgraph] (rpython.rtyper.lltypesystem.rlist:395)ll_fixed_length
[flowgraph] (rpython.rtyper.lltypesystem.rrange:70)ll_newrange
[flowgraph] (rpython.rtyper.lltypesystem.rrange:91)ll_rangeiter
[flowgraph] (rpython.rtyper.rrange:172)ll_rangenext_up
[flowgraph] (rpython.rtyper.rlist:688)ll_getitem_nonneg
[flowgraph] (rpython.rtyper.rlist:717)ll_getitem_fast
[flowgraph] (rpython.rtyper.lltypesystem.rlist:402)ll_fixed_getitem_fast
[flowgraph] (rpython.rtyper.rlist:572)ll_len
[flowgraph] (rpython.rtyper.rlist:633)ll_pop_default
[flowgraph] (rpython.rtyper.rrange:128)ll_range2list
[flowgraph] (rpython.rtyper.rrange:56)_ll_rangelen
[flowgraph] (rpython.rtyper.lltypesystem.rlist:384)ll_fixed_newlist
[flowgraph] (rpython.rtyper.lltypesystem.rlist:407)ll_fixed_setitem_fast
[flowgraph] (rpython.rtyper.rlist:782)ll_extend
[flowgraph] (rpython.rtyper.lltypesystem.rlist:395)ll_fixed_length
[flowgraph] (rpython.rtyper.lltypesystem.rlist:280)_ll_list_resize_ge
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rlib.jit:1300)conditional_call
[flowgraph] (rpython.rtyper.rlist:552)ll_arraycopy
[flowgraph] (rpython.rtyper.lltypesystem.rlist:399)ll_fixed_items
[flowgraph] (rpython.rtyper.rlist:487)ll_alloc_and_set
[flowgraph] (rpython.rlib.rarithmetic:741)int_force_ge_zero
[flowgraph] (rpython.rtyper.rlist:504)_ll_alloc_and_set_jit
[flowgraph] (rpython.rtyper.rlist:472)_ll_zero_or_null
[flowgraph] (rpython.rtyper.rlist:494)_ll_alloc_and_set_nojit
[flowgraph] (rpython.rtyper.lltypesystem.rlist:384)ll_fixed_newlist
[flowgraph] (rpython.rtyper.rlist:516)_ll_alloc_and_clear
[flowgraph] (rpython.rtyper.lltypesystem.rlist:407)ll_fixed_setitem_fast
[flowgraph] (?:11)_ll_alloc_and_set_nonnull_look_inside_iff
[flowgraph] (rpython.rtyper.rlist:528)<lambda>
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rtyper.rlist:528)_ll_alloc_and_set_nonnull
[flowgraph] (?:2)_ll_alloc_and_set_nonnull_trampoline
[flowgraph] (rpython.rtyper.rlist:528)_ll_alloc_and_set_nonnull
[flowgraph] (?:1)memo__null_of_type_0
[flowgraph] (rpython.rtyper.rlist:600)ll_concat
[flowgraph] (rpython.rtyper.rlist:552)ll_arraycopy
[flowgraph] (rpython.rtyper.lltypesystem.rlist:399)ll_fixed_items
[flowgraph] (?:2)ll_arraycopy
[flowgraph] (rpython.rlib.rgc:362)ll_arraycopy
[flowgraph] (rpython.rlib.rgc:342)copy_item
[flowgraph] (rpython.rtyper.lltypesystem.llmemory:411)sizeof
[flowgraph] (?:1)memo__contains_gcptr_0
[flowgraph] (?:1)memo_itemoffsetof_0
[flowgraph] (?:1)memo__sizeof_none_0
[flowgraph] (rpython.rtyper.rlist:588)ll_append
[flowgraph] (rpython.rtyper.lltypesystem.rlist:377)ll_setitem_fast
[flowgraph] (rpython.rtyper.rstr:996)ll_float
[flowgraph] (rpython.rlib.rfloat:87)rstring_to_float
[flowgraph] (rpython.rlib.rdtoa:54)strtod
[flowgraph] (rpython.rlib.objectmodel:397)revdb_flag_io_disabled
[flowgraph] (rpython.rtyper.lltypesystem.rffi:278)_PyPy_dg_strtod
[flowgraph] (?:1)memo__isfunctype_0
[flowgraph] (?:1)memo__isfunctype_0
[flowgraph] (rpython.rtyper.rlist:726)ll_setitem_nonneg
[flowgraph] (rpython.rtyper.lltypesystem.rstr:350)ll_strlen
[rtyper] specializing: 100 / 868 blocks (11%)
[flowgraph] (?:11)ll_join_strs_look_inside_iff
[flowgraph] (rpython.rtyper.lltypesystem.rstr:785)<lambda>
[flowgraph] (rpython.rlib.jit:294)loop_unrolling_heuristic
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rtyper.lltypesystem.rstr:783)ll_join_strs
[flowgraph] (rpython.rtyper.lltypesystem.llmemory:1037)cast_any_ptr
[flowgraph] (rpython.rtyper.lltypesystem.rstr:78)copy_string_contents
[flowgraph] (rpython.rlib.jit:281)isvirtual
[flowgraph] (?:2)ll_join_strs_trampoline
[flowgraph] (rpython.rtyper.lltypesystem.rstr:783)ll_join_strs
[flowgraph] (rpython.rtyper.lltypesystem.rlist:470)ll_listiter
[flowgraph] (rpython.rtyper.lltypesystem.rlist:476)ll_listnext
[flowgraph] (rpython.rtyper.lltypesystem.rstr:695)ll_count_char
[rtyper] specializing: 200 / 936 blocks (21%)
[flowgraph] (rpython.rtyper.lltypesystem.ll_str:13)ll_int2dec
[flowgraph] (rpython.rtyper.lltypesystem.ll_str:7)ll_unsigned
[rtyper] specializing: 300 / 952 blocks (31%)
[flowgraph] (rpython.rtyper.lltypesystem.rstr:1293)ll_striter
[rtyper] specializing: 400 / 955 blocks (41%)
[flowgraph] (rpython.rtyper.lltypesystem.rstr:1306)ll_strnext
[flowgraph] (rpython.rtyper.rlist:588)ll_append
[flowgraph] (rpython.rtyper.lltypesystem.rlist:365)ll_length
[flowgraph] (rpython.rtyper.lltypesystem.rlist:280)_ll_list_resize_ge
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rlib.jit:1300)conditional_call
[flowgraph] (?:11)_ll_list_resize_hint_really_look_inside_iff
[flowgraph] (rpython.rtyper.lltypesystem.rlist:198)<lambda>
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rtyper.lltypesystem.rlist:198)_ll_list_resize_hint_really
[flowgraph] (rpython.rtyper.lltypesystem.rlist:351)_ll_new_empty_item_array
[flowgraph] (?:2)ll_arraycopy
[flowgraph] (rpython.rlib.rgc:362)ll_arraycopy
[flowgraph] (rpython.rlib.rgc:342)copy_item
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (?:2)_ll_list_resize_hint_really_trampoline
[flowgraph] (rpython.rtyper.lltypesystem.rlist:198)_ll_list_resize_hint_really
[flowgraph] (rpython.rtyper.lltypesystem.rlist:377)ll_setitem_fast
[flowgraph] (rpython.rtyper.lltypesystem.rlist:369)ll_items
[flowgraph] (?:1)memo__ll_prebuilt_empty_array_0
[flowgraph] (?:1)memo__contains_gcptr_0
[flowgraph] (?:1)memo_itemoffsetof_0
[flowgraph] (rpython.rtyper.rint:149)ll_str
[flowgraph] (?:11)ll_join_chars_look_inside_iff
[flowgraph] (rpython.rtyper.lltypesystem.rstr:821)<lambda>
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rtyper.lltypesystem.rstr:820)ll_join_chars
[flowgraph] (rpython.rlib.jit:281)isvirtual
[flowgraph] (?:2)ll_join_chars_trampoline
[flowgraph] (rpython.rtyper.lltypesystem.rstr:820)ll_join_chars
[flowgraph] (?:11)ll_listdelslice_startonly_look_inside_iff
[flowgraph] (rpython.rtyper.rlist:912)<lambda>
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rtyper.rlist:912)ll_listdelslice_startonly
[flowgraph] (rpython.rtyper.rlist:539)ll_null_item
[flowgraph] (rpython.rlib.jit:281)isvirtual
[flowgraph] (rpython.rtyper.lltypesystem.rlist:295)_ll_list_resize_le
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (?:2)ll_listdelslice_startonly_trampoline
[flowgraph] (rpython.rtyper.rlist:912)ll_listdelslice_startonly
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rlib.jit:1300)conditional_call
[rtyper] specializing: 500 / 1106 blocks (45%)
[rtyper] specializing: 600 / 1106 blocks (54%)
[flowgraph] (rpython.rtyper.rint:398)ll_int_py_div
[rtyper] specializing: 700 / 1111 blocks (63%)
[rtyper] specializing: 800 / 1111 blocks (72%)
[flowgraph] (rpython.rtyper.lltypesystem.rstr:354)ll_stritem_nonneg
[flowgraph] (rpython.rtyper.lltypesystem.rstr:860)ll_stringslice_startstop
[flowgraph] (rpython.rtyper.lltypesystem.rstr:840)_ll_stringslice
[flowgraph] (?:1)memo_emptystrfun_0
[rtyper] specializing: 900 / 1130 blocks (79%)
[flowgraph] (rpython.rtyper.rint:434)ll_uint_py_div
[flowgraph] (rpython.rtyper.rint:525)ll_uint_py_mod
[rtyper] specializing: 1000 / 1134 blocks (88%)
[rtyper] specializing: 1100 / 1134 blocks (97%)
[rtyper] -=- specialized 1134 blocks -=-
[flowgraph] (rpython.rtyper.rclass:1133)ll_issubclass
[flowgraph] (rpython.rtyper.rclass:1130)ll_type
[rtyper] -=- specialized 4 more blocks -=-
[c583f8a9c67cd00] translation-task}
[translation:info] usession directory: /tmp/buildbot-arm64/usession-main-6799
[translation:info] already done: Annotating&simplifying
[translation:info] already done: RTyping
[translation:info] lltype back-end optimisations...
[c583f8a9c696d00] {translation-task
starting backendopt_lltype
[backendopt:removecasts] removed 1 cast_pointers in _get_raw_buf__rpy_string
[backendopt:removecasts] removed 3 cast_pointers in handle_posix_error__open
[backendopt:removecasts] removed 6 cast_pointers in VMProf.enable
[backendopt:removecasts] removed 1 cast_pointers in charpsize2str
[backendopt:removecasts] removed 3 cast_pointers in VMProf._write_code_registration
[backendopt:removecasts] removed 1 cast_pointers in copy_raw_to_string
[backendopt:removecasts] removed 1 cast_pointers in strerror
[backendopt:removecasts] removed 2 cast_pointers in main_rvmprof__star_3
[backendopt:removecasts] removed 4 cast_pointers in VMProf.disable
[backendopt:removecasts] removed 3 cast_pointers in handle_posix_error__close
[backendopt:removecasts] removed 3 cast_pointers in handle_posix_error__write
[backendopt:removecasts] removed 4 cast_pointers in ll_int__rpy_stringPtr_Signed
[backendopt:removecasts] removed 1 cast_pointers in ll_pop_default__dum_checkidxConst_listPtr
[backendopt:removecasts] removed 1 cast_pointers in ll_rangenext_up__rangePtr_Signed
[backendopt:removecasts] removed 1 cast_pointers in ll_range2list__GcArray_SignedLlT_Signed_Signed_Signed
[backendopt:removecasts] removed 1 cast_pointers in ll_extend__listPtr_arrayPtr
[backendopt:removecasts] removed 1 cast_pointers in int_force_ge_zero__Signed
[backendopt:removecasts] removed 1 cast_pointers in ll_concat__GcArray_Ptr_GCREF__gcopaque_Ll_arrayPtr_arrayPtr
[backendopt:removecasts] removed 3 cast_pointers in ll_float__rpy_stringPtr
[backendopt:removecasts] removed 2 cast_pointers in strtod__SomeString
[backendopt:removecasts] removed 1 cast_pointers in ll_join_strs__v2268___simple_call__function_
[backendopt:removecasts] removed 1 cast_pointers in copy_string_contents__rpy_stringPtr_rpy_stringPtr_Signed_Signed_Signed
[backendopt:removecasts] removed 1 cast_pointers in ll_join_strs__v2271___simple_call__function_
[backendopt:removecasts] removed 1 cast_pointers in ll_listnext__listiterPtr
[backendopt:removecasts] removed 1 cast_pointers in ll_strnext__stringiterPtr
[backendopt:removecasts] removed 1 cast_pointers in _ll_stringslice__rpy_stringPtr_Signed_Signed
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
[backendopt:inlining] 0.00 scoped_nonmovingbuffer.__init__
[backendopt:inlining] 0.00 scoped_nonmovingbuffer.__enter__
[backendopt:inlining] 0.00 write__Signed_arrayPtr_Signed_star_3
[backendopt:inlining] 0.00 ll_getitem_nonneg__dum_nocheckConst_ll_getitem_fastConst_listPtr_Signed
[backendopt:inlining] 0.00 isconstant__v2253___simple_call__function_
[backendopt:inlining] 0.00 widen__int
[backendopt:inlining] 0.00 ll_getitem_fast__listPtr_Signed
[backendopt:inlining] 0.00 memo__sizeof_none_0
[backendopt:inlining] 0.00 __exit____star_3
[backendopt:inlining] 0.00 memo_ll_constant_0
[backendopt:inlining] 0.00 ll_getitem_nonneg__dum_nocheckConst_ll_getitem_fastConst_arrayPtr_Signed
[backendopt:inlining] 0.00 gc_thread_run
[backendopt:inlining] 0.00 get_nonmovingbuffer_ll_final_null
[backendopt:inlining] 0.00 get_nonmovingbuffer_ll
[backendopt:inlining] 0.00 _get_raw_buf__rpy_string
[backendopt:inlining] 0.00 get_nonmovingbuffer_ll_final_null
[backendopt:inlining] 0.00 copy_string_contents__rpy_stringPtr_rpy_stringPtr_Signed_Signed_Signed
[backendopt:inlining] 0.00 memo__sizeof_none_0
[backendopt:inlining] 0.00 conditional_call__v2259___simple_call__function__star_3
[backendopt:inlining] 0.00 isconstant__v2258___simple_call__function_
[backendopt:inlining] 0.00 memo__ll_prebuilt_empty_array_0
[backendopt:inlining] 0.00 vmprof_disable___star_0
[backendopt:inlining] 0.00 memo_emptystrfun_0
[backendopt:inlining] 0.00 copy_string_to_raw
[backendopt:inlining] 0.00 get_nonmovingbuffer_ll_final_null
[backendopt:inlining] 0.00 close__Signed_star_1
[backendopt:inlining] 0.00 isconstant__v2251___simple_call__function_
[backendopt:inlining] 0.00 vmprof_register_virtual_function__SomeString_Signed_Signed_star_3
[backendopt:inlining] 0.00 vmprof_enable__Signed_Signed_Signed_star_3
[backendopt:inlining] 0.00 isconstant__v2261___simple_call__function_
[backendopt:inlining] 0.00 conditional_call__v2298___simple_call__function__star_3
[backendopt:inlining] 0.00 strerror__Signed_star_1
[backendopt:inlining] 0.00 memo__ll_prebuilt_empty_array_0
[backendopt:inlining] 0.00 open__SomeString_Signed_Signed_star_3
[backendopt:inlining] 0.00 memo__sizeof_none_0
[backendopt:inlining] 0.00 copy_raw_to_string
[backendopt:inlining] 0.00 isconstant__v2246___simple_call__function_
[backendopt:inlining] 0.00 conditional_call__v2248___simple_call__function__star_3
[backendopt:inlining] 0.00 vmprof_init__Signed_Float_Signed_Signed_SomeString_Signed_Signed_star_7
[backendopt:inlining] 0.00 cast_any_ptr__Ptr_GcStruct_rpy_stringLlT_rpy_stringPtr
[backendopt:inlining] 0.00 _lambda_
[backendopt:inlining] 0.00 ll_getitem_fast__arrayPtr_Signed
[backendopt:inlining] 0.00 isconstant__v2247___simple_call__function_
[backendopt:inlining] 0.00 _as_bytes__str
[backendopt:inlining] 0.00 ll_fixed_items__arrayPtr
[backendopt:inlining] 0.00 ll_fixed_items__arrayPtr
[backendopt:inlining] 0.00 isconstant__v2257___simple_call__function_
[backendopt:inlining] 0.00 _PyPy_dg_strtod__arrayPtr_arrayPtr_star_2
[backendopt:inlining] 0.00 ll_setitem_nonneg__dum_nocheckConst_arrayPtr_Signed_GCREFPtr
[backendopt:inlining] 0.00 isconstant__v2267___simple_call__function_
[backendopt:inlining] 0.00 isconstant__v2290___simple_call__function_
[backendopt:inlining] 0.00 isvirtual__v2269___simple_call__function_
[backendopt:inlining] 0.00 isvirtual__v2286___simple_call__function_
[backendopt:inlining] 0.00 isconstant__v2280___simple_call__function_
[backendopt:inlining] 0.00 isconstant__v2294___simple_call__function_
[backendopt:inlining] 0.00 isconstant__v2297___simple_call__function_
[backendopt:inlining] 0.00 isconstant__v2284___simple_call__function_
[backendopt:inlining] 0.00 isconstant__v2273___simple_call__function_
[backendopt:inlining] 0.00 isconstant__v2274___simple_call__function_
[backendopt:inlining] 0.00 conditional_call__v2275___simple_call__function__star_3
[backendopt:inlining] 0.00 isconstant__v2278___simple_call__function_
[backendopt:inlining] 0.00 isvirtual__v2292___simple_call__function_
[backendopt:inlining] 2.00 ll_strlen__rpy_stringPtr
[backendopt:inlining] 0.00 get_nonmovingbuffer_ll_final_null
[backendopt:inlining] 2.00 getraw
[backendopt:inlining] 2.00 ll_length__listPtr
[backendopt:inlining] 2.00 setraw
[backendopt:inlining] 2.00 setraw
[backendopt:inlining] 2.00 ll_fixed_newlist__GcArray_Ptr_GCREF__gcopaque_Ll_Signed
[backendopt:inlining] 2.00 getraw
[backendopt:inlining] 2.00 ll_length__listPtr
[backendopt:inlining] 2.00 ll_items__listPtr
[backendopt:inlining] 2.00 ll_fixed_length__arrayPtr
[backendopt:inlining] 2.00 VMProfError.__init__
[backendopt:inlining] 2.00 setraw
[backendopt:inlining] 2.00 ll_items__listPtr
[backendopt:inlining] 2.00 ll_fixed_newlist__GcArray_SignedLlT_Signed
[backendopt:inlining] 2.00 ll_fixed_length__arrayPtr
[backendopt:inlining] 2.00 ll_items__listPtr
[backendopt:inlining] 2.00 get_or_make_raw
[backendopt:inlining] 2.00 ll_unsigned__Signed
[backendopt:inlining] 2.00 ll_uint_py_div__Unsigned_Unsigned
[backendopt:inlining] 2.00 ll_uint_py_mod__Unsigned_Unsigned
[backendopt:inlining] 2.00 MyCode.__init__
[backendopt:inlining] 2.00 WeakCodeObjectList.get_all_handles
[backendopt:inlining] 4.00 ll_fixed_setitem_fast__arrayPtr_Signed_GCREFPtr
[backendopt:inlining] 4.00 _ll_zero_or_null__GCREFPtr
[backendopt:inlining] 4.00 ll_fixed_getitem_fast__arrayPtr_Signed
[backendopt:inlining] 4.00 ll_fixed_setitem_fast__arrayPtr_Signed_Signed
[backendopt:inlining] 4.00 copy_item__arrayPtr_arrayPtr_Signed_Signed
[backendopt:inlining] 4.00 copy_item__arrayPtr_arrayPtr_Signed_Signed
[backendopt:inlining] 4.00 getintfield__timevalPtr_c_tv_usec
[backendopt:inlining] 4.00 getintfield__timevalPtr_c_tv_sec
[backendopt:inlining] 4.00 ll_stritem_nonneg__rpy_stringPtr_Signed
[backendopt:inlining] 4.00 copy_item__arrayPtr_arrayPtr_Signed_Signed
[backendopt:inlining] 5.00 release
[backendopt:inlining] 6.00 _str_ofs__rpy_string
[backendopt:inlining] 0.00 get_nonmovingbuffer_ll_final_null
[backendopt:inlining] 7.00 mallocstr
[backendopt:inlining] 4.00 get_saved_errno
[backendopt:inlining] 7.00 llrepr_out__int
[backendopt:inlining] 7.00 rpython_print_newline
[backendopt:inlining] 2.00 ll_len_foldable__arrayPtr
[backendopt:inlining] 7.00 ll_str__IntegerR_SignedConst_Signed
[backendopt:inlining] 7.00 rstring_to_float__SomeString
[backendopt:inlining] 0.00 _as_bytes0__str
[backendopt:inlining] 7.00 disable
[backendopt:inlining] 2.00 ll_len__listPtr
[backendopt:inlining] 7.00 ll_listdelslice_startonly_look_inside_iff__listPtr_Signed
[backendopt:inlining] 7.50 int_force_ge_zero__Signed
[backendopt:inlining] 7.50 mallocstr
[backendopt:inlining] 8.00 ll_newrange__Ptr_GcStruct_rangeLlT_Signed_Signed
[backendopt:inlining] 8.00 ll_listiter__Ptr_GcStruct_listiterLlT_arrayPtr
[backendopt:inlining] 9.00 ll_join_strs_look_inside_iff__Signed_arrayPtr_Ptr_GcStruct_rpy_stringLlT
[backendopt:inlining] 9.00 _ll_list_resize_hint_really_look_inside_iff__listPtr_Signed_Bool
[backendopt:inlining] 9.00 _ll_list_resize_hint_really_look_inside_iff__listPtr_Signed_Bool
[backendopt:inlining] 9.00 _ll_alloc_and_set_nonnull_look_inside_iff__GcArray_Ptr_GCREF__gcopaque_Ll_Signed_GCREFPtr
[backendopt:inlining] 9.00 ll_join_chars_look_inside_iff__Signed_arrayPtr_Ptr_GcStruct_rpy_stringLlT
[backendopt:inlining] 9.00 register_code__rpython_rlib_rvmprof_test_test_rvmprof_MyCode
[backendopt:inlining] 4.00 ll_str__StringR_Ptr_GcStruct_rpy_strin_rpy_stringPtr
[backendopt:inlining] 7.00 acquire
[backendopt:inlining] 6.00 ll_getitem_fast__listPtr_Signed
[backendopt:inlining] 11.00 ll_arraycopy__arrayPtr_arrayPtr_Signed_Signed_Signed
[backendopt:inlining] 6.00 ll_getitem_fast__listPtr_Signed
[backendopt:inlining] 11.00 ll_arraycopy__arrayPtr_arrayPtr_Signed_Signed_Signed
[backendopt:inlining] 11.00 ll_arraycopy__arrayPtr_arrayPtr_Signed_Signed_Signed
[backendopt:inlining] 6.00 ll_setitem_fast__listPtr_Signed_Signed
[backendopt:inlining] 11.00 enable
[backendopt:inlining] 6.00 leave_code
[backendopt:inlining] 6.00 ll_setitem_fast__listPtr_Signed_Char
[backendopt:inlining] 12.00 ll_rangeiter__Ptr_GcStruct_rangeLlT_rangePtr
[backendopt:inlining] 12.00 ll_striter__rpy_stringPtr
[backendopt:inlining] 12.50 ll_rangenext_up__rangePtr_Signed
[backendopt:inlining] 13.00 free_nonmovingbuffer_ll
[backendopt:inlining] 9.00 ll_listdelslice_startonly__v2291___simple_call__function_
[backendopt:inlining] 9.00 ll_listdelslice_startonly__v2296___simple_call__function_
[backendopt:inlining] 15.00 ll_int_py_div__Signed_Signed
[backendopt:inlining] 15.50 ll_strnext__stringiterPtr
[backendopt:inlining] 14.25 ll_alloc_and_set__GcArray_Ptr_GCREF__gcopaque_Ll_Signed_GCREFPtr
[backendopt:inlining] 16.00 WeakCodeObjectList.add_handle
[backendopt:inlining] 4.00 loop_unrolling_heuristic__v2266___simple_call__function_
[backendopt:inlining] 18.12 ll_stringslice_startstop__rpy_stringPtr_Signed_Signed
[backendopt:inlining] 21.00 ccall_close
[backendopt:inlining] 0.00 close__Signed_star_1
[backendopt:inlining] 16.00 WeakCodeObjectList.store_handle
[backendopt:inlining] 21.65 ll_streq__rpy_stringPtr_rpy_stringPtr
[backendopt:inlining] 21.75 close
[backendopt:inlining] 16.00 decode_timeval
[backendopt:inlining] 17.00 ll_pop_default__dum_nocheckConst_listPtr
[backendopt:inlining] 23.33 charp2str
[backendopt:inlining] 18.75 ll_pop_default__dum_checkidxConst_listPtr
[backendopt:inlining] 17.50 ll_listnext__listiterPtr
[backendopt:inlining] 17.00 ll_append__listPtr_Char
[backendopt:inlining] 17.00 ll_append__listPtr_Signed
[backendopt:inlining] 13.00 ll_arraycopy__arrayPtr_listPtr_Signed_Signed_Signed
[backendopt:inlining] 11.00 ll_arraycopy__arrayPtr_arrayPtr_Signed_Signed_Signed
[backendopt:inlining] 19.25 _errno_after__v2244___simple_call__function_
[backendopt:inlining] 19.25 _errno_after__v2240___simple_call__function_
[backendopt:inlining] 19.25 _errno_after__v2242___simple_call__function_
[backendopt:inlining] 0.00 close__Signed_star_1
[backendopt:inlining] 19.25 _errno_after__v2236___simple_call__function_
[backendopt:inlining] 19.25 _errno_after__v2238___simple_call__function_
[backendopt:inlining] 26.16 ll_join_chars__v2285___simple_call__function_
[backendopt:inlining] 26.16 ll_join_chars__v2288___simple_call__function_
[backendopt:inlining] 19.00 enter_code
[backendopt:inlining] 17.83 _ll_alloc_and_clear__GcArray_Ptr_GCREF__gcopaque_Ll_Signed
[backendopt:inlining] 27.50 ll_arraycopy__arrayPtr_arrayPtr_Signed_Signed_Signed
[backendopt:inlining] 27.50 ll_arraycopy__arrayPtr_arrayPtr_Signed_Signed_Signed
[backendopt:inlining] 31.66 ll_count_char__rpy_stringPtr_Char_Signed_Signed
[backendopt:inlining] 20.67 _ll_alloc_and_set_nonnull__v2262___simple_call__function_
[backendopt:inlining] 20.67 _ll_alloc_and_set_nonnull__v2264___simple_call__function_
[backendopt:inlining] 25.75 _ll_alloc_and_set_nojit__GcArray_Ptr_GCREF__gcopaque_Ll_Signed_GCREFPtr
[backendopt:inlining] 27.50 ll_concat__GcArray_Ptr_GCREF__gcopaque_Ll_arrayPtr_arrayPtr
[backendopt:inlining] 27.75 ll_range2list__GcArray_SignedLlT_Signed_Signed_Signed
[backendopt:inlining] 31.75 handle_posix_error__close
[backendopt:inlining] 31.75 handle_posix_error__write
[backendopt:inlining] 31.75 handle_posix_error__open
[backendopt:inlining] 31.87 _errno_before__v2241___simple_call__function_
[backendopt:inlining] 0.00 close__Signed_star_1
[backendopt:inlining] 31.87 _errno_before__v2243___simple_call__function_
[backendopt:inlining] 31.87 _errno_before__v2239___simple_call__function_
[backendopt:inlining] 31.87 _errno_before__v2235___simple_call__function_
[backendopt:inlining] 31.87 _errno_before__v2237___simple_call__function_
[backendopt:inlining] inlined 383 callsites.
[backendopt:removecasts] removed 2 cast_pointers in time
[backendopt:removecasts] removed 2 cast_pointers in strtod__SomeString
[backendopt:malloc] starting malloc removal
[backendopt:malloc] 9 simple mallocs removed in 'entry_point'
[backendopt:malloc] 1 simple mallocs removed in 'RVMProfSamplingTest.entry_point'
[backendopt:malloc] 2 simple mallocs removed in 'WeakCodeObjectList.reserve_next_handle_index'
[backendopt:malloc] 10 simple mallocs removed in 'open__str'
[backendopt:malloc] 10 simple mallocs removed in 'open__SomeString_Signed_Signed_star_3'
[backendopt:malloc] 24 simple mallocs removed in 'VMProf.enable'
[backendopt:malloc] 17 simple mallocs removed in 'vmprof_init__Signed_Float_Signed_Signed_SomeString_Signed_Signed_star_7'
[backendopt:malloc] 1 simple mallocs removed in 'gather_all_code_objs'
[backendopt:malloc] 10 simple mallocs removed in 'VMProf._write_code_registration'
[backendopt:malloc] 10 simple mallocs removed in 'vmprof_register_virtual_function__SomeString_Signed_Signed_star_3'
[backendopt:malloc] 7 simple mallocs removed in 'vmprof_enable__Signed_Signed_Signed_star_3'
[backendopt:malloc] 3 simple mallocs removed in 'strerror'
[backendopt:malloc] 3 simple mallocs removed in 'strerror__Signed_star_1'
[backendopt:malloc] 1 simple mallocs removed in 'main_rvmprof__star_3'
[backendopt:malloc] 1 simple mallocs removed in 'decorated_jitted_function__star_3'
[backendopt:malloc] 2 simple mallocs removed in 'main'
[backendopt:malloc] 1 simple mallocs removed in 'close'
[backendopt:malloc] 3 simple mallocs removed in 'close__Signed_star_1'
[backendopt:malloc] 1 simple mallocs removed in 'rpython_print_item'
[backendopt:malloc] 1 simple mallocs removed in 'rpython_print_end'
[backendopt:malloc] 3 simple mallocs removed in 'write'
[backendopt:malloc] 2 simple mallocs removed in 'scoped_nonmovingbuffer.__init__'
[backendopt:malloc] 7 simple mallocs removed in 'write__Signed_arrayPtr_Signed_star_3'
[backendopt:malloc] 1 simple mallocs removed in '_ll_list_resize_le__listPtr_Signed'
[backendopt:malloc] 1 simple mallocs removed in 'conditional_call__v2248___simple_call__function__star_3'
[backendopt:malloc] 1 simple mallocs removed in '_ll_list_resize_ge__listPtr_Signed'
[backendopt:malloc] 1 simple mallocs removed in 'conditional_call__v2259___simple_call__function__star_3'
[backendopt:malloc] 1 simple mallocs removed in 'strtod__SomeString'
[backendopt:malloc] 5 simple mallocs removed in '_PyPy_dg_strtod__arrayPtr_arrayPtr_star_2'
[backendopt:malloc] 1 simple mallocs removed in '_ll_list_resize_ge__listPtr_Signed'
[backendopt:malloc] 1 simple mallocs removed in 'conditional_call__v2275___simple_call__function__star_3'
[backendopt:malloc] 1 simple mallocs removed in '_ll_list_resize_le__listPtr_Signed'
[backendopt:malloc] 1 simple mallocs removed in 'conditional_call__v2298___simple_call__function__star_3'
[backendopt:malloc] removed 143 simple mallocs in total
[backendopt:removecasts] removed 5 cast_pointers in main_rvmprof__star_3
[backendopt:removecasts] removed 4 cast_pointers in decorated_jitted_function__star_3
[backendopt:mergeifblocks] starting to merge if blocks
[c583f8ab0665280] translation-task}
[translation:info] usession directory: /tmp/buildbot-arm64/usession-main-6799
[translation:info] already done: Annotating&simplifying
[translation:info] already done: RTyping
[translation:info] already done: lltype back-end optimisations
[translation:info] inserting stack checks...
[c583f8ab069ea80] {translation-task
starting stackcheckinsertion_lltype
[flowgraph] (rpython.rlib.rstack:42)stack_check
[flowgraph] (rpython.rlib.rstack:67)stack_check_slowpath
[rtyper] -=- specialized 8 more blocks -=-
[translation:info] inserted 0 stack checks.
[c583f8ab0f65400] translation-task}
[translation:info] Creating database for generating c source...
[c583f8ab0f76580] {translation-task
starting database_c
[flowgraph] (rpython.translator.exceptiontransform:100)rpyexc_occurred
[flowgraph] (rpython.translator.exceptiontransform:104)rpyexc_fetch_type
[flowgraph] (rpython.translator.exceptiontransform:107)rpyexc_fetch_value
[flowgraph] (rpython.translator.exceptiontransform:110)rpyexc_clear
[flowgraph] (rpython.translator.exceptiontransform:114)rpyexc_raise
[flowgraph] (rpython.translator.exceptiontransform:128)rpyexc_reraise
[flowgraph] (rpython.translator.exceptiontransform:133)rpyexc_fetch_exception
[flowgraph] (rpython.translator.exceptiontransform:138)rpyexc_restore_exception
[flowgraph] (rpython.translator.exceptiontransform:539)rpyexc_get_exception_addr
[flowgraph] (rpython.translator.exceptiontransform:543)rpyexc_get_exc_value_addr
[flowgraph] (rpython.rtyper.rclass:1173)ll_inst_type
[rtyper] -=- specialized 25 more blocks -=-
[flowgraph] (rpython.memory.gctransform.transform:447)_ll_malloc_fixedsize
[flowgraph] (rpython.memory.gctransform.transform:454)_ll_malloc_fixedsize_zero
[flowgraph] (rpython.memory.gctransform.transform:470)_ll_malloc_varsize_no_length
[flowgraph] (rpython.memory.gctransform.transform:487)ll_malloc_varsize
[flowgraph] (rpython.memory.gctransform.transform:493)_ll_malloc_varsize_no_length_zero
[flowgraph] (rpython.memory.gctransform.transform:447)_ll_malloc_fixedsize
[flowgraph] (rpython.memory.gctransform.transform:447)_ll_malloc_fixedsize
[flowgraph] (rpython.memory.gctransform.transform:470)_ll_malloc_varsize_no_length
[flowgraph] (rpython.memory.gctransform.transform:487)ll_malloc_varsize
[flowgraph] (rpython.memory.gctransform.boehm:58)ll_identityhash
[flowgraph] (rpython.memory.gctransform.transform:461)_ll_compute_size
[flowgraph] (rpython.memory.gctransform.boehm:20)<lambda>
[flowgraph] (rpython.memory.gctransform.boehm:24)<lambda>
[flowgraph] (rpython.memory.gctransform.transform:461)_ll_compute_size
[rtyper] specializing: 1200 / 1228 blocks (97%)
[rtyper] -=- specialized 57 more blocks -=-
[backendopt:removecasts] removed 1 cast_pointers in _ll_malloc_fixedsize__Signed
[backendopt:removecasts] removed 1 cast_pointers in _ll_malloc_fixedsize_zero__Signed
[backendopt:removecasts] removed 1 cast_pointers in _ll_malloc_varsize_no_length__Signed_Signed_Signed
[backendopt:removecasts] removed 1 cast_pointers in _ll_malloc_varsize_no_length_zero__Signed_Signed_Signed
[backendopt:removecasts] removed 1 cast_pointers in _ll_malloc_fixedsize__Signed
[backendopt:removecasts] removed 1 cast_pointers in _ll_malloc_fixedsize__Signed
[backendopt:removecasts] removed 1 cast_pointers in _ll_malloc_varsize_no_length__Signed_Signed_Signed
[backendopt:removecasts] removed 1 cast_pointers in _ll_compute_size__Signed_Signed_Signed
[backendopt:removecasts] removed 1 cast_pointers in _ll_compute_size__Signed_Signed_Signed
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
[backendopt:inlining] 0.00 _ll_compute_size__Signed_Signed_Signed
[backendopt:inlining] 0.00 _ll_compute_size__Signed_Signed_Signed
[backendopt:inlining] 2.00 _lambda_
[backendopt:inlining] 2.00 _lambda_
[backendopt:inlining] 16.50 _ll_malloc_varsize_no_length__Signed_Signed_Signed
[backendopt:inlining] 16.50 _ll_malloc_varsize_no_length__Signed_Signed_Signed
[backendopt:inlining] inlined 8 callsites.
[backendopt:malloc] starting malloc removal
[backendopt:malloc] removed 0 simple mallocs in total
[backendopt:mergeifblocks] starting to merge if blocks
[flowgraph] (rpython.translator.c.genc:261)entrypoint_wrapper
[flowgraph] (rpython.rtyper.rlist:487)ll_alloc_and_set
[flowgraph] (rpython.rtyper.rlist:504)_ll_alloc_and_set_jit
[flowgraph] (rpython.rtyper.rlist:516)_ll_alloc_and_clear
[flowgraph] (rpython.rtyper.lltypesystem.rlist:324)ll_newlist
[flowgraph] (?:11)_ll_alloc_and_set_nonnull_look_inside_iff
[flowgraph] (rpython.rtyper.rlist:528)<lambda>
[flowgraph] (rpython.rlib.jit:269)isconstant
[flowgraph] (rpython.rtyper.rlist:528)_ll_alloc_and_set_nonnull
[flowgraph] (rpython.rtyper.lltypesystem.rlist:377)ll_setitem_fast
[flowgraph] (rpython.rtyper.rlist:494)_ll_alloc_and_set_nojit
[flowgraph] (?:2)_ll_alloc_and_set_nonnull_trampoline
[flowgraph] (rpython.rtyper.rlist:528)_ll_alloc_and_set_nonnull
[flowgraph] (rpython.rtyper.rlist:726)ll_setitem_nonneg
[rtyper] -=- specialized 50 more blocks -=-
[rtyper] -=- specialized 0 more blocks -=-
[rtyper] -=- specialized 0 more blocks -=-
[backendopt:inlining] phase with threshold factor: 32.4
[backendopt:inlining] heuristic: rpython.translator.backendopt.inline.inlining_heuristic
[backendopt:inlining] inlined 0 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
[c:database] Inlining GC helpers and postprocessing
[c] 387 nodes [ array: 49 boehm rtti: 22 func: 91 struct: 225 ]
[c:database] Completed
[translation:info] database for generating C source was created
[c583f8abb5e6600] translation-task}
[translation:info] Generating c source...
[c583f8abb5efa00] {translation-task
starting source_c
[c:writing] structdef.h
[c:writing] forwarddecl.h
[c:writing] preimpl.h
[c:writing] data_rpython_flowspace.c
[c:writing] data_rpython_memory_gctransform.c
[c:writing] data_rpython_rlib.c
[c:writing] data_rpython_rlib_rvmprof.c
[c:writing] data_rpython_rlib_rvmprof_test.c
[c:writing] data_rpython_rtyper_lltypesystem.c
[c:writing] data_rpython_translator_c.c
[c:writing] data_rpython_translator_c_test.c
[c:writing] nonfuncnodes.c
[c:writing] data_rpython_rlib_1.c
[c:writing] data_rpython_rlib_rvmprof_1.c
[c:writing] data_rpython_rtyper_lltypesystem_1.c
[c:writing] implement.c
[c:writing] rpython_flowspace.c
[c:writing] rpython_memory_gctransform.c
[c:writing] rpython_rlib.c
[c:writing] rpython_rlib_rvmprof.c
[c:writing] rpython_rlib_rvmprof_test.c
[c:writing] rpython_rtyper.c
[c:writing] rpython_rtyper_lltypesystem.c
[c:writing] rpython_translator.c
[c:writing] rpython_translator_c.c
[c:writing] rpython_translator_c_test.c
[translation:info] written: /tmp/buildbot-arm64/usession-main-6799/testing_4/testing_4.c
[c583f8ac15ee780] translation-task}
[translation:info] Compiling c source...
[c583f8ac15f7d80] {translation-task
starting compile_c
[platform:execute] make in /tmp/buildbot-arm64/usession-main-6799/testing_4
[translation:info] created: /tmp/buildbot-arm64/usession-main-6799/testing_4/testing_4
[c583f8b237fc280] translation-task}
[translation:info] usession directory: /tmp/buildbot-arm64/usession-main-6799
---------- Captured stdout call ----------
THE RESULT IS: 99990000 ;
MALLOC COUNTERS: 0 0
---------- Captured stderr call ----------
[c:cmdexec] /tmp/buildbot-arm64/usession-main-6799/testing_4/testing_4 10000 0.5 0
builder: rpython-macos-arm64 build #260
test: rlib/rvmprof/test/test_rvmprof/py/TestEnable/()/test