Profiling results ----------------- Total cpu time observed: 57682ms (out of 58852ms) Number of samples taken: 143 (once every 403ms) (Hiding functions with self<1.0% and local<2.0%: 1 of 55 hidden) ======================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================= ??? [3] 100.0% [1] 56958(98.7%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [2] 100.0% ----------------------------------------------------------------------- profile-thunk16 [1] 100.0% [2] 56958(98.7%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [3] 100.0% ----------------------------------------------------------------------- run [2] 49.4% [3] 57682(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 49.4% loop [5] 49.2% run-improve50 [4] 1.4% ----------------------------------------------------------------------- ??? [3] 100.0% [4] 1626(2.8%) 0(0.0%) run-improve50 ...ie/develop/src/mainloop.rkt:234:0 loop [5] 59.2% for-loop [6] 21.2% setup-alt-simplified [7] 19.7% ----------------------------------------------------------------------- run-improve50 [4] 1.7% ??? [3] 98.3% [5] 57018(98.8%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:205:2 loop [8] 34.5% loop [12] 33.2% make-exacts* [13] 27.5% for-loop [9] 4.8% ----------------------------------------------------------------------- run-improve50 [4] 100.0% [6] 344(0.6%) 0(0.0%) for-loop ...herbie/develop/src/mainloop.rkt:249:10 run-iter! [10] 100.0% ----------------------------------------------------------------------- run-improve50 [4] 100.0% [7] 320(0.6%) 0(0.0%) setup-alt-simplified .../develop/src/glue.rkt:49:0 simplify-alt [11] 100.0% ----------------------------------------------------------------------- loop [5] 100.0% [8] 19666(34.1%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:158:2 make-exacts* [13] 57.4% loop [12] 42.6% ----------------------------------------------------------------------- loop [5] 100.0% [9] 2724(4.7%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:222:26 for-loop [14] 100.0% ----------------------------------------------------------------------- for-loop [6] 100.0% [10] 344(0.6%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:215:0 localize-error [15] 100.0% ----------------------------------------------------------------------- setup-alt-simplified [7] 100.0% [11] 320(0.6%) 0(0.0%) simplify-alt ...s/herbie/develop/src/glue.rkt:76:0 ??? [25] 100.0% ----------------------------------------------------------------------- loop [8] 30.7% loop [5] 69.3% [12] 27324(47.4%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:141:4 loop [16] 100.0% ----------------------------------------------------------------------- loop [8] 41.8% loop [5] 58.2% [13] 26970(46.8%) 0(0.0%) make-exacts* ...erbie/develop/src/points.rkt:138:0 loop [16] 97.3% eval-prog [17] 2.7% ----------------------------------------------------------------------- for-loop [9] 100.0% [14] 2724(4.7%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:223:28 ??? [23] 100.0% ----------------------------------------------------------------------- run-iter! [10] 100.0% [15] 344(0.6%) 0(0.0%) localize-error ...velop/src/core/localize.rkt:47:0 hash-ref! [18] 100.0% ----------------------------------------------------------------------- loop [12] 1.1% make-exacts* [13] 2.7% loop [16] 96.2% [16] 53568(92.9%) 766(1.3%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [16] 96.2% ??? [19] 3.4% ??? [23] 0.4% ----------------------------------------------------------------------- make-exacts* [13] 100.0% [17] 726(1.3%) 310(0.5%) eval-prog ...herbie/develop/src/programs.rkt:148:0 f137 [20] 57.3% ----------------------------------------------------------------------- localize-error [15] 100.0% [18] 344(0.6%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 parse-loop12 [27] 100.0% ----------------------------------------------------------------------- loop [16] 100.0% [19] 50670(87.8%) 980(1.7%) ??? ...tlies/herbie/develop/src/programs.rkt:154:4 ??? [21] 74.0% ??? [22] 24.1% ----------------------------------------------------------------------- eval-prog [17] 33.3% f137 [20] 66.7% [20] 416(0.7%) 0(0.0%) f137 .../collects/racket/match/compiler.rkt:507:40 f137 [20] 66.7% ??? [23] 33.3% ----------------------------------------------------------------------- ??? [19] 100.0% [21] 37480(65.0%) 6684(11.6%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [37] 76.6% ...higher-order.rkt:346:33 [26] 1.9% ??? [28] 1.8% parse-loop12 [27] 0.9% ----------------------------------------------------------------------- ??? [19] 100.0% [22] 12210(21.2%) 0(0.0%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [24] 100.0% ----------------------------------------------------------------------- f137 [20] 7.9% loop [16] 40.4% for-loop [14] 51.7% [23] 5272(9.1%) 368(0.6%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ??? [25] 85.1% ??? [52] 7.9% ----------------------------------------------------------------------- ??? [22] 100.0% [24] 12210(21.2%) 9394(16.3%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [44] 23.1% ----------------------------------------------------------------------- ??? [25] 3.3% simplify-alt [11] 3.3% ??? [23] 93.3% [25] 4808(8.3%) 1838(3.2%) ??? ...llects/racket/private/norm-define.rkt:53:83 ??? [29] 21.6% for-loop [30] 13.2% return/no-unsupplied [33] 7.1% list-member? [34] 6.9% loop [36] 6.4% ??? [25] 3.3% mk-egraph [35] 3.3% ----------------------------------------------------------------------- ??? [21] 100.0% [26] 710(1.2%) 0(0.0%) ...higher-order.rkt:346:33 (unknown source) ??? [50] 100.0% ----------------------------------------------------------------------- hash-ref! [18] 49.3% ??? [21] 50.7% [27] 698(1.2%) 354(0.6%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 bf* [32] 49.3% ----------------------------------------------------------------------- ??? [21] 100.0% [28] 666(1.2%) 322(0.6%) ??? ...ects/racket/contract/private/prop.rkt:493:4 ??? [31] 51.7% ----------------------------------------------------------------------- ??? [25] 100.0% [29] 1040(1.8%) 0(0.0%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [38] 100.0% ----------------------------------------------------------------------- ??? [25] 100.0% [30] 634(1.1%) 634(1.1%) for-loop ...ies/herbie/develop/src/points.rkt:47:4 ----------------------------------------------------------------------- ??? [28] 100.0% [31] 344(0.6%) 344(0.6%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ----------------------------------------------------------------------- parse-loop12 [27] 100.0% [32] 344(0.6%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [37] 100.0% ----------------------------------------------------------------------- ??? [25] 100.0% [33] 340(0.6%) 340(0.6%) return/no-unsupplied ...ct/private/arr-i.rkt:533:0 ----------------------------------------------------------------------- ??? [25] 100.0% [34] 330(0.6%) 330(0.6%) list-member? ...llects/racket/private/set.rkt:24:0 ----------------------------------------------------------------------- ??? [25] 100.0% [35] 320(0.6%) 0(0.0%) mk-egraph ...bie/develop/src/core/egraph.rkt:131:0 mk-enode-rec! [39] 100.0% ----------------------------------------------------------------------- ??? [25] 100.0% [36] 306(0.5%) 0(0.0%) loop ...ghtlies/herbie/develop/src/points.rkt:66:6 random-exp [40] 100.0% ----------------------------------------------------------------------- bf* [32] 1.2% ??? [21] 98.8% [37] 29060(50.4%) 11936(20.7%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bflog [41] 52.8% bfmul [42] 6.2% ----------------------------------------------------------------------- ??? [29] 100.0% [38] 1040(1.8%) 1040(1.8%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ----------------------------------------------------------------------- mk-enode-rec! [39] 50.0% mk-egraph [35] 50.0% [39] 320(0.6%) 0(0.0%) mk-enode-rec! ...develop/src/core/egraph.rkt:122:0 mk-enode-rec! [39] 50.0% mk-enode! [43] 50.0% ----------------------------------------------------------------------- loop [36] 100.0% [40] 306(0.5%) 306(0.5%) random-exp .../herbie/develop/src/common.rkt:251:0 ----------------------------------------------------------------------- ??? [37] 100.0% [41] 15334(26.6%) 11396(19.8%) bflog ...-lib/math/private/bigfloat/mpfr.rkt:616:4 ??? [44] 25.7% ----------------------------------------------------------------------- ??? [37] 100.0% [42] 1790(3.1%) 1088(1.9%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [44] 39.2% ----------------------------------------------------------------------- mk-enode-rec! [39] 100.0% [43] 320(0.6%) 0(0.0%) mk-enode! ...bie/develop/src/core/egraph.rkt:102:0 new-enode [45] 100.0% ----------------------------------------------------------------------- bfmul [42] 9.4% real->bigfloat [24] 37.8% bflog [41] 52.8% [44] 7456(12.9%) 7456(12.9%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ----------------------------------------------------------------------- mk-enode! [43] 100.0% [45] 320(0.6%) 0(0.0%) new-enode ...erbie/develop/src/core/enode.rkt:97:0 type-of-enode-expr [46] 100.0% ----------------------------------------------------------------------- new-enode [45] 100.0% [46] 320(0.6%) 0(0.0%) type-of-enode-expr ...elop/src/core/enode.rkt:68:0 get-sigs [47] 100.0% ----------------------------------------------------------------------- type-of-enode-expr [46] 100.0% [47] 320(0.6%) 0(0.0%) get-sigs .../herbie/develop/src/type-check.rkt:5:0 ??? [48] 100.0% ----------------------------------------------------------------------- get-sigs [47] 100.0% [48] 320(0.6%) 0(0.0%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 for-loop [49] 100.0% ----------------------------------------------------------------------- ??? [48] 100.0% [49] 320(0.6%) 0(0.0%) for-loop ...racket/contract/private/hash.rkt:239:6 ??? [50] 100.0% ----------------------------------------------------------------------- for-loop [49] 31.1% ...higher-order.rkt:346:33 [26] 68.9% [50] 1030(1.8%) 710(1.2%) ??? ...cts/racket/contract/private/list.rkt:187:10 ??? [51] 31.1% ----------------------------------------------------------------------- ??? [50] 100.0% [51] 320(0.6%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:686:7 ??? [52] 100.0% ----------------------------------------------------------------------- ??? [51] 43.5% ??? [23] 56.5% [52] 736(1.3%) 320(0.6%) ??? ...ects/racket/contract/private/guts.rkt:644:8 ??? [53] 56.5% ----------------------------------------------------------------------- ??? [52] 100.0% [53] 416(0.7%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:357:18 hash-has-key? [54] 100.0% ----------------------------------------------------------------------- ??? [53] 100.0% [54] 416(0.7%) 416(0.7%) hash-has-key? ...et/private/more-scheme.rkt:368:13 -----------------------------------------------------------------------