Profiling results ----------------- Total cpu time observed: 3434ms (out of 3512ms) Number of samples taken: 35 (once every 98ms) ============================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================== ??? [4] 100.0% [1] 3378(98.4%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% -------------------------------------------------------------- hash-ref! [28] 100.0% [2] 212(6.2%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:181:5 loop [24] 100.0% -------------------------------------------------------------- profile-thunk16 [1] 98.4% [3] 3434(100.0%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [4] 100.0% -------------------------------------------------------------- run [3] 50.8% [4] 3434(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 49.2% loop [6] 46.2% run-improve50 [5] 4.7% -------------------------------------------------------------- ??? [4] 100.0% [5] 264(7.7%) 0(0.0%) run-improve50 ...ie/develop/src/mainloop.rkt:234:0 loop [6] 56.8% ??? [7] 22.0% setup-alt-simplified [8] 21.2% -------------------------------------------------------------- run-improve50 [5] 4.5% ??? [4] 95.5% [6] 3320(96.7%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:159:2 make-exacts* [14] 50.1% loop [9] 42.8% for-loop [10] 3.0% loop [15] 2.1% filter-exacts [11] 2.0% -------------------------------------------------------------- run-improve50 [5] 100.0% [7] 58(1.7%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:357:18 atab-add-altns [12] 100.0% -------------------------------------------------------------- run-improve50 [5] 100.0% [8] 56(1.6%) 0(0.0%) setup-alt-simplified .../develop/src/glue.rkt:54:0 simplify-alt [13] 100.0% -------------------------------------------------------------- loop [6] 100.0% [9] 1420(41.4%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:119:2 loop [15] 51.5% make-exacts* [14] 34.6% eval-prog [21] 13.8% -------------------------------------------------------------- loop [6] 100.0% [10] 98(2.9%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:166:24 for-loop [16] 100.0% -------------------------------------------------------------- loop [6] 100.0% [11] 68(2.0%) 0(0.0%) filter-exacts ...rbie/develop/src/points.rkt:134:0 for-loop [17] 100.0% -------------------------------------------------------------- ??? [7] 100.0% [12] 58(1.7%) 0(0.0%) atab-add-altns ...elop/src/core/alt-table.rkt:50:0 atab-add-altn [18] 100.0% -------------------------------------------------------------- setup-alt-simplified [8]100.0% [13] 56(1.6%) 0(0.0%) simplify-alt ...s/herbie/develop/src/glue.rkt:87:0 simplify4 [19] 100.0% -------------------------------------------------------------- loop [9] 22.8% loop [6] 77.2% [14] 2156(62.8%) 0(0.0%) make-exacts* ...erbie/develop/src/points.rkt:106:0 loop [24] 47.9% map [20] 47.7% eval-prog [21] 4.5% -------------------------------------------------------------- loop [6] 8.7% loop [9] 91.3% [15] 802(23.4%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:109:4 map [20] 100.0% -------------------------------------------------------------- for-loop [10] 100.0% [16] 98(2.9%) 98(2.9%) for-loop ...s/herbie/develop/src/points.rkt:167:26 -------------------------------------------------------------- filter-exacts [11] 100.0% [17] 68(2.0%) 68(2.0%) for-loop ...es/herbie/develop/src/points.rkt:137:4 -------------------------------------------------------------- atab-add-altns [12] 100.0% [18] 58(1.7%) 0(0.0%) atab-add-altn ...elop/src/core/alt-table.rkt:208:0 override-at-pnts [22] 100.0% -------------------------------------------------------------- simplify-alt [13] 100.0% [19] 56(1.6%) 0(0.0%) simplify4 ...ie/develop/src/core/simplify.rkt:39:0 simplify-expr12 [23] 100.0% -------------------------------------------------------------- loop [15] 43.8% make-exacts* [14] 56.2% [20] 1830(53.3%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [24] 100.0% -------------------------------------------------------------- make-exacts* [14] 32.9% loop [9] 67.1% [21] 292(8.5%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:146:0 hash-ref! [28] 72.6% [running body] [25] 27.4% -------------------------------------------------------------- atab-add-altn [18] 100.0% [22] 58(1.7%) 0(0.0%) override-at-pnts ...p/src/core/alt-table.rkt:145:0 loop [24] 100.0% -------------------------------------------------------------- simplify4 [19] 100.0% [23] 56(1.6%) 0(0.0%) simplify-expr12 ...elop/src/core/simplify.rkt:72:0 iterate-egraph!19 [26] 100.0% -------------------------------------------------------------- make-exacts* [14] 0.0% override-at-pnts [22] 0.1% map [20] 0.7% ??? [2] 6.8% loop [24] 92.4% [24] 3132(91.2%) 150(4.4%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [24] 92.4% hash-ref! [28] 6.8% ??? [27] 0.7% ->flonum [29] 0.0% -------------------------------------------------------------- eval-prog [21] 100.0% [25] 80(2.3%) 80(2.3%) [running body] ...t/collects/syntax/id-set.rkt:##f -------------------------------------------------------------- simplify-expr12 [23] 100.0% [26] 56(1.6%) 0(0.0%) iterate-egraph!19 ...op/src/core/simplify.rkt:99:0 map-enodes [30] 100.0% -------------------------------------------------------------- loop [24] 100.0% [27] 2642(76.9%) 84(2.4%) ??? ...tlies/herbie/develop/src/programs.rkt:152:4 ??? [31] 62.5% ??? [32] 34.4% -------------------------------------------------------------- loop [24] 50.0% eval-prog [21] 50.0% [28] 212(6.2%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 ??? [2] 50.0% bigfloat-hash [33] 50.0% -------------------------------------------------------------- loop [24] 100.0% [29] 128(3.7%) 0(0.0%) ->flonum ...s/herbie/develop/src/programs.rkt:34:0 ??? [34] 100.0% -------------------------------------------------------------- iterate-egraph!19 [26] 100.0% [30] 56(1.6%) 0(0.0%) map-enodes ...ie/develop/src/core/egraph.rkt:139:0 for-loop [35] 100.0% -------------------------------------------------------------- ??? [27] 100.0% [31] 1650(48.0%) 312(9.1%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [36] 71.5% ??? [38] 9.6% -------------------------------------------------------------- ??? [27] 100.0% [32] 908(26.4%) 82(2.4%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [37] 91.0% -------------------------------------------------------------- hash-ref! [28] 100.0% [33] 212(6.2%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:165:0 sig+exp->bigfloat [39] 54.7% bfcanonicalize [40] 45.3% -------------------------------------------------------------- ->flonum [29] 100.0% [34] 128(3.7%) 128(3.7%) ??? ...ightlies/herbie/develop/src/config.rkt:48:0 -------------------------------------------------------------- map-enodes [30] 100.0% [35] 56(1.6%) 56(1.6%) for-loop ...ie/develop/src/core/simplify.rkt:165:2 -------------------------------------------------------------- ??? [31] 100.0% [36] 1180(34.4%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfadd [41] 100.0% -------------------------------------------------------------- ??? [32] 100.0% [37] 826(24.1%) 826(24.1%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 -------------------------------------------------------------- ??? [31] 100.0% [38] 158(4.6%) 158(4.6%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 -------------------------------------------------------------- bigfloat-hash [33] 100.0% [39] 116(3.4%) 116(3.4%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:385:0 -------------------------------------------------------------- bigfloat-hash [33] 100.0% [40] 96(2.8%) 96(2.8%) bfcanonicalize .../private/bigfloat/mpfr.rkt:155:0 -------------------------------------------------------------- ??? [36] 100.0% [41] 1180(34.4%) 1006(29.3%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [42] 14.7% -------------------------------------------------------------- bfadd [41] 100.0% [42] 174(5.1%) 174(5.1%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 --------------------------------------------------------------