Profiling results ----------------- Total cpu time observed: 85720ms (out of 86836ms) Number of samples taken: 300 (once every 286ms) (Hiding functions with self<1.0% and local<2.0%: 2 of 81 hidden) ========================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================= run [10] 50.0% [1] 85720(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [7] 50.0% run-improve40 [6] 50.0% ------------------------------------------------------------------------- hash-ref! [28] 100.0% [2] 5392(6.3%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:189:5 loop [22] 100.0% ------------------------------------------------------------------------- expand-capturing-lifts [58] 37.2% for-loop [70] 62.8% [3] 866(1.0%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [8] 100.0% ------------------------------------------------------------------------- for-loop [70] 100.0% [4] 322(0.4%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [9] 100.0% ------------------------------------------------------------------------- for-loop [70] 100.0% [5] 250(0.3%) 0(0.0%) expand-implicit (unknown source) resolve+shift28 [9] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [6] 85720(100.0%) 0(0.0%) run-improve40 ...ie/develop/src/mainloop.rkt:336:0 loop [11] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [7] 85720(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [10] 100.0% ------------------------------------------------------------------------- dispatch-transformer41 [3] 100.0% [8] 866(1.0%) 266(0.3%) apply-transformer52 (unknown source) apply-transformer-in-context [13] 37.2% loop [74] 32.1% ------------------------------------------------------------------------- expand-id-application-form17 [76] 30.2% expand-implicit [5] 30.5% expand-identifier [4] 39.3% [9] 820(1.0%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [12] 100.0% ------------------------------------------------------------------------- profile-thunk16 [7] 100.0% [10] 85720(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------- run-improve40 [6] 100.0% [11] 85720(100.0%) 204(0.2%) loop ...htlies/herbie/develop/src/points.rkt:304:2 loop [14] 35.7% loop [19] 24.7% make-exacts-walkup [18] 24.3% make-exacts-halfpoints [15] 12.9% for-loop [16] 2.2% ------------------------------------------------------------------------- resolve+shift28 [9] 100.0% [12] 820(1.0%) 322(0.4%) fallback-loop (unknown source) for-loop [70] 60.7% ------------------------------------------------------------------------- apply-transformer52 [8] 100.0% [13] 322(0.4%) 0(0.0%) apply-transformer-in-context (unknown source) parse-lambda [17] 100.0% ------------------------------------------------------------------------- loop [11] 100.0% [14] 30580(35.7%) 276(0.3%) loop ...htlies/herbie/develop/src/points.rkt:265:2 loop [19] 46.7% make-exacts-walkup [18] 44.7% eval-prog [23] 7.6% ------------------------------------------------------------------------- loop [11] 100.0% [15] 11046(12.9%) 0(0.0%) make-exacts-halfpoints ...lop/src/points.rkt:263:0 make-exacts-walkup [18] 79.2% loop [19] 20.8% ------------------------------------------------------------------------- loop [11] 100.0% [16] 1910(2.2%) 310(0.4%) for-loop ...s/herbie/develop/src/points.rkt:323:31 for-loop [20] 83.8% ------------------------------------------------------------------------- apply-transformer-in-context [13]100.0% [17] 322(0.4%) 0(0.0%) parse-lambda ...llects/racket/private/kw.rkt:585:2 stx-pair? [21] 100.0% ------------------------------------------------------------------------- make-exacts-halfpoints [15] 20.2% loop [14] 31.6% loop [11] 48.1% [18] 43258(50.5%) 214(0.2%) make-exacts-walkup ...develop/src/points.rkt:245:0 loop [22] 69.2% eval-prog [23] 30.3% ------------------------------------------------------------------------- make-exacts-halfpoints [15] 6.1% loop [14] 37.9% loop [11] 56.1% [19] 37736(44.0%) 214(0.2%) loop ...htlies/herbie/develop/src/points.rkt:248:4 loop [22] 96.9% composed [25] 1.3% ??? [32] 0.7% ------------------------------------------------------------------------- for-loop [16] 100.0% [20] 1600(1.9%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:324:32 random-posit16 [24] 100.0% ------------------------------------------------------------------------- parse-lambda [17] 100.0% [21] 322(0.4%) 322(0.4%) stx-pair? .../collects/racket/private/stx.rkt:40:4 ------------------------------------------------------------------------- make-exacts-walkup [18] 5.7% loop [19] 6.5% ??? [2] 7.5% loop [22] 80.3% [22] 71880(83.9%) 490(0.6%) loop ...-7.0/collects/racket/private/map.rkt:40:19 loop [22] 80.3% hash-ref! [28] 7.5% composed [25] 7.3% ??? [26] 2.8% ??? [32] 1.7% ??? [30] 0.0% ------------------------------------------------------------------------- loop [14] 15.1% make-exacts-walkup [18] 84.9% [23] 15456(18.0%) 320(0.4%) eval-prog ...herbie/develop/src/programs.rkt:130:0 temp68_2 [27] 43.2% hash-ref! [28] 42.9% inductor [29] 7.2% loop [74] 3.4% eval [31] 1.4% ------------------------------------------------------------------------- for-loop [20] 100.0% [24] 1600(1.9%) 1600(1.9%) random-posit16 ...softposit-rkt/softposit.rkt:64:0 ------------------------------------------------------------------------- loop [19] 1.6% loop [22] 98.4% [25] 29218(34.1%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [32] 100.0% ------------------------------------------------------------------------- loop [22] 100.0% [26] 22462(26.2%) 4084(4.8%) ??? ...tract/private/arrow-higher-order.rkt:357:33 double->posit16 [33] 60.1% ->flonum [36] 21.8% ------------------------------------------------------------------------- eval-prog [23] 100.0% [27] 6670(7.8%) 0(0.0%) temp68_2 (unknown source) compile16 [34] 100.0% ------------------------------------------------------------------------- eval-prog [23] 46.5% loop [22] 53.5% [28] 6624(7.7%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 53.5% bigfloat-hash [35] 46.5% ------------------------------------------------------------------------- eval-prog [23] 31.0% inductor [29] 69.0% [29] 1114(1.3%) 314(0.4%) inductor .../herbie/develop/src/programs.rkt:135:4 inductor [29] 69.0% bf [46] 23.9% ------------------------------------------------------------------------- loop [22] 100.0% [30] 774(0.9%) 0(0.0%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ??? [37] 100.0% ------------------------------------------------------------------------- eval-prog [23] 100.0% [31] 210(0.2%) 0(0.0%) eval (unknown source) namespace-syntax-introduce3 [38] 100.0% ------------------------------------------------------------------------- loop [19] 0.6% loop [22] 32.2% composed [25] 67.1% [32] 43516(50.8%) 1124(1.3%) ??? ...tlies/herbie/develop/src/programs.rkt:146:2 ->bf [39] 76.1% ??? [41] 21.3% ------------------------------------------------------------------------- ??? [26] 100.0% [33] 13492(15.7%) 0(0.0%) double->posit16 ...ftposit-rkt/softposit.rkt:248:0 get-ffi-obj* [40] 100.0% ------------------------------------------------------------------------- temp68_2 [27] 100.0% [34] 6670(7.8%) 0(0.0%) compile16 (unknown source) temp74_0 [42] 100.0% ------------------------------------------------------------------------- hash-ref! [28] 100.0% [35] 6624(7.7%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bfcanonicalize [43] 59.4% sig+exp->bigfloat [44] 36.1% bigfloat->sig+exp [52] 4.5% ------------------------------------------------------------------------- ??? [26] 100.0% [36] 4886(5.7%) 4326(5.0%) ->flonum ...s/herbie/develop/src/programs.rkt:38:0 keyword-apply [45] 5.9% ??? [51] 5.6% ------------------------------------------------------------------------- ??? [30] 100.0% [37] 774(0.9%) 774(0.9%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ------------------------------------------------------------------------- eval [31] 100.0% [38] 210(0.2%) 0(0.0%) namespace-syntax-introduce3 (unknown source) for-loop [70] 100.0% ------------------------------------------------------------------------- ??? [32] 100.0% [39] 33124(38.6%) 8310(9.7%) ->bf ...tlies/herbie/develop/src/programs.rkt:62:0 bf [46] 69.8% ??? [51] 5.1% ------------------------------------------------------------------------- double->posit16 [33] 100.0% [40] 13492(15.7%) 1490(1.7%) get-ffi-obj* ...-7.0/collects/ffi/unsafe.rkt:209:2 get-ffi-lib9 [47] 89.0% ------------------------------------------------------------------------- ??? [32] 100.0% [41] 9268(10.8%) 410(0.5%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 big-posit16-sub [49] 63.5% big-posit16-div [50] 26.9% for-loop [54] 5.2% ------------------------------------------------------------------------- compile16 [34] 100.0% [42] 6670(7.8%) 0(0.0%) temp74_0 (unknown source) expand-single [48] 89.0% compile-top9 [53] 11.0% ------------------------------------------------------------------------- bigfloat-hash [35] 100.0% [43] 3936(4.6%) 3382(3.9%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 bigfloat->sig+exp [52] 14.1% ------------------------------------------------------------------------- bigfloat-hash [35] 100.0% [44] 2392(2.8%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:387:0 new-mpfr [67] 91.1% integer->mpz [55] 8.9% ------------------------------------------------------------------------- ->flonum [36] 100.0% [45] 286(0.3%) 286(0.3%) keyword-apply ...lects/racket/private/kw.rkt:421:2 ------------------------------------------------------------------------- inductor [29] 3.3% ->bf [39] 96.7% [46] 23920(27.9%) 884(1.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [67] 79.8% ??? [68] 16.5% ------------------------------------------------------------------------- get-ffi-obj* [40] 100.0% [47] 12002(14.0%) 4856(5.7%) get-ffi-lib9 ...-7.0/collects/ffi/unsafe.rkt:121:0 get-cross-lib-search-dirs [57] 57.8% ------------------------------------------------------------------------- temp74_0 [42] 100.0% [48] 5936(6.9%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [58] 100.0% ------------------------------------------------------------------------- ??? [41] 100.0% [49] 5884(6.9%) 0(0.0%) big-posit16-sub .../src/syntax/softposit.rkt:109:0 ??? [56] 95.6% ...higher-order.rkt:361:33 [61] 4.4% ------------------------------------------------------------------------- ??? [41] 100.0% [50] 2494(2.9%) 0(0.0%) big-posit16-div .../src/syntax/softposit.rkt:111:0 ??? [56] 91.3% bf/ [62] 8.7% ------------------------------------------------------------------------- ->flonum [36] 13.9% ->bf [39] 86.1% [51] 1968(2.3%) 1968(2.3%) ??? ...-7.0/collects/racket/lazy-require.rkt:106:6 ------------------------------------------------------------------------- bigfloat-hash [35] 34.8% bfcanonicalize [43] 65.2% [52] 850(1.0%) 850(1.0%) bigfloat->sig+exp ...ivate/bigfloat/mpfr.rkt:372:0 ------------------------------------------------------------------------- temp74_0 [42] 100.0% [53] 734(0.9%) 0(0.0%) compile-top9 (unknown source) compile-forms31 [59] 100.0% ------------------------------------------------------------------------- ??? [41] 100.0% [54] 480(0.6%) 0(0.0%) for-loop ...ie/develop/src/syntax/syntax.rkt:725:2 fold-binary-pred [60] 100.0% ------------------------------------------------------------------------- sig+exp->bigfloat [44] 100.0% [55] 214(0.2%) 214(0.2%) integer->mpz ...math/private/bigfloat/gmp.rkt:87:0 ------------------------------------------------------------------------- big-posit16-div [50] 28.8% big-posit16-sub [49] 71.2% [56] 7906(9.2%) 1184(1.4%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfdiv [63] 85.0% ------------------------------------------------------------------------- get-ffi-lib9 [47] 100.0% [57] 6934(8.1%) 6532(7.6%) get-cross-lib-search-dirs ...rivate/dirs.rkt:168:7 ??? [66] 5.8% ------------------------------------------------------------------------- loop [74] 3.3% expand-single [48] 96.7% [58] 6138(7.2%) 202(0.2%) expand-capturing-lifts (unknown source) lambda-clause-expander [64] 87.4% dispatch-transformer41 [3] 5.2% loop [74] 4.1% ------------------------------------------------------------------------- compile-top9 [53] 100.0% [59] 734(0.9%) 0(0.0%) compile-forms31 (unknown source) for-loop [70] 100.0% ------------------------------------------------------------------------- for-loop [54] 100.0% [60] 480(0.6%) 0(0.0%) fold-binary-pred ...gfloat/bigfloat-mpfr.rkt:117:0 ??? [65] 100.0% ------------------------------------------------------------------------- big-posit16-sub [49] 100.0% [61] 256(0.3%) 256(0.3%) ...higher-order.rkt:361:33 (unknown source) ------------------------------------------------------------------------- big-posit16-div [50] 100.0% [62] 216(0.3%) 216(0.3%) bf/ ...th/private/bigfloat/bigfloat-mpfr.rkt:102:0 ------------------------------------------------------------------------- ??? [56] 100.0% [63] 6722(7.8%) 0(0.0%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [67] 72.4% ??? [68] 27.6% ------------------------------------------------------------------------- expand-capturing-lifts [58] 100.0% [64] 5364(6.3%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [69] 90.9% for-loop [70] 5.2% loop [74] 3.9% ------------------------------------------------------------------------- fold-binary-pred [60] 100.0% [65] 480(0.6%) 480(0.6%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ------------------------------------------------------------------------- get-cross-lib-search-dirs [57] 100.0% [66] 402(0.5%) 402(0.5%) ??? ...racket-7.0/collects/racket/promise.rkt:42:2 ------------------------------------------------------------------------- sig+exp->bigfloat [44] 8.3% bfdiv [63] 18.6% bf [46] 73.0% [67] 26124(30.5%) 26124(30.5%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------- bfdiv [63] 31.9% bf [46] 68.1% [68] 5812(6.8%) 5812(6.8%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------- for-loop [70] 49.5% lambda-clause-expander [64] 50.5% [69] 4878(5.7%) 214(0.2%) finish-bodys (unknown source) for-loop [70] 99.6% ------------------------------------------------------------------------- fallback-loop [12] 1.2% namespace-syntax-introduce3 [38] 3.4% lambda-clause-expander [64] 4.6% compile-forms31 [59] 12.0% for-loop [70] 14.1% finish-bodys [69] 64.7% [70] 6100(7.1%) 2344(2.7%) for-loop (unknown source) finish-bodys [69] 35.2% syntax-e [71] 17.1% for-loop [70] 14.1% add-local-binding!37 [72] 6.1% expand-identifier [4] 2.6% loop [74] 2.0% dispatch-transformer41 [3] 1.1% expand-implicit [5] 0.5% ------------------------------------------------------------------------- loop [74] 13.4% for-loop [70] 86.6% [71] 2068(2.4%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [73] 100.0% ------------------------------------------------------------------------- for-loop [70] 100.0% [72] 564(0.7%) 564(0.7%) add-local-binding!37 (unknown source) ------------------------------------------------------------------------- expand-id-application-form17 [76] 13.5% syntax-e [71] 86.5% [73] 2390(2.8%) 0(0.0%) syntax-e/no-taint (unknown source) loop [74] 100.0% ------------------------------------------------------------------------- apply-transformer52 [8] 3.8% lambda-clause-expander [64] 5.8% expand-capturing-lifts [58] 6.9% for-loop [70] 11.3% eval-prog [23] 14.3% syntax-e/no-taint [73] 57.8% [74] 3614(4.2%) 982(1.1%) loop (unknown source) gf [75] 52.1% expand-id-application-form17 [76] 11.3% expand-capturing-lifts [58] 5.6% syntax-e [71] 3.8% ------------------------------------------------------------------------- loop [74] 100.0% [75] 2182(2.5%) 278(0.3%) gf (unknown source) propagation-apply-shifted [77] 59.1% propagation-apply [78] 14.8% propagation-merge [79] 13.4% ------------------------------------------------------------------------- loop [74] 100.0% [76] 570(0.7%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [73] 56.5% resolve+shift28 [9] 43.5% ------------------------------------------------------------------------- gf [75] 100.0% [77] 1290(1.5%) 1290(1.5%) propagation-apply-shifted (unknown source) ------------------------------------------------------------------------- gf [75] 100.0% [78] 322(0.4%) 322(0.4%) propagation-apply (unknown source) ------------------------------------------------------------------------- gf [75] 100.0% [79] 292(0.3%) 292(0.3%) propagation-merge (unknown source) -------------------------------------------------------------------------