Profiling results ----------------- Total cpu time observed: 28572ms (out of 28952ms) Number of samples taken: 81 (once every 353ms) (Hiding functions with self<1.0% and local<2.0%: 2 of 66 hidden) ================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ================================================================== ??? [5] 100.0% [1] 28572(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ------------------------------------------------------------------ ??? [5] 100.0% [2] 5994(21.0%) 0(0.0%) errors ...lies/herbie/develop/src/points.rkt:223:0 for-loop [4] 100.0% ------------------------------------------------------------------ profile-thunk16 [1] 100.0% [3] 28572(100.0%) 0(0.0%) run ...et-7.2/share/pkgs/profile-lib/main.rkt:39:2 ??? [5] 100.0% ------------------------------------------------------------------ errors [2] 100.0% [4] 5994(21.0%) 302(1.1%) for-loop ...es/herbie/develop/src/points.rkt:225:2 ??? [5] 95.0% ------------------------------------------------------------------ for-loop [4] 6.6% run [3] 46.7% [5] 28572(100.0%) 108(0.4%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 46.7% prepare-points [18] 33.9% errors [2] 7.2% ??? [32] 3.4% ??? [39] 3.3% run-improve43 [6] 1.7% eval-errors [7] 1.4% oracle-error [8] 1.4% get-final-combination [9] 0.5% loop [10] 0.3% ??? [40] 0.1% errors-score [11] 0.1% ------------------------------------------------------------------ ??? [5] 100.0% [6] 964(3.4%) 0(0.0%) run-improve43 ...ie/develop/src/mainloop.rkt:339:0 setup-prog!34 [12] 100.0% ------------------------------------------------------------------ ??? [5] 100.0% [7] 802(2.8%) 0(0.0%) eval-errors ...herbie/develop/src/points.rkt:198:0 for-loop [13] 100.0% ------------------------------------------------------------------ ??? [5] 100.0% [8] 790(2.8%) 0(0.0%) oracle-error ...erbie/develop/src/points.rkt:207:0 for-loop [14] 100.0% ------------------------------------------------------------------ ??? [5] 100.0% [9] 270(0.9%) 0(0.0%) get-final-combination ...op/src/mainloop.rkt:360:0 ??? [15] 100.0% ------------------------------------------------------------------ ??? [5] 100.0% [10] 152(0.5%) 0(0.0%) loop ...-7.2/collects/racket/private/map.rkt:40:19 eval-prog [16] 100.0% ------------------------------------------------------------------ ??? [5] 100.0% [11] 56(0.2%) 0(0.0%) errors-score ...erbie/develop/src/points.rkt:215:0 loop [17] 100.0% ------------------------------------------------------------------ run-improve43 [6] 100.0% [12] 964(3.4%) 0(0.0%) setup-prog!34 ...bie/develop/src/mainloop.rkt:67:0 prepare-points [18] 100.0% ------------------------------------------------------------------ eval-errors [7] 100.0% [13] 802(2.8%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:200:2 ??? [32] 63.6% ulp-difference [20] 36.4% ------------------------------------------------------------------ oracle-error [8] 100.0% [14] 790(2.8%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:208:2 map [19] 100.0% ------------------------------------------------------------------ get-final-combination [9] 100.0% [15] 270(0.9%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:22:0 ??? [21] 100.0% ------------------------------------------------------------------ loop [10] 100.0% [16] 152(0.5%) 0(0.0%) eval-prog .../herbie/develop/src/programs.rkt:83:0 temp85_0 [22] 100.0% ------------------------------------------------------------------ errors-score [11] 100.0% [17] 56(0.2%) 0(0.0%) loop .../racket-7.2/collects/racket/list.rkt:559:2 ordinary-value? [33] 100.0% ------------------------------------------------------------------ setup-prog!34 [12] 4.7% ??? [5] 95.3% [18] 20322(71.1%) 0(0.0%) prepare-points ...bie/develop/src/points.rkt:166:0 loop [23] 100.0% ------------------------------------------------------------------ for-loop [14] 100.0% [19] 790(2.8%) 0(0.0%) map ...t-7.2/collects/racket/private/map.rkt:35:13 ??? [24] 100.0% ------------------------------------------------------------------ for-loop [13] 100.0% [20] 292(1.0%) 292(1.0%) ulp-difference ...erbie/develop/src/float.rkt:46:0 ------------------------------------------------------------------ ??? [15] 100.0% [21] 270(0.9%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:26:0 loop [25] 100.0% ------------------------------------------------------------------ eval-prog [16] 100.0% [22] 152(0.5%) 0(0.0%) temp85_0 (unknown source) compile15 [26] 100.0% ------------------------------------------------------------------ prepare-points [18] 100.0% [23] 20322(71.1%) 348(1.2%) loop ...htlies/herbie/develop/src/points.rkt:143:4 loop [27] 84.7% ??? [28] 12.1% andmap [29] 1.4% ------------------------------------------------------------------ map [19] 100.0% [24] 790(2.8%) 0(0.0%) ??? ...htlies/herbie/develop/src/points.rkt:209:26 ??? [32] 67.8% ??? [39] 32.2% ------------------------------------------------------------------ ??? [21] 100.0% [25] 270(0.9%) 0(0.0%) loop ...herbie/develop/src/core/simplify.rkt:142:2 debug-print [30] 100.0% ------------------------------------------------------------------ temp85_0 [22] 100.0% [26] 152(0.5%) 0(0.0%) compile15 (unknown source) temp91_0 [31] 100.0% ------------------------------------------------------------------ loop [23] 100.0% [27] 17216(60.3%) 654(2.3%) loop ...htlies/herbie/develop/src/points.rkt:102:2 ??? [32] 94.6% ------------------------------------------------------------------ loop [23] 100.0% [28] 2466(8.6%) 1410(4.9%) ??? ...ghtlies/herbie/develop/src/points.rkt:127:2 ??? [40] 34.9% ??? [39] 7.9% ------------------------------------------------------------------ loop [23] 100.0% [29] 292(1.0%) 0(0.0%) andmap ...2/collects/racket/private/map.rkt:102:13 ordinary-value? [33] 100.0% ------------------------------------------------------------------ loop [25] 100.0% [30] 270(0.9%) 0(0.0%) debug-print .../herbie/develop/src/debug.rkt:110:0 ??? [34] 100.0% ------------------------------------------------------------------ compile15 [26] 100.0% [31] 152(0.5%) 0(0.0%) temp91_0 (unknown source) temp118_0 [35] 100.0% ------------------------------------------------------------------ for-loop [13] 2.5% ??? [24] 2.7% ??? [5] 14.3% loop [27] 80.5% [32] 20218(70.8%) 0(0.0%) ??? ...htlies/herbie/develop/src/programs.rkt:99:2 ??? [36] 74.1% ??? [39] 25.9% ------------------------------------------------------------------ loop [17] 16.1% andmap [29] 83.9% [33] 348(1.2%) 0(0.0%) ordinary-value? ...rbie/develop/src/float.rkt:80:0 special-value? [37] 100.0% ------------------------------------------------------------------ debug-print [30] 100.0% [34] 270(0.9%) 270(0.9%) ??? .../contract/private/arrow-val-first.rkt:430:3 ------------------------------------------------------------------ temp91_0 [31] 100.0% [35] 152(0.5%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [38]100.0% ------------------------------------------------------------------ ??? [32] 100.0% [36] 14984(52.4%) 0(0.0%) ??? ...t-7.2/collects/racket/private/kw.rkt:594:14 ??? [40] 69.3% ??? [39] 27.2% ??? [41] 3.6% ------------------------------------------------------------------ ordinary-value? [33] 100.0% [37] 348(1.2%) 0(0.0%) special-value? ...erbie/develop/src/float.rkt:76:0 for-loop [42] 100.0% ------------------------------------------------------------------ temp118_0 [35] 100.0% [38] 152(0.5%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [43]100.0% ------------------------------------------------------------------ ??? [28] 1.6% ??? [24] 2.0% ??? [5] 22.3% ??? [36] 32.4% ??? [32] 41.7% [39] 12558(44.0%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:360:33 ->flonum [45] 51.4% ival-mult [46] 32.4% mk-ival [47] 12.1% ??? [50] 2.5% ------------------------------------------------------------------ ??? [5] 0.7% ??? [28] 7.6% ??? [36] 91.7% [40] 11316(39.6%) 2650(9.3%) ??? ...tract/private/arrow-higher-order.rkt:364:33 ival-cos [44] 57.7% ival-exp [48] 10.6% ??? [49] 8.3% ------------------------------------------------------------------ ??? [36] 100.0% [41] 534(1.9%) 534(1.9%) ??? ...herbie/develop/src/syntax/syntax.rkt:209:17 ------------------------------------------------------------------ special-value? [37] 100.0% [42] 348(1.2%) 292(1.0%) for-loop ...lies/herbie/develop/src/float.rkt:17:3 return/no-unsupplied [64] 16.1% ------------------------------------------------------------------ expand-capturing-lifts [38]100.0% [43] 152(0.5%) 0(0.0%) lambda-clause-expander (unknown source) for-loop [51] 100.0% ------------------------------------------------------------------ ??? [40] 100.0% [44] 6534(22.9%) 2796(9.8%) ival-cos ...rbie/develop/src/biginterval.rkt:275:0 bfmul [53] 21.3% bffloor [56] 15.5% bfexp [55] 10.3% pi.bf [57] 5.4% bfeven? [58] 4.7% ------------------------------------------------------------------ ??? [39] 100.0% [45] 6458(22.6%) 0(0.0%) ->flonum ...ies/herbie/develop/src/float.rkt:149:0 ??? [52] 100.0% ------------------------------------------------------------------ ??? [39] 100.0% [46] 4072(14.3%) 790(2.8%) ival-mult ...bie/develop/src/biginterval.rkt:112:0 bfmul [53] 80.6% ------------------------------------------------------------------ ??? [39] 100.0% [47] 1516(5.3%) 0(0.0%) mk-ival ...herbie/develop/src/biginterval.rkt:57:0 bf [54] 100.0% ------------------------------------------------------------------ ??? [40] 100.0% [48] 1194(4.2%) 430(1.5%) ival-exp ...rbie/develop/src/biginterval.rkt:180:0 bfexp [55] 64.0% ------------------------------------------------------------------ ??? [40] 100.0% [49] 938(3.3%) 938(3.3%) ??? ...cts/racket/contract/private/list.rkt:209:10 ------------------------------------------------------------------ ??? [39] 100.0% [50] 316(1.1%) 316(1.1%) ??? ...ects/racket/contract/private/prop.rkt:541:4 ------------------------------------------------------------------ lambda-clause-expander [43]100.0% [51] 152(0.5%) 0(0.0%) for-loop (unknown source) add-local-binding!39 [59] 100.0% ------------------------------------------------------------------ ->flonum [45] 100.0% [52] 6458(22.6%) 0(0.0%) ??? ...nightlies/herbie/develop/src/float.rkt:23:2 for-loop [61] 100.0% ------------------------------------------------------------------ ival-cos [44] 29.8% ival-mult [46] 70.2% [53] 4672(16.4%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [60] 69.7% ??? [62] 30.3% ------------------------------------------------------------------ mk-ival [47] 100.0% [54] 1516(5.3%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [60] 100.0% ------------------------------------------------------------------ ival-cos [44] 46.9% ival-exp [48] 53.1% [55] 1438(5.0%) 0(0.0%) bfexp ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [60] 100.0% ------------------------------------------------------------------ ival-cos [44] 100.0% [56] 1016(3.6%) 0(0.0%) bffloor ...ib/math/private/bigfloat/mpfr.rkt:716:4 ??? [62] 61.6% new-mpfr [60] 38.4% ------------------------------------------------------------------ ival-cos [44] 100.0% [57] 354(1.2%) 0(0.0%) pi.bf ...-lib/math/private/bigfloat/mpfr.rkt:998:4 new-mpfr [60] 100.0% ------------------------------------------------------------------ ival-cos [44] 100.0% [58] 304(1.1%) 0(0.0%) bfeven? ...ib/math/private/bigfloat/mpfr.rkt:800:0 size+limbs->integer [63] 100.0% ------------------------------------------------------------------ for-loop [51] 100.0% [59] 152(0.5%) 152(0.5%) add-local-binding!39 (unknown source) ------------------------------------------------------------------ pi.bf [57] 5.1% bffloor [56] 5.6% bfexp [55] 20.7% bf [54] 21.8% bfmul [53] 46.8% [60] 6954(24.3%) 6954(24.3%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------ ??? [52] 100.0% [61] 6458(22.6%) 3410(11.9%) for-loop ...lies/herbie/develop/src/float.rkt:24:5 return/no-unsupplied [64] 47.2% ------------------------------------------------------------------ bffloor [56] 30.7% bfmul [53] 69.3% [62] 2042(7.1%) 2042(7.1%) ??? /opt/racket-7.2/collects/ffi/unsafe.rkt:905:4 ------------------------------------------------------------------ bfeven? [58] 100.0% [63] 304(1.1%) 304(1.1%) size+limbs->integer ...vate/bigfloat/gmp.rkt:103:0 ------------------------------------------------------------------ for-loop [42] 1.8% for-loop [61] 98.2% [64] 3104(10.9%) 3104(10.9%) return/no-unsupplied ...ct/private/arr-i.rkt:542:0 ------------------------------------------------------------------