Profiling results ----------------- Total cpu time observed: 99980ms (out of 101296ms) Number of samples taken: 303 (once every 330ms) (Hiding functions with self<1.0% and local<2.0%: 3 of 98 hidden) ========================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================= run [8] 50.0% [1] 99980(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 50.0% run-improve40 [5] 50.0% ------------------------------------------------------------------------- hash-ref! [24] 100.0% [2] 8430(8.4%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:189:5 loop [18] 100.0% ------------------------------------------------------------------------- loop [83] 10.8% for-loop [93] 89.2% [3] 3002(3.0%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [7] 100.0% ------------------------------------------------------------------------- for-loop [93] 100.0% [4] 298(0.3%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [89] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [5] 99980(100.0%) 0(0.0%) run-improve40 ...ie/develop/src/mainloop.rkt:340:0 loop [9] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [6] 99980(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [8] 100.0% ------------------------------------------------------------------------- gf [84] 6.8% expand-id-application-form17 [85] 25.3% syntax-e [3] 67.9% [7] 4422(4.4%) 272(0.3%) syntax-e/no-taint (unknown source) loop [83] 93.8% ------------------------------------------------------------------------- profile-thunk16 [6] 100.0% [8] 99980(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------- run-improve40 [5] 100.0% [9] 99980(100.0%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:303:2 loop [10] 33.4% make-exacts-walkup [14] 23.3% loop [15] 21.3% make-exacts-halfpoints [11] 17.6% for-loop [12] 4.1% filter-p&e [13] 0.3% ------------------------------------------------------------------------- loop [9] 100.0% [10] 33388(33.4%) 324(0.3%) loop ...htlies/herbie/develop/src/points.rkt:264:2 loop [15] 47.3% make-exacts-walkup [14] 41.3% eval-prog [19] 10.4% ------------------------------------------------------------------------- loop [9] 100.0% [11] 17590(17.6%) 0(0.0%) make-exacts-halfpoints ...lop/src/points.rkt:262:0 make-exacts-walkup [14] 88.9% loop [15] 11.1% ------------------------------------------------------------------------- loop [9] 100.0% [12] 4098(4.1%) 330(0.3%) for-loop ...s/herbie/develop/src/points.rkt:322:31 for-loop [16] 91.9% ------------------------------------------------------------------------- loop [9] 100.0% [13] 314(0.3%) 0(0.0%) filter-p&e .../herbie/develop/src/points.rkt:277:0 for-loop [17] 100.0% ------------------------------------------------------------------------- loop [10] 26.1% make-exacts-halfpoints [11] 29.7% loop [9] 44.2% [14] 52742(52.8%) 324(0.3%) make-exacts-walkup ...develop/src/points.rkt:244:0 loop [18] 65.6% eval-prog [19] 33.8% ------------------------------------------------------------------------- make-exacts-halfpoints [11] 5.0% loop [10] 40.5% loop [9] 54.5% [15] 39038(39.0%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:247:4 loop [18] 94.8% composed [22] 2.8% ??? [23] 1.6% ??? [29] 0.8% ------------------------------------------------------------------------- for-loop [12] 100.0% [16] 3768(3.8%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:323:32 random-posit16 [20] 56.1% keyword-apply [50] 43.9% ------------------------------------------------------------------------- filter-p&e [13] 100.0% [17] 314(0.3%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:279:2 ordinary-value? [21] 100.0% ------------------------------------------------------------------------- make-exacts-walkup [14] 5.2% loop [15] 6.3% ??? [2] 10.5% loop [18] 78.0% [18] 80030(80.0%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 loop [18] 78.0% hash-ref! [24] 10.5% composed [22] 5.7% ??? [23] 3.4% ??? [29] 1.9% ??? [27] 0.5% ------------------------------------------------------------------------- loop [10] 16.3% make-exacts-walkup [14] 83.7% [19] 21284(21.3%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:130:0 hash-ref! [24] 47.6% temp68_2 [25] 35.0% inductor [26] 10.4% eval [28] 4.3% loop [83] 2.7% ------------------------------------------------------------------------- for-loop [16] 100.0% [20] 2114(2.1%) 2114(2.1%) random-posit16 ...softposit-rkt/softposit.rkt:64:0 ------------------------------------------------------------------------- for-loop [17] 100.0% [21] 314(0.3%) 314(0.3%) ordinary-value? ...rbie/develop/src/float.rkt:54:0 ------------------------------------------------------------------------- loop [15] 3.5% loop [18] 96.5% [22] 31396(31.4%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [29] 100.0% ------------------------------------------------------------------------- loop [15] 2.3% loop [18] 97.7% [23] 27772(27.8%) 1266(1.3%) ??? ...tract/private/arrow-higher-order.rkt:357:33 double->posit16 [30] 74.1% ->flonum [33] 21.3% ------------------------------------------------------------------------- eval-prog [19] 43.5% loop [18] 56.5% [24] 10138(10.1%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 56.5% bigfloat-hash [31] 43.5% ------------------------------------------------------------------------- eval-prog [19] 100.0% [25] 7442(7.4%) 0(0.0%) temp68_2 (unknown source) compile16 [32] 100.0% ------------------------------------------------------------------------- eval-prog [19] 35.6% inductor [26] 64.4% [26] 2206(2.2%) 596(0.6%) inductor .../herbie/develop/src/programs.rkt:135:4 inductor [26] 64.4% bf [45] 19.6% ??? [34] 4.7% ------------------------------------------------------------------------- loop [18] 100.0% [27] 1334(1.3%) 374(0.4%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ??? [34] 72.0% ------------------------------------------------------------------------- eval-prog [19] 100.0% [28] 916(0.9%) 298(0.3%) eval (unknown source) namespace-syntax-introduce3 [35] 35.2% add-ns-scopes [36] 32.3% ------------------------------------------------------------------------- loop [15] 0.7% loop [18] 28.8% composed [22] 70.5% [29] 44530(44.5%) 1850(1.9%) ??? ...tlies/herbie/develop/src/programs.rkt:146:2 ->bf [37] 73.1% ??? [39] 22.8% ------------------------------------------------------------------------- ??? [23] 100.0% [30] 20582(20.6%) 324(0.3%) double->posit16 ...ftposit-rkt/softposit.rkt:248:0 get-ffi-obj* [38] 98.4% ------------------------------------------------------------------------- hash-ref! [24] 100.0% [31] 10138(10.1%) 546(0.5%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bfcanonicalize [41] 48.5% sig+exp->bigfloat [42] 40.1% bigfloat-signbit [44] 3.1% bigfloat->sig+exp [53] 2.9% ------------------------------------------------------------------------- temp68_2 [25] 100.0% [32] 7442(7.4%) 0(0.0%) compile16 (unknown source) temp74_0 [40] 100.0% ------------------------------------------------------------------------- ??? [23] 100.0% [33] 5924(5.9%) 3768(3.8%) ->flonum ...s/herbie/develop/src/programs.rkt:38:0 ??? [43] 16.6% ??? [73] 10.3% ??? [52] 9.5% ------------------------------------------------------------------------- inductor [26] 24.4% ??? [27] 75.6% [34] 1270(1.3%) 1270(1.3%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ------------------------------------------------------------------------- eval [28] 100.0% [35] 322(0.3%) 322(0.3%) namespace-syntax-introduce3 (unknown source) ------------------------------------------------------------------------- eval [28] 100.0% [36] 296(0.3%) 296(0.3%) add-ns-scopes (unknown source) ------------------------------------------------------------------------- ??? [29] 100.0% [37] 32540(32.5%) 10230(10.2%) ->bf ...tlies/herbie/develop/src/programs.rkt:62:0 bf [45] 65.8% ??? [52] 1.6% keyword-apply [50] 1.1% ------------------------------------------------------------------------- double->posit16 [30] 100.0% [38] 20258(20.3%) 3900(3.9%) get-ffi-obj* ...-7.0/collects/ffi/unsafe.rkt:209:2 get-ffi-lib9 [46] 80.7% ------------------------------------------------------------------------- ??? [29] 100.0% [39] 10140(10.1%) 298(0.3%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 big-posit16-div [48] 48.4% big-posit16-sub [49] 31.4% for-loop [51] 17.2% ------------------------------------------------------------------------- compile16 [32] 100.0% [40] 7442(7.4%) 0(0.0%) temp74_0 (unknown source) expand-single [47] 97.2% compile-top9 [54] 2.8% ------------------------------------------------------------------------- bigfloat-hash [31] 100.0% [41] 4916(4.9%) 4604(4.6%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 bigfloat->sig+exp [53] 6.3% ------------------------------------------------------------------------- bigfloat-hash [31] 100.0% [42] 4068(4.1%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:387:0 new-mpfr [71] 100.0% ------------------------------------------------------------------------- ->flonum [33] 100.0% [43] 986(1.0%) 986(1.0%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ------------------------------------------------------------------------- bigfloat-hash [31] 100.0% [44] 310(0.3%) 310(0.3%) bigfloat-signbit ...rivate/bigfloat/mpfr.rkt:362:0 ------------------------------------------------------------------------- inductor [26] 5.7% ->bf [37] 94.3% [45] 22702(22.7%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [71] 86.7% ??? [73] 13.3% ------------------------------------------------------------------------- get-ffi-obj* [38] 100.0% [46] 16358(16.4%) 7600(7.6%) get-ffi-lib9 ...-7.0/collects/ffi/unsafe.rkt:121:0 get-cross-lib-search-dirs [55] 52.2% ------------------------------------------------------------------------- temp74_0 [40] 100.0% [47] 7232(7.2%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [56] 100.0% ------------------------------------------------------------------------- ??? [39] 100.0% [48] 4912(4.9%) 306(0.3%) big-posit16-div .../src/syntax/softposit.rkt:111:0 ??? [57] 80.7% bf/ [59] 6.7% ...higher-order.rkt:361:33 [60] 6.4% ------------------------------------------------------------------------- ??? [39] 100.0% [49] 3186(3.2%) 0(0.0%) big-posit16-sub .../src/syntax/softposit.rkt:109:0 ??? [57] 100.0% ------------------------------------------------------------------------- ->bf [37] 18.4% for-loop [16] 81.6% [50] 2028(2.0%) 2028(2.0%) keyword-apply ...lects/racket/private/kw.rkt:421:2 ------------------------------------------------------------------------- ??? [39] 100.0% [51] 1744(1.7%) 638(0.6%) for-loop ...ie/develop/src/syntax/syntax.rkt:725:2 fold-binary-pred [58] 50.2% ...higher-order.rkt:357:33 [62] 13.2% ------------------------------------------------------------------------- ->bf [37] 48.8% ->flonum [33] 51.2% [52] 1094(1.1%) 1094(1.1%) ??? ...-7.0/collects/racket/lazy-require.rkt:106:6 ------------------------------------------------------------------------- bigfloat-hash [31] 48.9% bfcanonicalize [41] 51.1% [53] 610(0.6%) 312(0.3%) bigfloat->sig+exp ...ivate/bigfloat/mpfr.rkt:372:0 new-mpz [61] 48.9% ------------------------------------------------------------------------- temp74_0 [40] 100.0% [54] 210(0.2%) 0(0.0%) compile-top9 (unknown source) compile-forms31 [63] 100.0% ------------------------------------------------------------------------- get-ffi-lib9 [46] 100.0% [55] 8538(8.5%) 7864(7.9%) get-cross-lib-search-dirs ...rivate/dirs.rkt:168:7 ??? [68] 7.9% ------------------------------------------------------------------------- loop [83] 7.4% expand-single [47] 92.6% [56] 7814(7.8%) 300(0.3%) expand-capturing-lifts (unknown source) lambda-clause-expander [64] 84.8% dispatch-transformer41 [66] 7.4% expand-id-application-form17 [85] 3.9% ------------------------------------------------------------------------- big-posit16-sub [49] 44.6% big-posit16-div [48] 55.4% [57] 7150(7.2%) 1780(1.8%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfsub [65] 75.1% ------------------------------------------------------------------------- for-loop [51] 100.0% [58] 876(0.9%) 0(0.0%) fold-binary-pred ...gfloat/bigfloat-mpfr.rkt:117:0 ??? [67] 100.0% ------------------------------------------------------------------------- big-posit16-div [48] 100.0% [59] 330(0.3%) 330(0.3%) bf/ ...th/private/bigfloat/bigfloat-mpfr.rkt:102:0 ------------------------------------------------------------------------- big-posit16-div [48] 100.0% [60] 312(0.3%) 0(0.0%) ...higher-order.rkt:361:33 (unknown source) ??? [69] 100.0% ------------------------------------------------------------------------- bigfloat->sig+exp [53] 100.0% [61] 298(0.3%) 298(0.3%) new-mpz ...-lib/math/private/bigfloat/gmp.rkt:73:0 ------------------------------------------------------------------------- for-loop [51] 100.0% [62] 230(0.2%) 0(0.0%) ...higher-order.rkt:357:33 (unknown source) ??? [69] 100.0% ------------------------------------------------------------------------- compile-top9 [54] 100.0% [63] 210(0.2%) 0(0.0%) compile-forms31 (unknown source) loop! [70] 100.0% ------------------------------------------------------------------------- expand-capturing-lifts [56] 100.0% [64] 6626(6.6%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [72] 91.0% loop [83] 9.0% ------------------------------------------------------------------------- ??? [57] 100.0% [65] 5370(5.4%) 0(0.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [71] 65.8% ??? [73] 34.2% ------------------------------------------------------------------------- loop [83] 21.5% expand-capturing-lifts [56] 38.6% for-loop [93] 39.9% [66] 1508(1.5%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [74] 100.0% ------------------------------------------------------------------------- fold-binary-pred [58] 100.0% [67] 876(0.9%) 876(0.9%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ------------------------------------------------------------------------- get-cross-lib-search-dirs [55] 100.0% [68] 674(0.7%) 348(0.3%) ??? ...racket-7.0/collects/racket/promise.rkt:42:2 call-with-exception-handler [75] 48.4% ------------------------------------------------------------------------- ...higher-order.rkt:357:33 [62] 42.4% ...higher-order.rkt:361:33 [60] 57.6% [69] 542(0.5%) 542(0.5%) ??? ...cts/racket/contract/private/list.rkt:209:10 ------------------------------------------------------------------------- compile-forms31 [63] 100.0% [70] 210(0.2%) 0(0.0%) loop! (unknown source) for-loop [93] 100.0% ------------------------------------------------------------------------- bfsub [65] 13.0% sig+exp->bigfloat [42] 14.9% bf [45] 72.1% [71] 27272(27.3%) 27272(27.3%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------- lambda-clause-expander [64] 34.3% for-loop [93] 65.7% [72] 6030(6.0%) 0(0.0%) finish-bodys (unknown source) for-loop [93] 100.0% ------------------------------------------------------------------------- ->flonum [33] 11.1% bfsub [65] 33.6% bf [45] 55.3% [73] 5478(5.5%) 5478(5.5%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------- dispatch-transformer41 [66] 100.0% [74] 1508(1.5%) 0(0.0%) apply-transformer52 (unknown source) apply-transformer-in-context [76] 61.4% apply-post-expansion [78] 19.9% loop [83] 18.7% ------------------------------------------------------------------------- ??? [68] 100.0% [75] 326(0.3%) 0(0.0%) call-with-exception-handler ...re-scheme.rkt:265:2 ??? [77] 100.0% ------------------------------------------------------------------------- apply-transformer52 [74] 100.0% [76] 926(0.9%) 306(0.3%) apply-transformer-in-context (unknown source) ??? [79] 35.0% parse-app [80] 32.0% ------------------------------------------------------------------------- call-with-exception-handler [75] 100.0% [77] 326(0.3%) 326(0.3%) ??? ...acket-7.0/collects/racket/promise.rkt:74:15 ------------------------------------------------------------------------- apply-transformer52 [74] 100.0% [78] 300(0.3%) 0(0.0%) apply-post-expansion (unknown source) gf [84] 100.0% ------------------------------------------------------------------------- apply-transformer-in-context [76]100.0% [79] 324(0.3%) 0(0.0%) ??? ...collects/racket/private/qq-and-or.rkt:155:9 ??? [81] 100.0% ------------------------------------------------------------------------- apply-transformer-in-context [76]100.0% [80] 296(0.3%) 296(0.3%) parse-app ...collects/racket/private/kw.rkt:1105:2 ------------------------------------------------------------------------- ??? [79] 100.0% [81] 324(0.3%) 0(0.0%) ??? ...ollects/racket/private/qq-and-or.rkt:164:21 syntax->list [82] 100.0% ------------------------------------------------------------------------- ??? [81] 100.0% [82] 324(0.3%) 0(0.0%) syntax->list (unknown source) loop [83] 100.0% ------------------------------------------------------------------------- syntax->list [82] 2.1% apply-transformer52 [74] 2.8% eval-prog [19] 5.8% lambda-clause-expander [64] 7.5% for-loop [93] 15.4% syntax-e/no-taint [7] 66.4% [83] 5058(5.1%) 0(0.0%) loop (unknown source) gf [84] 66.4% expand-id-application-form17 [85] 13.8% core-form-sym [86] 9.8% expand-capturing-lifts [56] 5.8% dispatch-transformer41 [66] 2.1% syntax-e [3] 2.1% ------------------------------------------------------------------------- apply-post-expansion [78] 3.6% loop [83] 96.4% [84] 4150(4.2%) 300(0.3%) gf (unknown source) propagation-apply [87] 51.2% propagation-apply-shifted [88] 28.4% cache-or-reuse-set [90] 13.1% syntax-e/no-taint [7] 3.6% ------------------------------------------------------------------------- expand-capturing-lifts [56] 21.5% loop [83] 78.5% [85] 1426(1.4%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [7] 78.5% binding-lookup50 [91] 21.5% ------------------------------------------------------------------------- loop [83] 100.0% [86] 636(0.6%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [89] 100.0% ------------------------------------------------------------------------- gf [84] 100.0% [87] 2126(2.1%) 2126(2.1%) propagation-apply (unknown source) ------------------------------------------------------------------------- gf [84] 100.0% [88] 1180(1.2%) 1180(1.2%) propagation-apply-shifted (unknown source) ------------------------------------------------------------------------- expand-identifier [4] 31.9% core-form-sym [86] 68.1% [89] 934(0.9%) 636(0.6%) resolve+shift28 (unknown source) fallback-loop [92] 31.9% ------------------------------------------------------------------------- gf [84] 100.0% [90] 544(0.5%) 544(0.5%) cache-or-reuse-set (unknown source) ------------------------------------------------------------------------- expand-id-application-form17 [85]100.0% [91] 306(0.3%) 306(0.3%) binding-lookup50 (unknown source) ------------------------------------------------------------------------- resolve+shift28 [89] 100.0% [92] 298(0.3%) 0(0.0%) fallback-loop (unknown source) for-loop [93] 100.0% ------------------------------------------------------------------------- fallback-loop [92] 1.6% loop! [70] 3.4% for-loop [93] 13.4% finish-bodys [72] 81.6% [93] 6240(6.2%) 990(1.0%) for-loop (unknown source) finish-bodys [72] 56.4% for-loop [93] 13.4% syntax-e [3] 7.8% loop [83] 4.3% compile5 [94] 3.4% dispatch-transformer41 [66] 2.0% expand-identifier [4] 1.6% ------------------------------------------------------------------------- for-loop [93] 100.0% [94] 210(0.2%) 0(0.0%) compile5 (unknown source) compile-let13 [95] 100.0% ------------------------------------------------------------------------- compile5 [94] 100.0% [95] 210(0.2%) 210(0.2%) compile-let13 (unknown source) -------------------------------------------------------------------------