Profiling results ----------------- Total cpu time observed: 23374ms (out of 24016ms) Number of samples taken: 64 (once every 365ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== ??? [4] 100.0% [1] 23374(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ---------------------------------------------------------------------- hash-ref! [31] 100.0% [2] 312(1.3%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:153:5 loop [24] 100.0% ---------------------------------------------------------------------- profile-thunk16 [1] 100.0% [3] 23374(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [4] 100.0% ---------------------------------------------------------------------- run [3] 50.0% [4] 23374(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% loop [10] 46.4% run-improve39 [5] 3.1% get-final-combination [6] 0.5% ---------------------------------------------------------------------- ??? [4] 100.0% [5] 1434(6.1%) 0(0.0%) run-improve39 ...ie/develop/src/mainloop.rkt:287:0 setup-prog!32 [7] 66.5% for-loop [8] 18.1% for-loop [9] 15.3% ---------------------------------------------------------------------- ??? [4] 100.0% [6] 252(1.1%) 0(0.0%) get-final-combination ...op/src/mainloop.rkt:310:0 ??? [11] 100.0% ---------------------------------------------------------------------- run-improve39 [5] 100.0% [7] 954(4.1%) 0(0.0%) setup-prog!32 ...bie/develop/src/mainloop.rkt:63:0 loop [10] 100.0% ---------------------------------------------------------------------- run-improve39 [5] 100.0% [8] 260(1.1%) 0(0.0%) for-loop ...herbie/develop/src/mainloop.rkt:299:29 ??? [11] 100.0% ---------------------------------------------------------------------- run-improve39 [5] 100.0% [9] 220(0.9%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:304:8 run-iter! [12] 100.0% ---------------------------------------------------------------------- setup-prog!32 [7] 4.2% ??? [4] 95.8% [10] 22642(96.9%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:166:2 loop [19] 51.3% loop [13] 31.4% make-exacts* [20] 8.7% make-exacts [14] 4.5% for-loop [15] 2.6% debug7 [17] 1.5% ---------------------------------------------------------------------- get-final-combination [6] 49.2% for-loop [8] 50.8% [11] 512(2.2%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:31:0 iterate-egraph!7 [16] 100.0% ---------------------------------------------------------------------- for-loop [9] 100.0% [12] 220(0.9%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:268:0 choose-best-alt! [18] 100.0% ---------------------------------------------------------------------- loop [10] 100.0% [13] 7114(30.4%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:124:2 loop [19] 58.1% make-exacts* [20] 37.5% eval-prog [25] 4.4% ---------------------------------------------------------------------- loop [10] 100.0% [14] 1018(4.4%) 0(0.0%) make-exacts ...herbie/develop/src/points.rkt:122:0 make-exacts* [20] 100.0% ---------------------------------------------------------------------- loop [10] 100.0% [15] 594(2.5%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:181:19 for-loop [21] 100.0% ---------------------------------------------------------------------- ??? [11] 100.0% [16] 512(2.2%) 0(0.0%) iterate-egraph!7 ...lop/src/core/simplify.rkt:55:0 one-iter [23] 100.0% ---------------------------------------------------------------------- loop [10] 100.0% [17] 334(1.4%) 0(0.0%) debug7 ...tlies/herbie/develop/src/debug.rkt:102:0 ??? [22] 100.0% ---------------------------------------------------------------------- run-iter! [12] 100.0% [18] 220(0.9%) 0(0.0%) choose-best-alt! ...develop/src/mainloop.rkt:114:0 ??? [22] 100.0% ---------------------------------------------------------------------- loop [13] 26.2% loop [10] 73.8% [19] 15748(67.4%) 326(1.4%) loop ...htlies/herbie/develop/src/points.rkt:107:4 loop [24] 97.9% ---------------------------------------------------------------------- make-exacts [14] 18.0% loop [10] 34.8% loop [13] 47.2% [20] 5654(24.2%) 0(0.0%) make-exacts* ...erbie/develop/src/points.rkt:104:0 loop [24] 82.8% eval-prog [25] 17.2% ---------------------------------------------------------------------- for-loop [15] 100.0% [21] 594(2.5%) 304(1.3%) for-loop ...es/herbie/develop/src/points.rkt:158:4 ??? [28] 48.8% ---------------------------------------------------------------------- choose-best-alt! [18] 39.7% debug7 [17] 60.3% [22] 554(2.4%) 334(1.4%) ??? ...contract/private/arrow-val-first.rkt:388:18 ??? [27] 39.7% ---------------------------------------------------------------------- iterate-egraph!7 [16] 100.0% [23] 512(2.2%) 252(1.1%) one-iter ...bie/develop/src/core/simplify.rkt:66:0 for-loop [26] 50.8% ---------------------------------------------------------------------- loop [19] 0.9% ??? [2] 1.5% make-exacts* [20] 2.5% loop [24] 95.0% [24] 20418(87.4%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:40:19 loop [24] 95.0% ??? [52] 3.3% hash-ref! [31] 1.5% ??? [28] 0.2% ---------------------------------------------------------------------- loop [13] 24.3% make-exacts* [20] 75.7% [25] 1282(5.5%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:109:0 temp68_2 [29] 47.1% f206 [30] 28.5% hash-ref! [31] 24.3% ---------------------------------------------------------------------- one-iter [23] 100.0% [26] 260(1.1%) 0(0.0%) for-loop ...ie/develop/src/core/simplify.rkt:113:2 custom-set-intersect [32] 100.0% ---------------------------------------------------------------------- ??? [22] 100.0% [27] 220(0.9%) 0(0.0%) ??? .../herbie/develop/src/core/alt-table.rkt:54:0 ??? [28] 100.0% ---------------------------------------------------------------------- ??? [27] 5.6% for-loop [21] 7.4% loop [24] 87.0% [28] 3924(16.8%) 634(2.7%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [33] 70.8% sample-multi-bounded [36] 7.4% best-alt [38] 5.6% ---------------------------------------------------------------------- eval-prog [25] 100.0% [29] 604(2.6%) 0(0.0%) temp68_2 (unknown source) compile16 [34] 100.0% ---------------------------------------------------------------------- f206 [30] 50.0% eval-prog [25] 50.0% [30] 366(1.6%) 0(0.0%) f206 .../collects/racket/match/compiler.rkt:507:40 f206 [30] 50.0% bf [54] 50.0% ---------------------------------------------------------------------- eval-prog [25] 33.3% loop [24] 66.7% [31] 312(1.3%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 66.7% bigfloat-hash [35] 33.3% ---------------------------------------------------------------------- for-loop [26] 100.0% [32] 260(1.1%) 0(0.0%) custom-set-intersect ...rivate/set-types.rkt:195:0 for-loop [37] 100.0% ---------------------------------------------------------------------- ??? [28] 100.0% [33] 2780(11.9%) 2392(10.2%) ->flonum ...s/herbie/develop/src/programs.rkt:36:0 list-member? [40] 14.0% ---------------------------------------------------------------------- temp68_2 [29] 100.0% [34] 604(2.6%) 0(0.0%) compile16 (unknown source) temp74_0 [39] 100.0% ---------------------------------------------------------------------- hash-ref! [31] 100.0% [35] 312(1.3%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bigfloat->sig+exp [41] 100.0% ---------------------------------------------------------------------- ??? [28] 100.0% [36] 290(1.2%) 0(0.0%) sample-multi-bounded ...evelop/src/points.rkt:43:0 loop [42] 100.0% ---------------------------------------------------------------------- custom-set-intersect [32] 100.0% [37] 260(1.1%) 260(1.1%) for-loop ...cts/racket/private/set-types.rkt:152:2 ---------------------------------------------------------------------- ??? [28] 100.0% [38] 220(0.9%) 0(0.0%) best-alt .../herbie/develop/src/mainloop.rkt:109:0 argmins [43] 100.0% ---------------------------------------------------------------------- compile16 [34] 100.0% [39] 604(2.6%) 0(0.0%) temp74_0 (unknown source) expand-single [44] 100.0% ---------------------------------------------------------------------- ->flonum [33] 100.0% [40] 388(1.7%) 388(1.7%) list-member? ...llects/racket/private/set.rkt:24:0 ---------------------------------------------------------------------- bigfloat-hash [35] 100.0% [41] 312(1.3%) 0(0.0%) bigfloat->sig+exp ...ivate/bigfloat/mpfr.rkt:372:0 new-mpz [45] 100.0% ---------------------------------------------------------------------- sample-multi-bounded [36] 100.0% [42] 290(1.2%) 0(0.0%) loop ...ghtlies/herbie/develop/src/points.rkt:65:6 random-exp [46] 100.0% ---------------------------------------------------------------------- best-alt [38] 100.0% [43] 220(0.9%) 0(0.0%) argmins ...ies/herbie/develop/src/common.rkt:142:0 ??? [47] 100.0% ---------------------------------------------------------------------- temp74_0 [39] 100.0% [44] 604(2.6%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [48] 100.0% ---------------------------------------------------------------------- bigfloat->sig+exp [41] 100.0% [45] 312(1.3%) 312(1.3%) new-mpz ...-lib/math/private/bigfloat/gmp.rkt:73:0 ---------------------------------------------------------------------- loop [42] 100.0% [46] 290(1.2%) 290(1.2%) random-exp .../herbie/develop/src/common.rkt:243:0 ---------------------------------------------------------------------- argmins [43] 100.0% [47] 220(0.9%) 0(0.0%) ??? ...lies/herbie/develop/src/mainloop.rkt:111:19 errors [49] 100.0% ---------------------------------------------------------------------- expand-single [44] 100.0% [48] 604(2.6%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [50] 100.0% ---------------------------------------------------------------------- ??? [47] 100.0% [49] 220(0.9%) 0(0.0%) errors ...lies/herbie/develop/src/points.rkt:207:0 for-loop [51] 100.0% ---------------------------------------------------------------------- expand-capturing-lifts [48] 100.0% [50] 604(2.6%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [53] 100.0% ---------------------------------------------------------------------- errors [49] 100.0% [51] 220(0.9%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:210:4 ??? [52] 100.0% ---------------------------------------------------------------------- for-loop [51] 1.3% loop [24] 98.7% [52] 16912(72.4%) 2400(10.3%) ??? ...tlies/herbie/develop/src/programs.rkt:129:2 ??? [55] 43.9% bf [54] 41.9% ---------------------------------------------------------------------- lambda-clause-expander [50] 100.0% [53] 604(2.6%) 0(0.0%) finish-bodys (unknown source) for-loop [56] 100.0% ---------------------------------------------------------------------- f206 [30] 4.9% ??? [52] 95.1% [54] 7446(31.9%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [64] 74.7% ??? [65] 25.3% ---------------------------------------------------------------------- ??? [52] 100.0% [55] 7432(31.8%) 2380(10.2%) ??? ...acket/collects/racket/private/kw.rkt:592:14 ??? [57] 56.0% ...higher-order.rkt:361:33 [58] 4.8% ??? [59] 4.2% ??? [61] 3.0% ---------------------------------------------------------------------- for-loop [56] 25.8% finish-bodys [53] 74.2% [56] 604(2.6%) 292(1.2%) for-loop (unknown source) for-loop [56] 25.8% syntax-e [60] 25.8% ---------------------------------------------------------------------- ??? [55] 100.0% [57] 4164(17.8%) 1836(7.9%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfexpt [62] 55.9% ---------------------------------------------------------------------- ??? [55] 100.0% [58] 356(1.5%) 356(1.5%) ...higher-order.rkt:361:33 (unknown source) ---------------------------------------------------------------------- ??? [55] 100.0% [59] 312(1.3%) 312(1.3%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ---------------------------------------------------------------------- for-loop [56] 100.0% [60] 312(1.3%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [63] 100.0% ---------------------------------------------------------------------- ??? [55] 100.0% [61] 220(0.9%) 220(0.9%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ---------------------------------------------------------------------- ??? [57] 100.0% [62] 2328(10.0%) 0(0.0%) bfexpt ...lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [64] 74.2% ??? [65] 25.8% ---------------------------------------------------------------------- syntax-e [60] 100.0% [63] 312(1.3%) 0(0.0%) syntax-e/no-taint (unknown source) loop [66] 100.0% ---------------------------------------------------------------------- bfexpt [62] 23.7% bf [54] 76.3% [64] 7288(31.2%) 7288(31.2%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ---------------------------------------------------------------------- bfexpt [62] 24.1% bf [54] 75.9% [65] 2486(10.6%) 2486(10.6%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ---------------------------------------------------------------------- syntax-e/no-taint [63] 100.0% [66] 312(1.3%) 0(0.0%) loop (unknown source) gf [67] 100.0% ---------------------------------------------------------------------- loop [66] 100.0% [67] 312(1.3%) 0(0.0%) gf (unknown source) propagation-apply-shifted [68] 100.0% ---------------------------------------------------------------------- gf [67] 100.0% [68] 312(1.3%) 312(1.3%) propagation-apply-shifted (unknown source) ----------------------------------------------------------------------