Profiling results ----------------- Total cpu time observed: 7152ms (out of 7948ms) Number of samples taken: 35 (once every 204ms) ======================================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================================= [1] 7152(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [11] 100.0% --------------------------------------------------------------------------------------- ??? [70] 100.0% [2] 2856(39.9%) 198(2.8%) approximate9 ...pler-alts/src/core/taylor.rkt:11:0 loop [12] 93.1% --------------------------------------------------------------------------------------- map [18] 7.5% hash-ref! [76] 92.5% [3] 2658(37.2%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [13] 100.0% --------------------------------------------------------------------------------------- hash-ref! [76] 100.0% [4] 2458(34.4%) 0(0.0%) ??? ...bie/simpler-alts/src/core/taylor.rkt:300:23 for-loop [14] 100.0% --------------------------------------------------------------------------------------- hash-ref! [76] 100.0% [5] 2458(34.4%) 0(0.0%) ??? ...bie/simpler-alts/src/core/taylor.rkt:406:23 for-loop [15] 100.0% --------------------------------------------------------------------------------------- for-loop [92] 100.0% [6] 832(11.6%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [16] 100.0% --------------------------------------------------------------------------------------- for-loop [92] 100.0% [7] 602(8.4%) 200(2.8%) expand-implicit (unknown source) resolve+shift28 [17] 66.8% --------------------------------------------------------------------------------------- map [18] 50.0% hash-ref! [76] 50.0% [8] 200(2.8%) 0(0.0%) f40 (unknown source) map [18] 100.0% --------------------------------------------------------------------------------------- for-loop [92] 100.0% [9] 200(2.8%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [17] 100.0% --------------------------------------------------------------------------------------- hash-ref! [76] 100.0% [10] 198(2.8%) 0(0.0%) matcher ...simpler-alts/src/core/matcher.rkt:117:2 ??? [19] 50.0% rewriter [63] 50.0% --------------------------------------------------------------------------------------- ??? [1] 100.0% [11] 7152(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [20] 100.0% --------------------------------------------------------------------------------------- approximate9 [2] 100.0% [12] 2658(37.2%) 0(0.0%) loop ...rbie/simpler-alts/src/core/taylor.rkt:86:4 ??? [70] 100.0% --------------------------------------------------------------------------------------- parse-loop74 [3] 100.0% [13] 2658(37.2%) 0(0.0%) eval-const-expr ...ler-alts/src/programs.rkt:144:0 temp85_0 [71] 85.0% eval [24] 7.5% eval-prog [23] 7.5% --------------------------------------------------------------------------------------- ??? [4] 100.0% [14] 2458(34.4%) 0(0.0%) for-loop ...impler-alts/src/core/taylor.rkt:303:27 hash-ref! [76] 100.0% --------------------------------------------------------------------------------------- ??? [5] 100.0% [15] 2458(34.4%) 0(0.0%) for-loop ...impler-alts/src/core/taylor.rkt:410:33 for-loop [21] 91.6% hash-ref! [76] 8.4% --------------------------------------------------------------------------------------- expand-id-application-form17 [91] 32.5% syntax-e [6] 67.5% [16] 1232(17.2%) 0(0.0%) syntax-e/no-taint (unknown source) loop [87] 100.0% --------------------------------------------------------------------------------------- expand-identifier [9] 33.2% expand-implicit [7] 66.8% [17] 602(8.4%) 202(2.8%) resolve+shift28 (unknown source) fallback-loop [22] 66.4% --------------------------------------------------------------------------------------- f40 [8] 100.0% [18] 200(2.8%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 f40 [8] 50.0% parse-loop74 [3] 50.0% --------------------------------------------------------------------------------------- matcher [10] 100.0% [19] 198(2.8%) 0(0.0%) ??? ...ie/simpler-alts/src/core/matcher.rkt:129:11 for-loop [25] 100.0% --------------------------------------------------------------------------------------- profile-thunk16 [11] 100.0% [20] 7152(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [26] 100.0% --------------------------------------------------------------------------------------- for-loop [15] 100.0% [21] 2252(31.5%) 0(0.0%) for-loop ...impler-alts/src/core/taylor.rkt:412:39 hash-ref! [76] 100.0% --------------------------------------------------------------------------------------- resolve+shift28 [17] 100.0% [22] 400(5.6%) 200(2.8%) fallback-loop (unknown source) for-loop [92] 50.0% --------------------------------------------------------------------------------------- eval-const-expr [13] 100.0% [23] 200(2.8%) 0(0.0%) eval-prog ...e/simpler-alts/src/programs.rkt:106:0 inductor [27] 100.0% --------------------------------------------------------------------------------------- eval-const-expr [13] 100.0% [24] 200(2.8%) 0(0.0%) eval (unknown source) datum->syntax6 [28] 100.0% --------------------------------------------------------------------------------------- ??? [19] 100.0% [25] 198(2.8%) 0(0.0%) for-loop ...mpler-alts/src/core/matcher.rkt:131:15 hash-ref! [76] 100.0% --------------------------------------------------------------------------------------- for-loop [73] 2.7% run [20] 97.3% [26] 7152(100.0%) 388(5.4%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [29] 68.2% prepare-points-intervals [34] 22.0% get-final-combination [30] 2.9% oracle-error [32] 2.8% errors [65] 1.4% --------------------------------------------------------------------------------------- eval-prog [23] 100.0% [27] 200(2.8%) 0(0.0%) inductor ...ie/simpler-alts/src/programs.rkt:127:4 table-ref [31] 100.0% --------------------------------------------------------------------------------------- eval [24] 100.0% [28] 200(2.8%) 0(0.0%) datum->syntax6 (unknown source) loop [87] 100.0% --------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [26] 100.0% [29] 4976(69.6%) 0(0.0%) run-improve47 ...mpler-alts/src/mainloop.rkt:365:0 for-loop [33] 91.4% simplify! [41] 4.5% prepare-points-intervals [34] 4.1% --------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [26] 100.0% [30] 210(2.9%) 0(0.0%) get-final-combination ...ts/src/mainloop.rkt:390:0 infer-splitpoints [35] 100.0% --------------------------------------------------------------------------------------- inductor [27] 100.0% [31] 200(2.8%) 200(2.8%) table-ref ...rbie/simpler-alts/src/common.rkt:33:0 --------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [26] 100.0% [32] 200(2.8%) 0(0.0%) oracle-error .../simpler-alts/src/points.rkt:179:0 for-loop [36] 100.0% --------------------------------------------------------------------------------------- run-improve47 [29] 100.0% [33] 4546(63.6%) 0(0.0%) for-loop ...ie/simpler-alts/src/mainloop.rkt:384:4 run-iter! [37] 100.0% --------------------------------------------------------------------------------------- run-improve47 [29] 11.5% .../more-scheme.rkt:261:28 [26] 88.5% [34] 1774(24.8%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:122:0 loop [38] 88.5% loop [87] 11.5% --------------------------------------------------------------------------------------- get-final-combination [30] 100.0% [35] 210(2.9%) 0(0.0%) infer-splitpoints ...lts/src/core/regimes.rkt:33:0 for-loop [39] 100.0% --------------------------------------------------------------------------------------- oracle-error [32] 100.0% [36] 200(2.8%) 0(0.0%) for-loop ...rbie/simpler-alts/src/points.rkt:180:2 loop [87] 100.0% --------------------------------------------------------------------------------------- for-loop [33] 100.0% [37] 4546(63.6%) 0(0.0%) run-iter! ...e/simpler-alts/src/mainloop.rkt:346:0 gen-series! [40] 62.8% finalize-iter! [42] 17.5% simplify! [41] 15.3% gen-rewrites! [47] 4.4% --------------------------------------------------------------------------------------- prepare-points-intervals [34] 100.0% [38] 1570(22.0%) 194(2.7%) loop ...s/herbie/simpler-alts/src/points.rkt:134:4 ??? [43] 49.8% loop [44] 24.8% andmap [46] 13.0% --------------------------------------------------------------------------------------- infer-splitpoints [35] 100.0% [39] 210(2.9%) 0(0.0%) for-loop ...simpler-alts/src/core/regimes.rkt:45:6 option-on-expr [45] 100.0% --------------------------------------------------------------------------------------- run-iter! [37] 100.0% [40] 2856(39.9%) 0(0.0%) gen-series! ...simpler-alts/src/mainloop.rkt:160:0 for-loop [48] 100.0% --------------------------------------------------------------------------------------- run-improve47 [29] 24.5% run-iter! [37] 75.5% [41] 922(12.9%) 0(0.0%) simplify! ...e/simpler-alts/src/mainloop.rkt:224:0 ??? [49] 100.0% --------------------------------------------------------------------------------------- run-iter! [37] 100.0% [42] 796(11.1%) 0(0.0%) finalize-iter! ...pler-alts/src/mainloop.rkt:278:0 ??? [50] 100.0% --------------------------------------------------------------------------------------- loop [38] 100.0% [43] 782(10.9%) 0(0.0%) ??? ...es/herbie/simpler-alts/src/points.rkt:115:6 loop [87] 51.9% sample-multi-bounded [90] 48.1% --------------------------------------------------------------------------------------- loop [38] 100.0% [44] 390(5.5%) 0(0.0%) loop ...es/herbie/simpler-alts/src/points.rkt:79:2 ??? [70] 100.0% --------------------------------------------------------------------------------------- for-loop [39] 100.0% [45] 210(2.9%) 0(0.0%) option-on-expr ...-alts/src/core/regimes.rkt:124:0 sort-context-on-expr [51] 100.0% --------------------------------------------------------------------------------------- loop [38] 100.0% [46] 204(2.9%) 0(0.0%) andmap ...5/collects/racket/private/map.rkt:102:13 ordinary-value? [52] 100.0% --------------------------------------------------------------------------------------- run-iter! [37] 100.0% [47] 198(2.8%) 0(0.0%) gen-rewrites! ...mpler-alts/src/mainloop.rkt:183:0 for-loop [53] 100.0% --------------------------------------------------------------------------------------- gen-series! [40] 100.0% [48] 2856(39.9%) 0(0.0%) for-loop ...ie/simpler-alts/src/mainloop.rkt:167:7 taylor-alt [54] 100.0% --------------------------------------------------------------------------------------- simplify! [41] 100.0% [49] 922(12.9%) 0(0.0%) ??? ...bie/simpler-alts/src/core/simplify.rkt:42:0 egraph-run [55] 100.0% --------------------------------------------------------------------------------------- finalize-iter! [42] 100.0% [50] 796(11.1%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [56] 100.0% --------------------------------------------------------------------------------------- option-on-expr [45] 100.0% [51] 210(2.9%) 0(0.0%) sort-context-on-expr ...src/core/regimes.rkt:117:0 ??? [57] 100.0% --------------------------------------------------------------------------------------- andmap [46] 100.0% [52] 204(2.9%) 204(2.9%) ordinary-value? ...simpler-alts/src/float.rkt:51:0 --------------------------------------------------------------------------------------- gen-rewrites! [47] 100.0% [53] 198(2.8%) 0(0.0%) for-loop ...e/simpler-alts/src/mainloop.rkt:191:11 rewrite-expression-head23 [58] 100.0% --------------------------------------------------------------------------------------- for-loop [48] 100.0% [54] 2856(39.9%) 0(0.0%) taylor-alt .../simpler-alts/src/mainloop.rkt:146:0 for-loop [59] 100.0% --------------------------------------------------------------------------------------- ??? [49] 100.0% [55] 922(12.9%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [60] 100.0% --------------------------------------------------------------------------------------- ??? [50] 100.0% [56] 796(11.1%) 0(0.0%) for-loop ...pler-alts/src/core/alt-table.rkt:201:2 atab-add-altn [61] 100.0% --------------------------------------------------------------------------------------- sort-context-on-expr [51] 100.0% [57] 210(2.9%) 0(0.0%) ??? ...-7.5/collects/racket/private/sort.rkt:369:3 generic-sort/key [62] 100.0% --------------------------------------------------------------------------------------- for-loop [53] 100.0% [58] 198(2.8%) 0(0.0%) rewrite-expression-head23 ...core/matcher.rkt:83:0 rewriter [63] 100.0% --------------------------------------------------------------------------------------- taylor-alt [54] 100.0% [59] 2856(39.9%) 0(0.0%) for-loop ...ie/simpler-alts/src/mainloop.rkt:152:6 ??? [70] 100.0% --------------------------------------------------------------------------------------- egraph-run [55] 100.0% [60] 922(12.9%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [64] 100.0% --------------------------------------------------------------------------------------- for-loop [56] 100.0% [61] 796(11.1%) 0(0.0%) atab-add-altn ...alts/src/core/alt-table.rkt:204:0 errors [65] 49.2% remove-chnged-pnts [67] 26.1% best-and-tied-at-points [69] 24.6% --------------------------------------------------------------------------------------- ??? [57] 100.0% [62] 210(2.9%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:156:2 loop [66] 100.0% --------------------------------------------------------------------------------------- matcher [10] 50.0% rewrite-expression-head23 [58] 50.0% [63] 198(2.8%) 0(0.0%) rewriter ...simpler-alts/src/core/matcher.rkt:85:2 for-loop [68] 100.0% --------------------------------------------------------------------------------------- egraph-add-exprs [60] 100.0% [64] 922(12.9%) 0(0.0%) ??? ...ie/simpler-alts/src/core/simplify.rkt:103:6 for-loop [72] 100.0% --------------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [26] 33.3% atab-add-altn [61] 66.7% [65] 588(8.2%) 0(0.0%) errors ...herbie/simpler-alts/src/points.rkt:192:0 for-loop [73] 66.0% temp85_0 [71] 34.0% --------------------------------------------------------------------------------------- generic-sort/key [62] 100.0% [66] 210(2.9%) 0(0.0%) loop ...7.5/collects/racket/private/sort.rkt:96:12 ??? [70] 100.0% --------------------------------------------------------------------------------------- atab-add-altn [61] 100.0% [67] 208(2.9%) 208(2.9%) remove-chnged-pnts ...src/core/alt-table.rkt:103:0 --------------------------------------------------------------------------------------- rewriter [63] 100.0% [68] 198(2.8%) 0(0.0%) for-loop ...simpler-alts/src/core/matcher.rkt:87:4 hash-ref! [76] 100.0% --------------------------------------------------------------------------------------- atab-add-altn [61] 100.0% [69] 196(2.7%) 0(0.0%) best-and-tied-at-points ...core/alt-table.rkt:91:0 for-loop [74] 100.0% --------------------------------------------------------------------------------------- loop [66] 6.1% loop [44] 11.3% loop [12] 25.6% location-do [75] 28.5% for-loop [59] 28.5% [70] 3456(48.3%) 210(2.9%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [75] 28.5% approximate9 [2] 28.5% hash-ref! [76] 25.6% ival-mult [78] 11.3% --------------------------------------------------------------------------------------- errors [65] 8.1% eval-const-expr [13] 91.9% [71] 2458(34.4%) 0(0.0%) temp85_0 (unknown source) compile15 [77] 100.0% --------------------------------------------------------------------------------------- ??? [64] 100.0% [72] 922(12.9%) 922(12.9%) for-loop ...mpler-alts/src/core/simplify.rkt:121:2 --------------------------------------------------------------------------------------- errors [65] 100.0% [73] 388(5.4%) 0(0.0%) for-loop ...rbie/simpler-alts/src/points.rkt:194:2 .../more-scheme.rkt:261:28 [26] 100.0% --------------------------------------------------------------------------------------- best-and-tied-at-points [69] 100.0% [74] 196(2.7%) 0(0.0%) for-loop ...mpler-alts/src/core/alt-table.rkt:94:4 ??? [79] 100.0% --------------------------------------------------------------------------------------- ??? [70] 32.7% location-do [75] 67.3% [75] 2856(39.9%) 0(0.0%) location-do .../simpler-alts/src/programs.rkt:87:0 location-do [75] 67.3% ??? [70] 32.7% --------------------------------------------------------------------------------------- for-loop [15] 1.4% for-loop [25] 2.3% for-loop [68] 4.6% for-loop [21] 19.2% ??? [80] 22.4% ??? [70] 22.4% for-loop [14] 27.5% [76] 2856(39.9%) 198(2.8%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [4] 27.5% ??? [80] 22.4% ??? [5] 20.7% parse-loop74 [3] 20.1% matcher [10] 4.6% f40 [8] 2.3% --------------------------------------------------------------------------------------- temp85_0 [71] 100.0% [77] 2458(34.4%) 0(0.0%) compile15 (unknown source) temp91_0 [81] 100.0% --------------------------------------------------------------------------------------- ??? [70] 100.0% [78] 390(5.5%) 0(0.0%) ival-mult ...impler-alts/src/biginterval.rkt:129:0 bfmul [82] 100.0% --------------------------------------------------------------------------------------- for-loop [74] 100.0% [79] 196(2.7%) 196(2.7%) ??? ...7.5/collects/racket/private/for.rkt:1236:14 --------------------------------------------------------------------------------------- hash-ref! [76] 100.0% [80] 2658(37.2%) 0(0.0%) ??? ...rbie/simpler-alts/src/core/taylor.rkt:44:15 hash-ref! [76] 100.0% --------------------------------------------------------------------------------------- compile15 [77] 100.0% [81] 2458(34.4%) 0(0.0%) temp91_0 (unknown source) temp118_0 [83] 100.0% --------------------------------------------------------------------------------------- ival-mult [78] 100.0% [82] 390(5.5%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [84] 100.0% --------------------------------------------------------------------------------------- temp91_0 [81] 100.0% [83] 2458(34.4%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [85] 100.0% --------------------------------------------------------------------------------------- bfmul [82] 100.0% [84] 390(5.5%) 390(5.5%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 --------------------------------------------------------------------------------------- loop [87] 7.7% temp118_0 [83] 92.3% [85] 2662(37.2%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [86] 92.3% loop [87] 7.7% --------------------------------------------------------------------------------------- expand-capturing-lifts [85] 100.0% [86] 2458(34.4%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [88] 100.0% --------------------------------------------------------------------------------------- datum->syntax6 [28] 0.2% expand-capturing-lifts [85] 3.0% prepare-points-intervals [34] 3.0% for-loop [92] 8.9% for-loop [36] 8.9% loop [87] 11.7% ??? [43] 18.1% syntax-e/no-taint [16] 46.0% [87] 2242(31.3%) 400(5.6%) loop (unknown source) gf [89] 46.0% sample-multi-bounded [90] 18.1% loop [87] 11.7% expand-id-application-form17 [91] 8.9% expand-capturing-lifts [85] 3.0% for-loop [92] 3.0% --------------------------------------------------------------------------------------- lambda-clause-expander [86] 14.4% for-loop [92] 85.6% [88] 2458(34.4%) 0(0.0%) finish-bodys (unknown source) for-loop [92] 100.0% --------------------------------------------------------------------------------------- loop [87] 100.0% [89] 1232(17.2%) 0(0.0%) gf (unknown source) propagation-apply [93] 65.4% propagation-merge [95] 18.3% propagation-apply-shifted [96] 16.2% --------------------------------------------------------------------------------------- ??? [43] 48.1% loop [87] 51.9% [90] 782(10.9%) 206(2.9%) sample-multi-bounded ...r-alts/src/points.rkt:14:0 random-ranges [94] 73.7% --------------------------------------------------------------------------------------- loop [87] 100.0% [91] 400(5.6%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [16] 100.0% --------------------------------------------------------------------------------------- fallback-loop [22] 0.1% run-module-instance!125 [100] 3.8% loop [87] 3.8% for-loop [92] 8.4% finish-bodys [88] 83.9% [92] 2662(37.2%) 400(5.6%) for-loop (unknown source) finish-bodys [88] 72.2% for-loop [92] 8.4% expand-implicit [7] 4.1% run-module-instance!125 [100] 3.8% temp37_0 [99] 3.8% syntax-e [6] 1.7% add-local-binding!39 [98] 1.4% loop [87] 0.5% expand-identifier [9] 0.2% --------------------------------------------------------------------------------------- gf [89] 100.0% [93] 806(11.3%) 806(11.3%) propagation-apply (unknown source) --------------------------------------------------------------------------------------- sample-multi-bounded [90] 100.0% [94] 576(8.1%) 200(2.8%) random-ranges ...simpler-alts/src/common.rkt:164:0 cons/c [97] 65.3% --------------------------------------------------------------------------------------- gf [89] 100.0% [95] 226(3.2%) 226(3.2%) propagation-merge (unknown source) --------------------------------------------------------------------------------------- gf [89] 100.0% [96] 200(2.8%) 200(2.8%) propagation-apply-shifted (unknown source) --------------------------------------------------------------------------------------- random-ranges [94] 100.0% [97] 376(5.3%) 0(0.0%) cons/c .../racket/contract/private/guts.rkt:500:15 flat-contract? [102] 50.5% coerce-contract [103] 49.5% --------------------------------------------------------------------------------------- for-loop [92] 100.0% [98] 224(3.1%) 224(3.1%) add-local-binding!39 (unknown source) --------------------------------------------------------------------------------------- for-loop [92] 100.0% [99] 204(2.9%) 0(0.0%) temp37_0 (unknown source) [running body] [101] 100.0% --------------------------------------------------------------------------------------- for-loop [92] 100.0% [100] 204(2.9%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [92] 100.0% --------------------------------------------------------------------------------------- temp37_0 [99] 100.0% [101] 204(2.9%) 0(0.0%) [running body] .../collects/syntax/struct.rkt":##f do-partial-app [104] 100.0% --------------------------------------------------------------------------------------- cons/c [97] 100.0% [102] 190(2.7%) 190(2.7%) flat-contract? .../contract/private/guts.rkt:129:0 --------------------------------------------------------------------------------------- cons/c [97] 100.0% [103] 186(2.6%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [105] 100.0% --------------------------------------------------------------------------------------- [running body] [101] 100.0% [104] 204(2.9%) 0(0.0%) do-partial-app ...ntract/private/provide.rkt:493:0 successfully-got-the-right-kind-of-function [106]100.0% --------------------------------------------------------------------------------------- coerce-contract [103] 100.0% [105] 186(2.6%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [107] 100.0% --------------------------------------------------------------------------------------- do-partial-app [104] 100.0% [106] 204(2.9%) 204(2.9%) successfully-got-the-right-kind-of-function ...5:4 --------------------------------------------------------------------------------------- coerce-contract/f [105] 100.0% [107] 186(2.6%) 186(2.6%) coerce-simple-value ...ract/private/guts.rkt:385:0 ---------------------------------------------------------------------------------------