Profiling results ----------------- Total cpu time observed: 64280ms (out of 65740ms) Number of samples taken: 163 (once every 394ms) (Hiding functions with self<1.0% and local<2.0%: 2 of 83 hidden) ========================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================= run [12] 50.0% [1] 64280(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [7] 50.0% loop [17] 34.9% prepare-points [18] 11.9% run-improve39 [8] 1.8% get-final-combination [10] 1.4% ------------------------------------------------------------------------- loop [79] 100.0% [2] 1864(2.9%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [9] 100.0% ------------------------------------------------------------------------- hash-ref! [38] 100.0% [3] 1276(2.0%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:153:5 loop [30] 100.0% ------------------------------------------------------------------------- loop [79] 100.0% [4] 290(0.5%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [9] 100.0% ------------------------------------------------------------------------- for-loop [73] 100.0% [5] 276(0.4%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [11] 100.0% ------------------------------------------------------------------------- f206 [37] 100.0% [6] 250(0.4%) 0(0.0%) inductor .../herbie/develop/src/programs.rkt:119:4 ??? [28] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [7] 64280(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [12] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [8] 2264(3.5%) 0(0.0%) run-improve39 ...ie/develop/src/mainloop.rkt:286:0 setup-prog!32 [14] 88.6% for-loop [16] 11.4% ------------------------------------------------------------------------- syntax-e [4] 13.5% expand-id-application-form17 [2] 86.5% [9] 2154(3.4%) 0(0.0%) syntax-e/no-taint (unknown source) loop [79] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [10] 1864(2.9%) 0(0.0%) get-final-combination ...op/src/mainloop.rkt:309:0 argmins [13] 100.0% ------------------------------------------------------------------------- expand-identifier [5] 100.0% [11] 276(0.4%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [15] 100.0% ------------------------------------------------------------------------- profile-thunk16 [7] 100.0% [12] 64280(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------- best-alt [46] 12.2% get-final-combination [10] 87.8% [13] 2122(3.3%) 0(0.0%) argmins ...ies/herbie/develop/src/common.rkt:142:0 ??? [19] 100.0% ------------------------------------------------------------------------- run-improve39 [8] 100.0% [14] 2006(3.1%) 0(0.0%) setup-prog!32 ...bie/develop/src/mainloop.rkt:63:0 loop [17] 85.6% prepare-points [18] 14.4% ------------------------------------------------------------------------- resolve+shift28 [11] 100.0% [15] 276(0.4%) 0(0.0%) fallback-loop (unknown source) for-loop [73] 100.0% ------------------------------------------------------------------------- run-improve39 [8] 100.0% [16] 258(0.4%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:303:8 run-iter! [20] 100.0% ------------------------------------------------------------------------- setup-prog!32 [14] 3.7% ??? [1] 96.3% [17] 46552(72.4%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:182:2 loop [21] 37.3% loop [25] 33.3% make-exacts* [26] 28.3% ??? [22] 1.2% ------------------------------------------------------------------------- setup-prog!32 [14] 1.8% ??? [1] 98.2% [18] 15606(24.3%) 0(0.0%) prepare-points ...bie/develop/src/points.rkt:156:0 loop [25] 31.9% make-exacts* [26] 29.4% loop [21] 26.8% ??? [22] 11.9% ------------------------------------------------------------------------- argmins [13] 100.0% [19] 2122(3.3%) 0(0.0%) ??? ...lies/herbie/develop/src/mainloop.rkt:110:19 errors [23] 100.0% ------------------------------------------------------------------------- for-loop [16] 100.0% [20] 258(0.4%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:267:0 choose-best-alt! [24] 100.0% ------------------------------------------------------------------------- prepare-points [18] 19.4% loop [17] 80.6% [21] 21552(33.5%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:124:2 make-exacts* [26] 55.9% loop [25] 44.1% ------------------------------------------------------------------------- loop [17] 22.6% prepare-points [18] 77.4% [22] 2402(3.7%) 0(0.0%) ??? ...ghtlies/herbie/develop/src/points.rkt:173:7 for-loop [27] 100.0% ------------------------------------------------------------------------- ??? [19] 100.0% [23] 2122(3.3%) 0(0.0%) errors ...lies/herbie/develop/src/points.rkt:205:0 eval-prog [31] 87.8% for-loop [29] 12.2% ------------------------------------------------------------------------- run-iter! [20] 100.0% [24] 258(0.4%) 0(0.0%) choose-best-alt! ...develop/src/mainloop.rkt:113:0 ??? [28] 100.0% ------------------------------------------------------------------------- prepare-points [18] 16.6% loop [21] 31.7% loop [17] 51.7% [25] 29968(46.6%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:107:4 loop [30] 93.9% ??? [34] 4.2% ------------------------------------------------------------------------- prepare-points [18] 15.4% loop [21] 40.4% loop [17] 44.2% [26] 29788(46.3%) 0(0.0%) make-exacts* ...erbie/develop/src/points.rkt:104:0 loop [30] 81.8% eval-prog [31] 17.0% ------------------------------------------------------------------------- ??? [22] 100.0% [27] 2402(3.7%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:174:9 for-loop [32] 100.0% ------------------------------------------------------------------------- inductor [6] 49.2% choose-best-alt! [24] 50.8% [28] 508(0.8%) 250(0.4%) ??? ...contract/private/arrow-val-first.rkt:388:18 ??? [33] 50.8% ------------------------------------------------------------------------- errors [23] 100.0% [29] 258(0.4%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:208:4 ??? [34] 100.0% ------------------------------------------------------------------------- make-exacts* [26] 0.8% loop [25] 1.3% ??? [3] 2.4% loop [30] 95.5% [30] 53784(83.7%) 318(0.5%) loop ...cket/collects/racket/private/map.rkt:40:19 loop [30] 95.5% hash-ref! [38] 2.4% ??? [34] 2.0% ??? [35] 0.1% ------------------------------------------------------------------------- errors [23] 26.9% make-exacts* [26] 73.1% [31] 6922(10.8%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:109:0 temp68_2 [36] 45.9% f206 [37] 31.3% hash-ref! [38] 18.4% loop [79] 4.3% ------------------------------------------------------------------------- for-loop [27] 100.0% [32] 2402(3.7%) 218(0.3%) for-loop ...s/herbie/develop/src/points.rkt:175:11 ??? [35] 90.9% ------------------------------------------------------------------------- ??? [28] 100.0% [33] 258(0.4%) 0(0.0%) ??? .../herbie/develop/src/core/alt-table.rkt:54:0 ??? [35] 100.0% ------------------------------------------------------------------------- for-loop [29] 0.5% loop [25] 2.4% loop [30] 97.1% [34] 51588(80.3%) 3110(4.8%) ??? ...tlies/herbie/develop/src/programs.rkt:129:2 ??? [39] 74.6% bf [40] 19.3% ------------------------------------------------------------------------- ??? [33] 5.7% loop [30] 46.4% for-loop [32] 47.9% [35] 4556(7.1%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 sample-multi-bounded [42] 47.9% ->flonum [43] 46.4% best-alt [46] 5.7% ------------------------------------------------------------------------- eval-prog [31] 100.0% [36] 3178(4.9%) 0(0.0%) temp68_2 (unknown source) compile16 [41] 100.0% ------------------------------------------------------------------------- eval-prog [31] 49.4% f206 [37] 50.6% [37] 2170(3.4%) 0(0.0%) f206 .../collects/racket/match/compiler.rkt:507:40 f206 [37] 50.6% bf [40] 15.9% ??? [67] 15.5% table-ref [45] 14.1% inductor [6] 3.8% ------------------------------------------------------------------------- eval-prog [31] 29.9% loop [30] 70.1% [38] 1276(2.0%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [3] 70.1% bigfloat-hash [44] 29.9% ------------------------------------------------------------------------- ??? [34] 100.0% [39] 38510(59.9%) 8816(13.7%) ??? ...acket/collects/racket/private/kw.rkt:592:14 ??? [58] 57.9% bf* [47] 9.4% ??? [50] 3.8% ??? [51] 3.1% ...higher-order.rkt:361:33 [52] 2.8% ------------------------------------------------------------------------- f206 [37] 9.4% ??? [34] 90.6% [40] 11004(17.1%) 162(0.3%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [69] 79.0% ??? [70] 19.6% ------------------------------------------------------------------------- temp68_2 [36] 100.0% [41] 3178(4.9%) 0(0.0%) compile16 (unknown source) temp74_0 [48] 100.0% ------------------------------------------------------------------------- ??? [35] 100.0% [42] 2184(3.4%) 326(0.5%) sample-multi-bounded ...evelop/src/points.rkt:43:0 for-loop [49] 85.1% ------------------------------------------------------------------------- ??? [35] 100.0% [43] 2114(3.3%) 1502(2.3%) ->flonum ...s/herbie/develop/src/programs.rkt:36:0 return/no-unsupplied [55] 16.8% ??? [56] 12.1% ------------------------------------------------------------------------- hash-ref! [38] 100.0% [44] 1276(2.0%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bfcanonicalize [53] 79.9% sig+exp->bigfloat [57] 20.1% ------------------------------------------------------------------------- f206 [37] 100.0% [45] 548(0.9%) 0(0.0%) table-ref ...es/herbie/develop/src/common.rkt:47:0 ??? [54] 100.0% ------------------------------------------------------------------------- ??? [35] 100.0% [46] 258(0.4%) 0(0.0%) best-alt .../herbie/develop/src/mainloop.rkt:108:0 argmins [13] 100.0% ------------------------------------------------------------------------- ??? [39] 100.0% [47] 3626(5.6%) 308(0.5%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [58] 91.5% ------------------------------------------------------------------------- compile16 [41] 100.0% [48] 3178(4.9%) 0(0.0%) temp74_0 (unknown source) expand-single [59] 91.9% compile-top9 [62] 8.1% ------------------------------------------------------------------------- sample-multi-bounded [42] 100.0% [49] 1858(2.9%) 1858(2.9%) for-loop ...ies/herbie/develop/src/points.rkt:46:4 ------------------------------------------------------------------------- ??? [39] 100.0% [50] 1462(2.3%) 1462(2.3%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ------------------------------------------------------------------------- ??? [39] 100.0% [51] 1198(1.9%) 670(1.0%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ??? [60] 44.1% ------------------------------------------------------------------------- ??? [39] 100.0% [52] 1092(1.7%) 574(0.9%) ...higher-order.rkt:361:33 (unknown source) ??? [61] 47.4% ------------------------------------------------------------------------- bigfloat-hash [44] 100.0% [53] 1020(1.6%) 1020(1.6%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 ------------------------------------------------------------------------- table-ref [45] 100.0% [54] 548(0.9%) 302(0.5%) ??? ...ects/racket/contract/private/list.rkt:798:4 for-loop [63] 44.9% ------------------------------------------------------------------------- ->flonum [43] 100.0% [55] 356(0.6%) 356(0.6%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 ------------------------------------------------------------------------- ->flonum [43] 100.0% [56] 256(0.4%) 256(0.4%) ??? ...ects/racket/contract/private/guts.rkt:746:8 ------------------------------------------------------------------------- bigfloat-hash [44] 100.0% [57] 256(0.4%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:387:0 new-mpfr [69] 100.0% ------------------------------------------------------------------------- bf* [47] 12.9% ??? [39] 87.1% [58] 25634(39.9%) 5476(8.5%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [64] 60.7% bfsqrt [65] 17.9% ------------------------------------------------------------------------- temp74_0 [48] 100.0% [59] 2920(4.5%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [66] 100.0% ------------------------------------------------------------------------- ??? [51] 100.0% [60] 528(0.8%) 528(0.8%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ------------------------------------------------------------------------- ...higher-order.rkt:361:33 [52] 100.0% [61] 518(0.8%) 518(0.8%) ??? ...cts/racket/contract/private/list.rkt:209:10 ------------------------------------------------------------------------- temp74_0 [48] 100.0% [62] 258(0.4%) 0(0.0%) compile-top9 (unknown source) compile-forms31 [68] 100.0% ------------------------------------------------------------------------- ??? [54] 100.0% [63] 246(0.4%) 0(0.0%) for-loop ...acket/contract/private/list.rkt:804:12 ??? [67] 100.0% ------------------------------------------------------------------------- ??? [58] 100.0% [64] 15562(24.2%) 630(1.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [69] 55.4% ??? [70] 40.5% ------------------------------------------------------------------------- ??? [58] 100.0% [65] 4596(7.1%) 0(0.0%) bfsqrt ...lib/math/private/bigfloat/mpfr.rkt:618:4 ??? [70] 53.2% new-mpfr [69] 46.8% ------------------------------------------------------------------------- loop [79] 9.3% expand-single [59] 90.7% [66] 3218(5.0%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [71] 83.2% dispatch-transformer41 [74] 16.8% ------------------------------------------------------------------------- for-loop [63] 42.3% f206 [37] 57.7% [67] 582(0.9%) 582(0.9%) ??? ...private/unconstrained-domain-arrow.rkt:74:4 ------------------------------------------------------------------------- compile-top9 [62] 100.0% [68] 258(0.4%) 0(0.0%) compile-forms31 (unknown source) for-loop [73] 100.0% ------------------------------------------------------------------------- sig+exp->bigfloat [57] 1.3% bfsqrt [65] 10.9% bfmul [64] 43.7% bf [40] 44.1% [69] 19720(30.7%) 19720(30.7%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------- bf [40] 19.8% bfsqrt [65] 22.4% bfmul [64] 57.8% [70] 10906(17.0%) 10906(17.0%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------- expand-capturing-lifts [66] 100.0% [71] 2678(4.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [72] 100.0% ------------------------------------------------------------------------- lambda-clause-expander [71] 22.2% for-loop [73] 77.8% [72] 2678(4.2%) 0(0.0%) finish-bodys (unknown source) for-loop [73] 100.0% ------------------------------------------------------------------------- fallback-loop [15] 0.9% for-loop [73] 4.5% compile-forms31 [68] 8.8% finish-bodys [72] 85.8% [73] 2936(4.6%) 782(1.2%) for-loop (unknown source) finish-bodys [72] 66.3% loop [79] 15.9% for-loop [73] 4.5% dispatch-transformer41 [74] 1.4% expand-identifier [5] 0.9% ------------------------------------------------------------------------- for-loop [73] 34.9% expand-capturing-lifts [66] 65.1% [74] 830(1.3%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [75] 100.0% ------------------------------------------------------------------------- dispatch-transformer41 [74] 100.0% [75] 830(1.3%) 540(0.8%) apply-transformer52 (unknown source) apply-transformer-in-context [76] 34.9% ------------------------------------------------------------------------- apply-transformer52 [75] 100.0% [76] 290(0.5%) 0(0.0%) apply-transformer-in-context (unknown source) parse-app [77] 100.0% ------------------------------------------------------------------------- apply-transformer-in-context [76]100.0% [77] 290(0.5%) 0(0.0%) parse-app ...collects/racket/private/kw.rkt:1105:2 syntax->list [78] 100.0% ------------------------------------------------------------------------- parse-app [77] 100.0% [78] 290(0.5%) 0(0.0%) syntax->list (unknown source) loop [79] 100.0% ------------------------------------------------------------------------- syntax->list [78] 5.9% eval-prog [31] 12.2% for-loop [73] 38.0% syntax-e/no-taint [9] 43.9% [79] 2452(3.8%) 0(0.0%) loop (unknown source) gf [80] 43.9% expand-id-application-form17 [2] 38.0% expand-capturing-lifts [66] 12.2% syntax-e [4] 5.9% ------------------------------------------------------------------------- loop [79] 100.0% [80] 2154(3.4%) 290(0.5%) gf (unknown source) cache-or-reuse-set [81] 86.5% ------------------------------------------------------------------------- gf [80] 100.0% [81] 1864(2.9%) 1864(2.9%) cache-or-reuse-set (unknown source) -------------------------------------------------------------------------