Profiling results ----------------- Total cpu time observed: 46968ms (out of 48152ms) Number of samples taken: 197 (once every 238ms) (Hiding functions with self<1.0% and local<2.0%: 2 of 39 hidden) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== run [6] 48.4% [1] 46968(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 run-improve58 [3] 52.0% profile-thunk14 [4] 48.0% ---------------------------------------------------------------------- hash-ref! [15] 100.0% [2] 628(1.3%) 0(0.0%) ??? /home/ztatlock/herbie/src/programs.rkt:197:5 loop [12] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [3] 46968(100.0%) 0(0.0%) run-improve58 ...ock/herbie/src/mainloop.rkt:242:0 loop [5] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [4] 45044(95.9%) 0(0.0%) profile-thunk14 ...t/pkgs/profile-lib/main.rkt:9:0 run [6] 100.0% ---------------------------------------------------------------------- run-improve58 [3] 100.0% [5] 46968(100.0%) 0(0.0%) loop /home/ztatlock/herbie/src/points.rkt:122:2 loop [8] 58.3% loop [7] 41.2% ---------------------------------------------------------------------- profile-thunk14 [4] 99.5% [6] 45258(96.4%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:31:2 ??? [1] 100.0% ---------------------------------------------------------------------- loop [5] 100.0% [7] 19350(41.2%) 0(0.0%) loop /home/ztatlock/herbie/src/points.rkt:93:2 make-exacts* [9] 62.9% loop [8] 28.3% eval-prog [11] 8.8% ---------------------------------------------------------------------- loop [7] 16.6% loop [5] 83.4% [8] 32876(70.0%) 196(0.4%) loop /home/ztatlock/herbie/src/points.rkt:83:4 map [10] 99.4% ---------------------------------------------------------------------- loop [7] 100.0% [9] 12166(25.9%) 204(0.4%) make-exacts* ...tatlock/herbie/src/points.rkt:80:0 map [10] 52.8% loop [12] 43.8% eval-prog [11] 1.7% ---------------------------------------------------------------------- make-exacts* [9] 16.4% loop [8] 83.6% [10] 39104(83.3%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:21:13 loop [12] 94.1% ??? [13] 5.3% ->flonum [14] 0.6% ---------------------------------------------------------------------- make-exacts* [9] 10.8% loop [7] 89.2% [11] 1920(4.1%) 1096(2.3%) eval-prog ...tatlock/herbie/src/programs.rkt:162:0 hash-ref! [15] 42.9% ---------------------------------------------------------------------- ??? [2] 1.5% make-exacts* [9] 2.7% map [10] 12.4% loop [12] 83.4% [12] 42770(91.1%) 902(1.9%) loop ...cket/collects/racket/private/map.rkt:26:19 loop [12] 83.4% ??? [13] 14.3% hash-ref! [15] 1.5% ->flonum [14] 0.2% ---------------------------------------------------------------------- map [10] 4.9% loop [12] 95.1% [13] 42260(90.0%) 3624(7.7%) ??? /home/ztatlock/herbie/src/programs.rkt:168:4 ??? [16] 55.3% real->bigfloat [17] 26.8% ??? [29] 8.9% ---------------------------------------------------------------------- map [10] 17.0% loop [12] 83.0% [14] 1272(2.7%) 0(0.0%) ->flonum ...ock/herbie/src/syntax/syntax.rkt:224:0 ??? [32] 100.0% ---------------------------------------------------------------------- eval-prog [11] 45.8% loop [12] 54.2% [15] 824(1.8%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 ??? [2] 54.2% bigfloat-hash [18] 45.8% ---------------------------------------------------------------------- ??? [13] 100.0% [16] 23376(49.8%) 710(1.5%) ??? ...acket/collects/racket/private/kw.rkt:400:14 ??? [26] 48.1% bffmod [19] 42.2% ...ow-val-first.rkt:357:18 [23] 4.7% ...higher-order.rkt:373:33 [20] 2.0% ---------------------------------------------------------------------- ??? [13] 100.0% [17] 11314(24.1%) 9852(21.0%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [33] 12.9% ---------------------------------------------------------------------- hash-ref! [15] 100.0% [18] 824(1.8%) 196(0.4%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:165:0 bfcanonicalize [21] 51.0% bigfloat->sig+exp [22] 25.2% ---------------------------------------------------------------------- ??? [16] 100.0% [19] 9862(21.0%) 0(0.0%) bffmod ...tlock/herbie/src/syntax/syntax.rkt:128:0 ??? [26] 52.2% bf* [24] 28.4% ...ow-val-first.rkt:357:18 [23] 19.5% ---------------------------------------------------------------------- ??? [16] 100.0% [20] 476(1.0%) 0(0.0%) ...higher-order.rkt:373:33 (unknown source) ??? [29] 50.4% ??? [27] 49.6% ---------------------------------------------------------------------- bigfloat-hash [18] 100.0% [21] 420(0.9%) 420(0.9%) bfcanonicalize .../private/bigfloat/mpfr.rkt:155:0 ---------------------------------------------------------------------- bigfloat-hash [18] 100.0% [22] 208(0.4%) 0(0.0%) bigfloat->sig+exp ...ivate/bigfloat/mpfr.rkt:370:0 new-mpz [25] 100.0% ---------------------------------------------------------------------- ??? [16] 36.2% bffmod [19] 63.8% [23] 3008(6.4%) 0(0.0%) ...ow-val-first.rkt:357:18 (unknown source) ??? [27] 73.5% ??? [29] 26.5% ---------------------------------------------------------------------- bffmod [19] 100.0% [24] 2798(6.0%) 208(0.4%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [26] 92.6% ---------------------------------------------------------------------- bigfloat->sig+exp [22] 100.0% [25] 208(0.4%) 208(0.4%) new-mpz ...-lib/math/private/bigfloat/gmp.rkt:73:0 ---------------------------------------------------------------------- bf* [24] 13.7% bffmod [19] 27.1% ??? [16] 59.2% [26] 18974(40.4%) 1722(3.7%) ??? ...-racket/utils/simple-result-arrow.rkt:26:12 bfdiv [28] 48.5% ??? [32] 23.8% bfasin [30] 13.9% bffloor [31] 4.7% ---------------------------------------------------------------------- ...higher-order.rkt:373:33 [20] 9.6% ...ow-val-first.rkt:357:18 [23] 90.4% [27] 2446(5.2%) 0(0.0%) ??? ...cts/racket/contract/private/list.rkt:187:10 ??? [29] 100.0% ---------------------------------------------------------------------- ??? [26] 100.0% [28] 9210(19.6%) 6416(13.7%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [33] 30.3% ---------------------------------------------------------------------- ...higher-order.rkt:373:33 [20] 3.3% ...ow-val-first.rkt:357:18 [23] 11.0% ??? [27] 33.8% ??? [13] 51.9% [29] 7236(15.4%) 236(0.5%) ??? ...ects/racket/contract/private/guts.rkt:638:8 ??? [32] 96.7% ---------------------------------------------------------------------- ??? [26] 100.0% [30] 2630(5.6%) 1754(3.7%) bfasin ...lib/math/private/bigfloat/mpfr.rkt:616:4 ??? [33] 33.3% ---------------------------------------------------------------------- ??? [26] 100.0% [31] 888(1.9%) 0(0.0%) bffloor ...ib/math/private/bigfloat/mpfr.rkt:714:4 ??? [33] 100.0% ---------------------------------------------------------------------- ->flonum [14] 9.9% ??? [26] 35.4% ??? [29] 54.7% [32] 12796(27.2%) 6084(13.0%) ??? ...tract/private/arrow-higher-order.rkt:373:33 ??? [34] 45.7% ??? [35] 6.8% ---------------------------------------------------------------------- bfasin [30] 14.6% bffloor [31] 14.8% real->bigfloat [17] 24.3% bfdiv [28] 46.4% [33] 6020(12.8%) 6020(12.8%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ---------------------------------------------------------------------- ??? [32] 100.0% [34] 5842(12.4%) 2180(4.6%) ??? ...llects/racket/contract/combinator.rkt:178:4 any-wrap/traverse [36] 62.7% ---------------------------------------------------------------------- ??? [32] 100.0% [35] 870(1.9%) 632(1.3%) ??? ...ects/racket/contract/private/prop.rkt:489:4 ??? [37] 27.4% ---------------------------------------------------------------------- ??? [34] 100.0% [36] 3662(7.8%) 3662(7.8%) any-wrap/traverse ...cket/utils/any-wrap.rkt:106:2 ---------------------------------------------------------------------- ??? [35] 100.0% [37] 238(0.5%) 238(0.5%) ??? ...lects/racket/contract/private/orc.rkt:73:14 ----------------------------------------------------------------------