Profiling results ----------------- Total cpu time observed: 210514ms (out of 211632ms) Number of samples taken: 676 (once every 311ms) (Hiding functions with self<1.0% and local<2.0%: 5 of 207 hidden) ============================================================================ Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================================ ??? [78] 100.0% [1] 210514(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [11] 100.0% ---------------------------------------------------------------------------- ??? [78] 100.0% [2] 178742(84.9%) 0(0.0%) run-improve40 ...ie/develop/src/mainloop.rkt:340:0 for-loop [12] 99.7% prepare-points-intervals [87] 0.3% ---------------------------------------------------------------------------- ??? [152] 100.0% [3] 4368(2.1%) 0(0.0%) approximate9 ...e/develop/src/core/taylor.rkt:12:0 loop [14] 92.5% for-loop [18] 7.5% ---------------------------------------------------------------------------- matcher [72] 100.0% [4] 3660(1.7%) 0(0.0%) ??? .../herbie/develop/src/core/matcher.rkt:175:11 for-loop [16] 100.0% ---------------------------------------------------------------------------- loop [20] 8.8% for-loop [171] 91.2% [5] 3386(1.6%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [15] 100.0% ---------------------------------------------------------------------------- substitute-e [91] 16.7% match-e [80] 83.3% [6] 1792(0.9%) 0(0.0%) variable? .../develop/src/syntax/syntax.rkt:1159:0 ??? [34] 100.0% ---------------------------------------------------------------------------- for-loop [171] 100.0% [7] 1316(0.6%) 334(0.2%) expand-identifier (unknown source) resolve+shift28 [37] 74.6% ---------------------------------------------------------------------------- for-loop [171] 100.0% [8] 1024(0.5%) 334(0.2%) expand-implicit (unknown source) resolve+shift28 [37] 67.4% ---------------------------------------------------------------------------- hash-ref! [160] 100.0% [9] 612(0.3%) 0(0.0%) ??? ...s/herbie/develop/src/core/taylor.rkt:301:23 for-loop [17] 100.0% ---------------------------------------------------------------------------- taylor [23] 100.0% [10] 326(0.2%) 0(0.0%) taylor-quotient ...velop/src/core/taylor.rkt:334:0 simplify [13] 100.0% ---------------------------------------------------------------------------- profile-thunk16 [1] 100.0% [11] 210514(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [78] 100.0% ---------------------------------------------------------------------------- run-improve40 [2] 100.0% [12] 178128(84.6%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:355:4 run-iter! [19] 100.0% ---------------------------------------------------------------------------- taylor-quotient [10] 8.0% hash-ref! [160] 92.0% [13] 4076(1.9%) 0(0.0%) simplify ...erbie/develop/src/core/reduce.rkt:16:0 parse-loop80 [21] 46.4% f46 [22] 37.9% simplify* [74] 8.0% debug5 [24] 7.7% ---------------------------------------------------------------------------- approximate9 [3] 100.0% [14] 4042(1.9%) 0(0.0%) loop ...es/herbie/develop/src/core/taylor.rkt:87:4 ??? [152] 100.0% ---------------------------------------------------------------------------- expand-id-application-form17 [186] 15.9% syntax-e [5] 84.1% [15] 4024(1.9%) 0(0.0%) syntax-e/no-taint (unknown source) loop [20] 100.0% ---------------------------------------------------------------------------- ??? [4] 100.0% [16] 3660(1.7%) 0(0.0%) for-loop ...ie/develop/src/core/matcher.rkt:179:21 matcher [72] 100.0% ---------------------------------------------------------------------------- ??? [9] 100.0% [17] 612(0.3%) 0(0.0%) for-loop ...bie/develop/src/core/taylor.rkt:304:27 hash-ref! [160] 100.0% ---------------------------------------------------------------------------- approximate9 [3] 100.0% [18] 326(0.2%) 0(0.0%) for-loop ...rbie/develop/src/core/taylor.rkt:30:18 taylor [23] 100.0% ---------------------------------------------------------------------------- for-loop [12] 100.0% [19] 178128(84.6%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:321:0 simplify! [25] 82.7% finalize-iter! [26] 12.0% gen-series! [27] 2.5% gen-rewrites! [28] 2.2% localize! [30] 0.6% ---------------------------------------------------------------------------- loop [20] 1.4% gf [119] 2.8% apply-transformer52 [197] 6.1% eval-prog [81] 8.1% for-loop [171] 16.7% loop [120] 17.1% syntax-e/no-taint [15] 47.9% [20] 7430(3.5%) 2178(1.0%) loop (unknown source) gf [119] 47.2% expand-id-application-form17 [186] 12.7% expand-capturing-lifts [145] 8.1% core-form-sym [32] 4.1% syntax-e [5] 2.0% loop [20] 1.4% ---------------------------------------------------------------------------- map [61] 24.0% hash-ref! [160] 26.0% simplify [13] 49.9% [21] 3784(1.8%) 0(0.0%) parse-loop80 ...s/racket/match/compiler.rkt:418:15 eval-const-expr [29] 74.0% loop [118] 21.6% loop [31] 4.4% ---------------------------------------------------------------------------- hash-ref! [160] 17.2% map [61] 28.7% simplify [13] 54.0% [22] 1868(0.9%) 0(0.0%) f46 ...0/collects/racket/match/compiler.rkt:507:40 map [61] 100.0% ---------------------------------------------------------------------------- for-loop [18] 25.0% taylor [23] 75.0% [23] 326(0.2%) 0(0.0%) taylor ...herbie/develop/src/core/taylor.rkt:170:0 taylor [23] 75.0% taylor-quotient [10] 25.0% ---------------------------------------------------------------------------- simplify [13] 100.0% [24] 314(0.1%) 0(0.0%) debug5 ...tlies/herbie/develop/src/debug.rkt:102:0 ??? [34] 100.0% ---------------------------------------------------------------------------- run-iter! [19] 100.0% [25] 147330(70.0%) 0(0.0%) simplify! ...herbie/develop/src/mainloop.rkt:217:0 ??? [33] 100.0% ---------------------------------------------------------------------------- run-iter! [19] 100.0% [26] 21458(10.2%) 0(0.0%) finalize-iter! ...e/develop/src/mainloop.rkt:272:0 ??? [34] 100.0% ---------------------------------------------------------------------------- run-iter! [19] 100.0% [27] 4368(2.1%) 0(0.0%) gen-series! ...rbie/develop/src/mainloop.rkt:153:0 for-loop [35] 100.0% ---------------------------------------------------------------------------- run-iter! [19] 100.0% [28] 3988(1.9%) 0(0.0%) gen-rewrites! ...ie/develop/src/mainloop.rkt:176:0 for-loop [36] 91.8% for-loop [39] 8.2% ---------------------------------------------------------------------------- ??? [78] 25.7% parse-loop80 [21] 74.3% [29] 3768(1.8%) 0(0.0%) eval-const-expr .../develop/src/programs.rkt:149:0 eval-prog [81] 100.0% ---------------------------------------------------------------------------- run-iter! [19] 100.0% [30] 984(0.5%) 0(0.0%) localize! ...herbie/develop/src/mainloop.rkt:120:0 localize-error [38] 100.0% ---------------------------------------------------------------------------- parse-loop80 [21] 10.0% loop [31] 90.0% [31] 330(0.2%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:54:19 loop [31] 90.0% ??? [152] 10.0% ---------------------------------------------------------------------------- loop [20] 100.0% [32] 304(0.1%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [37] 100.0% ---------------------------------------------------------------------------- simplify! [25] 100.0% [33] 147330(70.0%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:29:0 loop [40] 90.2% loop [42] 9.8% ---------------------------------------------------------------------------- debug5 [24] 1.2% substitute-e [91] 2.5% variable? [6] 6.9% match-e [80] 6.9% finalize-iter! [26] 82.5% [34] 26016(12.4%) 4558(2.2%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [41] 82.5% ---------------------------------------------------------------------------- gen-series! [27] 100.0% [35] 4368(2.1%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:160:7 taylor-alt [43] 100.0% ---------------------------------------------------------------------------- gen-rewrites! [28] 100.0% [36] 3660(1.7%) 0(0.0%) for-loop ...herbie/develop/src/mainloop.rkt:184:11 rewrite-expression-head20 [44] 100.0% ---------------------------------------------------------------------------- core-form-sym [32] 10.4% expand-implicit [8] 23.6% expand-id-application-form17 [186] 32.5% expand-identifier [7] 33.6% [37] 2926(1.4%) 684(0.3%) resolve+shift28 (unknown source) fallback-loop [45] 76.6% ---------------------------------------------------------------------------- localize! [30] 100.0% [38] 984(0.5%) 0(0.0%) localize-error ...velop/src/core/localize.rkt:52:0 hash-ref! [160] 100.0% ---------------------------------------------------------------------------- gen-rewrites! [28] 100.0% [39] 328(0.2%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:201:4 for-loop [46] 100.0% ---------------------------------------------------------------------------- ??? [33] 100.0% [40] 132880(63.1%) 0(0.0%) loop .../herbie/develop/src/core/simplify.rkt:44:2 one-iter [47] 50.7% loop [48] 49.3% ---------------------------------------------------------------------------- ??? [34] 100.0% [41] 21458(10.2%) 0(0.0%) for-loop ...ie/develop/src/core/alt-table.rkt:51:2 atab-add-altn [49] 94.3% loop [53] 5.7% ---------------------------------------------------------------------------- ??? [33] 100.0% [42] 14450(6.9%) 302(0.1%) loop ...herbie/develop/src/core/simplify.rkt:132:2 for-loop [50] 97.9% ---------------------------------------------------------------------------- for-loop [35] 100.0% [43] 4368(2.1%) 0(0.0%) taylor-alt ...erbie/develop/src/mainloop.rkt:139:0 for-loop [51] 100.0% ---------------------------------------------------------------------------- for-loop [36] 100.0% [44] 3660(1.7%) 0(0.0%) rewrite-expression-head20 ...ore/matcher.rkt:126:0 rewriter [52] 100.0% ---------------------------------------------------------------------------- resolve+shift28 [37] 100.0% [45] 2242(1.1%) 646(0.3%) fallback-loop (unknown source) for-loop [171] 71.2% ---------------------------------------------------------------------------- for-loop [39] 100.0% [46] 328(0.2%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:202:6 ??? [152] 100.0% ---------------------------------------------------------------------------- loop [40] 100.0% [47] 67332(32.0%) 0(0.0%) one-iter ...ie/develop/src/core/simplify.rkt:100:0 for-loop [54] 84.6% find-matches [56] 15.4% ---------------------------------------------------------------------------- loop [40] 100.0% [48] 65548(31.1%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:74:19 set-precompute! [55] 51.6% update-leader! [97] 48.4% ---------------------------------------------------------------------------- for-loop [41] 100.0% [49] 20242(9.6%) 0(0.0%) atab-add-altn ...elop/src/core/alt-table.rkt:200:0 best-and-tied-at-points [57] 50.3% override-at-pnts [58] 45.0% map [61] 3.2% ---------------------------------------------------------------------------- loop [42] 100.0% [50] 14148(6.7%) 322(0.2%) for-loop ...ie/develop/src/core/simplify.rkt:138:4 argmin [59] 40.9% loop [60] 30.4% expression-cost [70] 17.3% for-loop [63] 4.7% for-loop [71] 4.5% ---------------------------------------------------------------------------- taylor-alt [43] 100.0% [51] 4368(2.1%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:145:6 ??? [152] 100.0% ---------------------------------------------------------------------------- rewrite-expression-head20 [44] 29.0% matcher [72] 71.0% [52] 3660(1.7%) 1332(0.6%) rewriter ...bie/develop/src/core/matcher.rkt:128:2 for-loop [62] 85.9% *rules* [64] 2.0% ---------------------------------------------------------------------------- for-loop [41] 100.0% [53] 1216(0.6%) 624(0.3%) loop ...erbie/develop/src/core/alt-table.rkt:174:2 loop [65] 24.3% map [61] 24.3% ---------------------------------------------------------------------------- one-iter [47] 100.0% [54] 56980(27.1%) 0(0.0%) for-loop ...ie/develop/src/core/simplify.rkt:101:2 apply-match [66] 100.0% ---------------------------------------------------------------------------- loop [48] 100.0% [55] 33852(16.1%) 0(0.0%) set-precompute! ...lop/src/core/simplify.rkt:105:0 for-loop [67] 100.0% ---------------------------------------------------------------------------- one-iter [47] 100.0% [56] 10352(4.9%) 0(0.0%) find-matches ...develop/src/core/simplify.rkt:64:0 for-loop [69] 100.0% ---------------------------------------------------------------------------- atab-add-altn [49] 100.0% [57] 10180(4.8%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:112:0 errors [68] 90.5% for-loop [73] 9.5% ---------------------------------------------------------------------------- atab-add-altn [49] 100.0% [58] 9104(4.3%) 306(0.1%) override-at-pnts ...p/src/core/alt-table.rkt:135:0 errors [68] 96.6% ---------------------------------------------------------------------------- for-loop [50] 100.0% [59] 5790(2.8%) 0(0.0%) argmin ...acket-7.0/collects/racket/list.rkt:765:0 for-loop [71] 53.1% expression-cost [70] 46.9% ---------------------------------------------------------------------------- for-loop [50] 100.0% [60] 4294(2.0%) 0(0.0%) loop .../racket-7.0/collects/racket/list.rkt:751:4 expression-cost [70] 71.5% for-loop [71] 28.5% ---------------------------------------------------------------------------- loop [53] 7.9% loop [118] 8.9% for-loop [104] 16.0% atab-add-altn [49] 17.4% f46 [22] 49.8% [61] 3748(1.8%) 0(0.0%) map ...t-7.0/collects/racket/private/map.rkt:35:13 loop [148] 17.4% parse-loop80 [21] 15.9% loop [118] 15.9% f46 [22] 14.3% simplify* [74] 11.0% ??? [152] 8.9% hash-ref! [160] 8.6% ??? [136] 8.0% ---------------------------------------------------------------------------- rewriter [52] 100.0% [62] 3660(1.7%) 298(0.1%) for-loop ...ie/develop/src/core/matcher.rkt:131:10 matcher [72] 85.1% return/no-unsupplied [174] 9.2% assoc-ref [77] 3.0% ---------------------------------------------------------------------------- for-loop [50] 100.0% [63] 662(0.3%) 0(0.0%) for-loop ...e/develop/src/core/simplify.rkt:142:16 for-loop [75] 100.0% ---------------------------------------------------------------------------- rewriter [52] 100.0% [64] 360(0.2%) 0(0.0%) *rules* ...rbie/develop/src/syntax/rules.rkt:783:0 for-loop [76] 100.0% ---------------------------------------------------------------------------- loop [53] 100.0% [65] 296(0.1%) 296(0.1%) loop ...-7.0/collects/racket/private/hash.rkt:20:4 ---------------------------------------------------------------------------- for-loop [54] 100.0% [66] 56980(27.1%) 0(0.0%) apply-match .../develop/src/core/simplify.rkt:73:0 for-loop [79] 65.9% match-e [80] 14.8% update-leader! [97] 12.2% set [146] 6.0% custom-set-intersect [84] 1.0% ---------------------------------------------------------------------------- set-precompute! [55] 100.0% [67] 33852(16.1%) 302(0.1%) for-loop ...ie/develop/src/core/simplify.rkt:108:2 ??? [78] 99.1% ---------------------------------------------------------------------------- ??? [78] 1.7% override-at-pnts [58] 48.0% best-and-tied-at-points [57] 50.3% [68] 18316(8.7%) 0(0.0%) errors ...lies/herbie/develop/src/points.rkt:223:0 for-loop [82] 51.8% eval-prog [81] 48.2% ---------------------------------------------------------------------------- for-loop [69] 48.4% find-matches [56] 51.6% [69] 10352(4.9%) 2952(1.4%) for-loop ...bie/develop/src/core/simplify.rkt:66:8 for-loop [69] 48.4% match-e [80] 35.7% ---------------------------------------------------------------------------- for-loop [50] 29.7% argmin [59] 33.0% loop [60] 37.3% [70] 8236(3.9%) 596(0.3%) expression-cost .../develop/src/programs.rkt:204:0 compile [83] 92.8% ---------------------------------------------------------------------------- for-loop [50] 12.8% loop [60] 24.8% argmin [59] 62.4% [71] 4928(2.3%) 302(0.1%) for-loop .../herbie/develop/src/programs.rkt:205:2 table-ref [101] 93.9% ---------------------------------------------------------------------------- for-loop [16] 50.0% for-loop [62] 50.0% [72] 3660(1.7%) 0(0.0%) matcher ...rbie/develop/src/core/matcher.rkt:163:2 ??? [4] 50.0% rewriter [52] 50.0% ---------------------------------------------------------------------------- best-and-tied-at-points [57] 100.0% [73] 968(0.5%) 968(0.5%) for-loop .../develop/src/core/alt-table.rkt:114:16 ---------------------------------------------------------------------------- simplify [13] 33.9% map [61] 66.1% [74] 962(0.5%) 326(0.2%) simplify* ...rbie/develop/src/core/reduce.rkt:31:0 ??? [85] 34.9% hash-ref! [160] 31.2% ---------------------------------------------------------------------------- for-loop [63] 100.0% [75] 662(0.3%) 662(0.3%) for-loop ...e/develop/src/core/simplify.rkt:146:23 ---------------------------------------------------------------------------- *rules* [64] 100.0% [76] 360(0.2%) 360(0.2%) for-loop ...ies/herbie/develop/src/common.rkt:71:9 ---------------------------------------------------------------------------- for-loop [62] 100.0% [77] 324(0.2%) 324(0.2%) assoc-ref ...collects/racket/private/dict.rkt:56:0 ---------------------------------------------------------------------------- for-loop [67] 5.3% run [11] 47.3% [78] 210514(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 47.3% run-improve40 [2] 39.8% prepare-points-intervals [87] 7.0% merge-egraph-nodes! [86] 5.2% oracle-error [90] 0.4% eval-const-expr [29] 0.2% eval-errors [95] 0.1% errors [68] 0.1% ---------------------------------------------------------------------------- apply-match [66] 100.0% [79] 37540(17.8%) 0(0.0%) for-loop ...bie/develop/src/core/simplify.rkt:87:2 merge-egraph-nodes! [86] 84.0% dedup-children! [103] 8.6% mk-enode! [121] 4.1% substitute-e [91] 3.4% ---------------------------------------------------------------------------- for-loop [100] 32.3% for-loop [69] 33.4% apply-match [66] 34.4% [80] 15856(7.5%) 2098(1.0%) match-e ...herbie/develop/src/core/ematch.rkt:39:0 for-loop [88] 81.7% ??? [34] 4.1% variable? [6] 3.1% ---------------------------------------------------------------------------- eval-const-expr [29] 29.9% errors [68] 70.1% [81] 12600(6.0%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:130:0 temp68_2 [89] 85.1% inductor [92] 5.1% loop [20] 4.8% ??? [151] 2.6% eval [96] 2.5% ---------------------------------------------------------------------------- errors [68] 100.0% [82] 9484(4.5%) 1894(0.9%) for-loop ...es/herbie/develop/src/points.rkt:225:2 ??? [130] 51.0% ??? [152] 15.7% ulp-difference [105] 6.7% point-error [93] 6.6% ---------------------------------------------------------------------------- expression-cost [70] 100.0% [83] 7640(3.6%) 0(0.0%) compile ...s/herbie/develop/src/programs.rkt:181:0 hash-ref! [160] 100.0% ---------------------------------------------------------------------------- apply-match [66] 100.0% [84] 592(0.3%) 0(0.0%) custom-set-intersect ...rivate/set-types.rkt:195:0 for-loop [94] 100.0% ---------------------------------------------------------------------------- simplify* [74] 100.0% [85] 336(0.2%) 336(0.2%) ??? ...ects/racket/contract/private/guts.rkt:746:8 ---------------------------------------------------------------------------- for-loop [102] 2.6% merge-egraph-nodes! [86] 3.3% for-loop [79] 43.2% ??? [78] 50.8% [86] 64098(30.4%) 328(0.2%) merge-egraph-nodes! ...p/src/core/egraph.rkt:145:0 update-leader! [97] 82.6% loop! [132] 9.5% merge-egraph-nodes! [86] 3.3% for-loop [102] 2.6% enode-merge! [107] 1.3% dedup-children! [103] 0.1% ---------------------------------------------------------------------------- run-improve40 [2] 2.1% ??? [78] 97.9% [87] 29914(14.2%) 0(0.0%) prepare-points-intervals ...p/src/points.rkt:122:0 loop [98] 100.0% ---------------------------------------------------------------------------- match-e [80] 100.0% [88] 14646(7.0%) 5842(2.8%) for-loop ...rbie/develop/src/core/ematch.rkt:52:11 for-loop [100] 50.6% loop [118] 6.2% cp-2 [108] 3.3% loop [135] 3.1% curried [109] 3.0% cartesian-product [111] 2.3% ---------------------------------------------------------------------------- eval-prog [81] 100.0% [89] 10720(5.1%) 0(0.0%) temp68_2 (unknown source) compile16 [99] 100.0% ---------------------------------------------------------------------------- ??? [78] 100.0% [90] 1824(0.9%) 0(0.0%) oracle-error ...erbie/develop/src/points.rkt:207:0 for-loop [104] 100.0% ---------------------------------------------------------------------------- for-loop [79] 49.2% for-loop [106] 50.8% [91] 1258(0.6%) 0(0.0%) substitute-e ...e/develop/src/core/ematch.rkt:64:0 for-loop [106] 74.6% ??? [34] 17.4% variable? [6] 7.9% ---------------------------------------------------------------------------- inductor [92] 40.9% eval-prog [81] 59.1% [92] 648(0.3%) 0(0.0%) inductor .../herbie/develop/src/programs.rkt:135:4 table-ref [101] 50.9% inductor [92] 40.9% ??? [112] 8.2% ---------------------------------------------------------------------------- for-loop [82] 100.0% [93] 630(0.3%) 0(0.0%) point-error ...herbie/develop/src/points.rkt:190:0 ulp-difference [105] 100.0% ---------------------------------------------------------------------------- custom-set-intersect [84] 100.0% [94] 592(0.3%) 298(0.1%) for-loop ...cts/racket/private/set-types.rkt:207:3 for-loop [114] 49.7% ---------------------------------------------------------------------------- ??? [78] 100.0% [95] 342(0.2%) 0(0.0%) eval-errors ...herbie/develop/src/points.rkt:198:0 for-loop [110] 100.0% ---------------------------------------------------------------------------- eval-prog [81] 100.0% [96] 310(0.1%) 0(0.0%) eval (unknown source) add-ns-scopes [113] 100.0% ---------------------------------------------------------------------------- apply-match [66] 7.5% loop [48] 34.0% merge-egraph-nodes! [86] 58.5% [97] 93206(44.3%) 0(0.0%) update-leader! ...evelop/src/core/egraph.rkt:213:0 for-loop [115] 99.8% custom-set-union! [128] 0.2% ---------------------------------------------------------------------------- prepare-points-intervals [87] 100.0% [98] 29914(14.2%) 920(0.4%) loop ...htlies/herbie/develop/src/points.rkt:138:4 loop [116] 94.8% ??? [152] 2.1% ---------------------------------------------------------------------------- temp68_2 [89] 100.0% [99] 10720(5.1%) 0(0.0%) compile16 (unknown source) temp74_0 [117] 100.0% ---------------------------------------------------------------------------- for-loop [88] 100.0% [100] 9456(4.5%) 882(0.4%) for-loop ...rbie/develop/src/core/ematch.rkt:58:37 match-e [80] 93.6% ---------------------------------------------------------------------------- inductor [92] 6.7% for-loop [71] 93.3% [101] 4956(2.4%) 2496(1.2%) table-ref ...es/herbie/develop/src/common.rkt:42:0 for-loop [122] 37.1% assoc-iterate-first [126] 6.5% dict? [127] 6.0% ---------------------------------------------------------------------------- merge-egraph-nodes! [86] 100.0% [102] 3984(1.9%) 0(0.0%) for-loop ...rbie/develop/src/core/egraph.rkt:199:4 merge-egraph-nodes! [86] 100.0% ---------------------------------------------------------------------------- merge-egraph-nodes! [86] 8.5% for-loop [79] 91.5% [103] 3516(1.7%) 0(0.0%) dedup-children! ...evelop/src/core/enode.rkt:199:0 loop [120] 53.9% loop [123] 46.1% ---------------------------------------------------------------------------- oracle-error [90] 100.0% [104] 1824(0.9%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:208:2 loop [118] 67.2% map [61] 32.8% ---------------------------------------------------------------------------- point-error [93] 49.8% for-loop [82] 50.2% [105] 1264(0.6%) 596(0.3%) ulp-difference ...erbie/develop/src/float.rkt:14:0 return/no-unsupplied [174] 26.6% ??? [152] 26.3% ---------------------------------------------------------------------------- substitute-e [91] 100.0% [106] 1258(0.6%) 0(0.0%) for-loop ...rbie/develop/src/core/ematch.rkt:73:24 substitute-e [91] 76.2% mk-enode! [121] 23.8% ---------------------------------------------------------------------------- merge-egraph-nodes! [86] 100.0% [107] 958(0.5%) 0(0.0%) enode-merge! ...e/develop/src/core/enode.rkt:128:0 adopt-enode! [124] 100.0% ---------------------------------------------------------------------------- for-loop [88] 100.0% [108] 644(0.3%) 0(0.0%) cp-2 .../racket-7.0/collects/racket/list.rkt:826:2 for-loop [125] 100.0% ---------------------------------------------------------------------------- for-loop [88] 100.0% [109] 610(0.3%) 610(0.3%) curried ...-7.0/collects/racket/function.rkt:71:18 ---------------------------------------------------------------------------- eval-errors [95] 100.0% [110] 342(0.2%) 342(0.2%) for-loop ...es/herbie/develop/src/points.rkt:200:2 ---------------------------------------------------------------------------- for-loop [88] 100.0% [111] 332(0.2%) 332(0.2%) cartesian-product ...ollects/racket/list.rkt:822:0 ---------------------------------------------------------------------------- inductor [92] 100.0% [112] 318(0.2%) 318(0.2%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ---------------------------------------------------------------------------- eval [96] 100.0% [113] 310(0.1%) 0(0.0%) add-ns-scopes (unknown source) gf [119] 100.0% ---------------------------------------------------------------------------- for-loop [94] 100.0% [114] 294(0.1%) 294(0.1%) for-loop ...cts/racket/private/set-types.rkt:201:4 ---------------------------------------------------------------------------- update-leader! [97] 100.0% [115] 92992(44.2%) 1062(0.5%) for-loop ...rbie/develop/src/core/egraph.rkt:218:6 for-loop [129] 55.3% hash-update! [143] 42.8% update-en-expr [170] 0.7% ---------------------------------------------------------------------------- loop [98] 100.0% [116] 28356(13.5%) 302(0.1%) loop ...htlies/herbie/develop/src/points.rkt:103:2 ??? [130] 93.6% ??? [152] 3.3% hash-update! [143] 2.0% ---------------------------------------------------------------------------- compile16 [99] 100.0% [117] 10720(5.1%) 0(0.0%) temp74_0 (unknown source) expand-single [131] 91.2% compile-top9 [134] 8.8% ---------------------------------------------------------------------------- map [61] 3.3% for-loop [88] 4.3% loop! [132] 4.8% parse-loop80 [21] 7.1% for-loop [104] 11.4% loop [118] 69.1% [118] 9320(4.4%) 522(0.2%) loop ...-7.0/collects/racket/private/map.rkt:40:19 loop [118] 69.1% ??? [130] 8.1% hash-ref! [160] 7.0% ??? [136] 6.5% loop! [132] 4.8% ??? [141] 0.1% map [61] 0.0% loop [135] 0.0% ---------------------------------------------------------------------------- add-ns-scopes [113] 3.8% loop [20] 96.2% [119] 4036(1.9%) 0(0.0%) gf (unknown source) propagation-apply [133] 84.8% loop [20] 7.7% cache-or-reuse-hash [140] 7.5% ---------------------------------------------------------------------------- dedup-children! [103] 19.1% loop [120] 80.9% [120] 1896(0.9%) 0(0.0%) loop ...racket-7.0/collects/racket/list.rkt:417:34 loop [120] 80.9% loop [20] 15.2% member [137] 3.9% ---------------------------------------------------------------------------- for-loop [106] 16.2% for-loop [79] 83.8% [121] 1848(0.9%) 902(0.4%) mk-enode! ...rbie/develop/src/core/egraph.rkt:99:0 new-enode [138] 33.8% hash-has-key? [139] 17.4% ---------------------------------------------------------------------------- table-ref [101] 100.0% [122] 1838(0.9%) 1838(0.9%) for-loop ...ies/herbie/develop/src/common.rkt:44:4 ---------------------------------------------------------------------------- dedup-children! [103] 20.4% loop [123] 79.6% [123] 1620(0.8%) 1620(0.8%) loop ...racket-7.0/collects/racket/list.rkt:434:17 loop [123] 79.6% ---------------------------------------------------------------------------- enode-merge! [107] 100.0% [124] 958(0.5%) 304(0.1%) adopt-enode! ...e/develop/src/core/enode.rkt:104:0 custom-set-union [147] 68.3% ---------------------------------------------------------------------------- cp-2 [108] 100.0% [125] 644(0.3%) 644(0.3%) for-loop ...ket-7.0/collects/racket/list.rkt:827:4 ---------------------------------------------------------------------------- table-ref [101] 100.0% [126] 324(0.2%) 324(0.2%) assoc-iterate-first ...cket/private/dict.rkt:166:0 ---------------------------------------------------------------------------- table-ref [101] 100.0% [127] 298(0.1%) 298(0.1%) dict? ...ollects/racket/private/generic.rkt:146:11 ---------------------------------------------------------------------------- update-leader! [97] 100.0% [128] 214(0.1%) 0(0.0%) custom-set-union! ...t/private/set-types.rkt:245:0 for-loop [142] 100.0% ---------------------------------------------------------------------------- for-loop [115] 100.0% [129] 51442(24.4%) 0(0.0%) for-loop ...rbie/develop/src/core/egraph.rkt:219:8 hash-update! [143] 100.0% ---------------------------------------------------------------------------- ??? [136] 1.8% loop [118] 2.8% for-loop [82] 14.7% loop [116] 80.7% [130] 32904(15.6%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:146:2 ??? [144] 89.3% ??? [152] 7.5% ??? [151] 3.2% ---------------------------------------------------------------------------- temp74_0 [117] 100.0% [131] 9782(4.6%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [145] 100.0% ---------------------------------------------------------------------------- loop [118] 34.6% merge-egraph-nodes! [86] 65.4% [132] 7960(3.8%) 2656(1.3%) loop! ...s/herbie/develop/src/core/enode.rkt:191:2 loop [118] 34.6% custom-set-union [147] 33.9% set [146] 7.5% update-en-expr [170] 6.4% ---------------------------------------------------------------------------- gf [119] 100.0% [133] 3424(1.6%) 3424(1.6%) propagation-apply (unknown source) ---------------------------------------------------------------------------- temp74_0 [117] 100.0% [134] 938(0.4%) 0(0.0%) compile-top9 (unknown source) compile-forms31 [149] 100.0% ---------------------------------------------------------------------------- loop [118] 35.7% for-loop [88] 64.3% [135] 930(0.4%) 930(0.4%) loop ...cket-7.0/collects/racket/function.rkt:53:6 ---------------------------------------------------------------------------- map [61] 33.0% loop [118] 67.0% [136] 904(0.4%) 0(0.0%) ??? ...htlies/herbie/develop/src/points.rkt:209:26 ??? [130] 66.8% ??? [152] 33.2% ---------------------------------------------------------------------------- loop [120] 100.0% [137] 628(0.3%) 628(0.3%) member (unknown source) ---------------------------------------------------------------------------- mk-enode! [121] 100.0% [138] 624(0.3%) 0(0.0%) new-enode ...erbie/develop/src/core/enode.rkt:96:0 set [146] 100.0% ---------------------------------------------------------------------------- mk-enode! [121] 100.0% [139] 322(0.2%) 322(0.2%) hash-has-key? ...ket/private/more-scheme.rkt:371:2 ---------------------------------------------------------------------------- gf [119] 100.0% [140] 302(0.1%) 302(0.1%) cache-or-reuse-hash (unknown source) ---------------------------------------------------------------------------- loop [118] 100.0% [141] 296(0.1%) 0(0.0%) ??? ...erbie/develop/src/core/alt-table.rkt:191:30 loop [148] 100.0% ---------------------------------------------------------------------------- custom-set-union! [128] 100.0% [142] 214(0.1%) 214(0.1%) for-loop ...cts/racket/private/set-types.rkt:253:4 ---------------------------------------------------------------------------- loop [116] 0.6% for-loop [115] 43.4% for-loop [129] 56.0% [143] 91848(43.6%) 1516(0.7%) hash-update! ...cket/private/more-scheme.rkt:365:4 ??? [150] 98.3% ---------------------------------------------------------------------------- ??? [130] 100.0% [144] 29390(14.0%) 930(0.4%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 ??? [151] 68.8% ??? [152] 18.0% ??? [155] 10.1% ---------------------------------------------------------------------------- loop [20] 5.8% expand-single [131] 94.2% [145] 10382(4.9%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [153] 94.2% dispatch-transformer41 [190] 2.9% expand-id-application-form17 [186] 2.9% ---------------------------------------------------------------------------- new-enode [138] 11.7% loop! [132] 24.1% apply-match [66] 64.2% [146] 5350(2.5%) 2212(1.1%) set ...collects/racket/private/set-types.rkt:981:0 for-loop [154] 58.7% ---------------------------------------------------------------------------- adopt-enode! [124] 17.9% loop! [132] 82.1% [147] 3656(1.7%) 1818(0.9%) custom-set-union ...et/private/set-types.rkt:168:0 for-loop [156] 26.0% for-loop [157] 24.3% ---------------------------------------------------------------------------- ??? [141] 5.2% map [61] 6.0% loop [148] 88.8% [148] 950(0.5%) 950(0.5%) loop ...7.0/collects/racket/private/list.rkt:82:16 loop [148] 88.8% ---------------------------------------------------------------------------- compile-top9 [134] 100.0% [149] 938(0.4%) 0(0.0%) compile-forms31 (unknown source) for-loop [171] 100.0% ---------------------------------------------------------------------------- hash-update! [143] 100.0% [150] 90332(42.9%) 2138(1.0%) ??? ...s/herbie/develop/src/core/egraph.rkt:221:24 for-loop [158] 96.6% update-en-expr [170] 1.1% ---------------------------------------------------------------------------- eval-prog [81] 1.4% location-do [164] 1.5% fold-binary-pred [187] 4.2% ??? [130] 4.7% ??? [144] 88.2% [151] 22232(10.6%) 2470(1.2%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-cos [159] 59.0% ival-div [165] 17.2% ival-sub [166] 10.6% mk-ival [167] 4.7% ---------------------------------------------------------------------------- ??? [136] 1.8% for-loop [46] 2.0% loop [31] 2.0% ulp-difference [105] 2.0% map [61] 2.0% loop [98] 3.8% loop [116] 5.6% loop [14] 8.0% for-loop [82] 8.8% location-do [164] 9.0% for-loop [51] 9.0% ??? [130] 14.7% ??? [144] 31.4% [152] 16794(8.0%) 952(0.5%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [162] 33.0% ival-mult [163] 31.4% location-do [164] 10.9% approximate9 [3] 9.0% hash-ref! [160] 8.0% sample-multi-bounded [169] 1.9% ---------------------------------------------------------------------------- expand-capturing-lifts [145] 100.0% [153] 9782(4.6%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [161] 100.0% ---------------------------------------------------------------------------- set [146] 100.0% [154] 3138(1.5%) 3138(1.5%) for-loop ...cts/racket/private/set-types.rkt:937:4 ---------------------------------------------------------------------------- ??? [144] 100.0% [155] 2968(1.4%) 1650(0.8%) ??? ...herbie/develop/src/syntax/syntax.rkt:317:17 return/no-unsupplied [174] 22.2% ??? [178] 22.2% ---------------------------------------------------------------------------- custom-set-union [147] 100.0% [156] 950(0.5%) 618(0.3%) for-loop ...cts/racket/private/set-types.rkt:174:3 for-loop [168] 34.9% ---------------------------------------------------------------------------- custom-set-union [147] 100.0% [157] 888(0.4%) 888(0.4%) for-loop ...cts/racket/private/set-types.rkt:152:2 ---------------------------------------------------------------------------- ??? [150] 100.0% [158] 87230(41.4%) 77474(36.8%) for-loop ...bie/develop/src/core/egraph.rkt:222:26 update-en-expr [170] 11.2% ---------------------------------------------------------------------------- ??? [151] 100.0% [159] 13562(6.4%) 2926(1.4%) ival-cos ...rbie/develop/src/biginterval.rkt:258:0 ??? [185] 69.8% fold-binary-pred [187] 6.5% bfeven? [184] 2.1% ---------------------------------------------------------------------------- map [61] 0.5% simplify* [74] 0.8% for-loop [17] 1.3% localize-error [38] 3.1% loop [118] 4.1% ??? [177] 4.3% ??? [173] 11.5% ??? [152] 14.1% compile [83] 24.9% ??? [172] 35.4% [160] 12666(6.0%) 7634(3.6%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [172] 36.0% simplify [13] 13.0% ??? [173] 11.5% parse-loop80 [21] 6.8% ??? [177] 5.4% ??? [9] 1.3% f46 [22] 0.5% ??? [182] 0.5% ---------------------------------------------------------------------------- lambda-clause-expander [153] 26.4% for-loop [171] 73.6% [161] 9782(4.6%) 0(0.0%) finish-bodys (unknown source) for-loop [171] 100.0% ---------------------------------------------------------------------------- ??? [152] 100.0% [162] 5544(2.6%) 3050(1.4%) ->flonum ...s/herbie/develop/src/programs.rkt:38:0 return/no-unsupplied [174] 22.8% list-member? [180] 11.4% ??? [178] 10.8% ---------------------------------------------------------------------------- ??? [152] 100.0% [163] 5278(2.5%) 0(0.0%) ival-mult ...rbie/develop/src/biginterval.rkt:95:0 bf* [175] 54.5% classify-ival [176] 39.5% ...higher-order.rkt:361:33 [183] 6.0% ---------------------------------------------------------------------------- location-do [164] 25.0% ??? [152] 75.0% [164] 4696(2.2%) 0(0.0%) location-do ...rbie/develop/src/programs.rkt:111:0 ??? [152] 73.6% location-do [164] 25.0% ??? [151] 1.4% ---------------------------------------------------------------------------- ??? [151] 100.0% [165] 3996(1.9%) 334(0.2%) ival-div ...rbie/develop/src/biginterval.rkt:131:0 ??? [185] 68.0% fold-binary-pred [187] 8.1% force [189] 8.1% classify-ival [176] 7.5% ---------------------------------------------------------------------------- ??? [151] 100.0% [166] 2362(1.1%) 0(0.0%) ival-sub ...erbie/develop/src/biginterval.rkt:83:0 ??? [185] 100.0% ---------------------------------------------------------------------------- ??? [151] 100.0% [167] 1048(0.5%) 356(0.2%) mk-ival ...herbie/develop/src/biginterval.rkt:53:0 bf [179] 66.0% ---------------------------------------------------------------------------- for-loop [156] 100.0% [168] 332(0.2%) 332(0.2%) for-loop ...cts/racket/private/set-types.rkt:178:5 ---------------------------------------------------------------------------- ??? [152] 100.0% [169] 324(0.2%) 0(0.0%) sample-multi-bounded ...evelop/src/points.rkt:15:0 for-loop [181] 100.0% ---------------------------------------------------------------------------- for-loop [115] 5.3% ??? [150] 7.8% loop! [132] 8.2% for-loop [158] 78.7% [170] 12392(5.9%) 12392(5.9%) update-en-expr ...evelop/src/core/egraph.rkt:207:0 ---------------------------------------------------------------------------- fallback-loop [45] 1.7% compile-forms31 [149] 8.8% for-loop [171] 9.3% finish-bodys [161] 80.2% [171] 10720(5.1%) 3494(1.7%) for-loop (unknown source) finish-bodys [161] 59.0% for-loop [171] 9.3% syntax-e [5] 5.1% loop [20] 4.2% expand-implicit [8] 2.2% expand-id-application-form17 [186] 2.1% expand-identifier [7] 1.2% dispatch-transformer41 [190] 0.8% ---------------------------------------------------------------------------- hash-ref! [160] 100.0% [172] 6732(3.2%) 306(0.1%) ??? ...tlies/herbie/develop/src/programs.rkt:189:5 hash-ref! [160] 98.9% ---------------------------------------------------------------------------- hash-ref! [160] 100.0% [173] 3706(1.8%) 0(0.0%) ??? ...es/herbie/develop/src/core/taylor.rkt:45:15 hash-ref! [160] 100.0% ---------------------------------------------------------------------------- ulp-difference [105] 9.3% ??? [155] 18.3% ->flonum [162] 35.0% for-loop [62] 37.3% [174] 3604(1.7%) 1966(0.9%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 filter [188] 45.4% ---------------------------------------------------------------------------- ival-mult [163] 100.0% [175] 2874(1.4%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [185] 100.0% ---------------------------------------------------------------------------- ival-div [165] 12.5% ival-mult [163] 87.5% [176] 2384(1.1%) 688(0.3%) classify-ival ...develop/src/biginterval.rkt:300:0 force [189] 29.9% fold-binary-pred [187] 25.9% ...higher-order.rkt:357:33 [191] 15.4% ---------------------------------------------------------------------------- hash-ref! [160] 100.0% [177] 1854(0.9%) 292(0.1%) ??? ...s/herbie/develop/src/core/taylor.rkt:344:33 hash-ref! [160] 84.3% ---------------------------------------------------------------------------- ->flonum [162] 47.6% ??? [155] 52.4% [178] 1256(0.6%) 1256(0.6%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ---------------------------------------------------------------------------- mk-ival [167] 100.0% [179] 692(0.3%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [201] 100.0% ---------------------------------------------------------------------------- ->flonum [162] 100.0% [180] 634(0.3%) 634(0.3%) list-member? ...llects/racket/private/set.rkt:24:0 ---------------------------------------------------------------------------- sample-multi-bounded [169] 100.0% [181] 324(0.2%) 324(0.2%) for-loop ...ies/herbie/develop/src/points.rkt:25:4 ---------------------------------------------------------------------------- hash-ref! [160] 100.0% [182] 322(0.2%) 0(0.0%) ??? .../herbie/develop/src/core/localize.rkt:22:13 repeat [192] 100.0% ---------------------------------------------------------------------------- ival-mult [163] 100.0% [183] 318(0.2%) 0(0.0%) ...higher-order.rkt:361:33 (unknown source) ??? [193] 100.0% ---------------------------------------------------------------------------- ival-cos [159] 100.0% [184] 286(0.1%) 0(0.0%) bfeven? ...ib/math/private/bigfloat/mpfr.rkt:800:0 ??? [202] 100.0% ---------------------------------------------------------------------------- ival-sub [166] 13.6% ival-div [165] 15.6% bf* [175] 16.5% ival-cos [159] 54.3% [185] 17422(8.3%) 4398(2.1%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfsub [194] 55.4% bfcos [195] 9.8% pi.bf [196] 7.4% bffloor [199] 2.2% ---------------------------------------------------------------------------- expand-capturing-lifts [145] 12.0% for-loop [171] 37.4% loop [20] 50.6% [186] 2490(1.2%) 0(0.0%) expand-id-application-form17 (unknown source) resolve+shift28 [37] 38.2% binding-lookup50 [198] 36.2% syntax-e/no-taint [15] 25.6% ---------------------------------------------------------------------------- ival-div [165] 17.8% classify-ival [176] 33.9% ival-cos [159] 48.4% [187] 1824(0.9%) 298(0.1%) fold-binary-pred ...gfloat/bigfloat-mpfr.rkt:117:0 ??? [151] 83.7% ---------------------------------------------------------------------------- return/no-unsupplied [174] 100.0% [188] 1638(0.8%) 1638(0.8%) filter ...0/collects/racket/private/list.rkt:256:2 ---------------------------------------------------------------------------- ival-div [165] 31.1% classify-ival [176] 68.9% [189] 1034(0.5%) 1034(0.5%) force ...collects/racket/private/promise.rkt:109:0 ---------------------------------------------------------------------------- expand-capturing-lifts [145] 33.4% for-loop [171] 66.6% [190] 904(0.4%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [197] 100.0% ---------------------------------------------------------------------------- classify-ival [176] 100.0% [191] 366(0.2%) 366(0.2%) ...higher-order.rkt:357:33 (unknown source) ---------------------------------------------------------------------------- ??? [182] 100.0% [192] 322(0.2%) 0(0.0%) repeat ...erbie/develop/src/core/localize.rkt:13:0 for-loop [200] 100.0% ---------------------------------------------------------------------------- ...higher-order.rkt:361:33 [183] 100.0% [193] 318(0.2%) 318(0.2%) ??? ...cts/racket/contract/private/list.rkt:209:10 ---------------------------------------------------------------------------- ??? [185] 100.0% [194] 9644(4.6%) 0(0.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [201] 66.4% ??? [202] 33.6% ---------------------------------------------------------------------------- ??? [185] 100.0% [195] 1700(0.8%) 0(0.0%) bfcos ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [201] 100.0% ---------------------------------------------------------------------------- ??? [185] 100.0% [196] 1290(0.6%) 0(0.0%) pi.bf ...-lib/math/private/bigfloat/mpfr.rkt:998:4 new-mpfr [201] 51.3% ??? [202] 48.7% ---------------------------------------------------------------------------- dispatch-transformer41 [190] 100.0% [197] 904(0.4%) 302(0.1%) apply-transformer52 (unknown source) loop [20] 66.6% ---------------------------------------------------------------------------- expand-id-application-form17 [186]100.0% [198] 902(0.4%) 902(0.4%) binding-lookup50 (unknown source) ---------------------------------------------------------------------------- ??? [185] 100.0% [199] 390(0.2%) 0(0.0%) bffloor ...ib/math/private/bigfloat/mpfr.rkt:716:4 ??? [202] 100.0% ---------------------------------------------------------------------------- repeat [192] 100.0% [200] 322(0.2%) 322(0.2%) for-loop ...bie/develop/src/core/localize.rkt:14:2 ---------------------------------------------------------------------------- pi.bf [196] 7.0% bf [179] 7.3% bfcos [195] 18.0% bfsub [194] 67.7% [201] 9454(4.5%) 9454(4.5%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ---------------------------------------------------------------------------- bfeven? [184] 6.3% bffloor [199] 8.6% pi.bf [196] 13.8% bfsub [194] 71.3% [202] 4548(2.2%) 4548(2.2%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ----------------------------------------------------------------------------