Profiling results ----------------- Total cpu time observed: 6714ms (out of 6872ms) Number of samples taken: 31 (once every 217ms) ======================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================= [1] 6714(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% ----------------------------------------------------------------------- matcher [65] 100.0% [2] 200(3.0%) 0(0.0%) ??? ...ie/simpler-alts/src/core/matcher.rkt:129:11 for-loop [4] 100.0% ----------------------------------------------------------------------- ??? [1] 100.0% [3] 6714(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% ----------------------------------------------------------------------- ??? [2] 100.0% [4] 200(3.0%) 0(0.0%) for-loop ...mpler-alts/src/core/matcher.rkt:131:15 hash-ref! [58] 100.0% ----------------------------------------------------------------------- profile-thunk16 [3] 100.0% [5] 6714(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [6] 100.0% ----------------------------------------------------------------------- for-loop [46] 6.0% run [5] 94.0% [6] 6714(100.0%) 202(3.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [7] 54.8% prepare-points-intervals [8] 32.5% eval-errors [10] 3.5% errors [41] 3.3% ??? [9] 3.1% ??? [39] 1.4% ----------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [7] 4076(60.7%) 0(0.0%) run-improve47 ...mpler-alts/src/mainloop.rkt:365:0 for-loop [11] 89.0% simplify! [18] 11.0% ----------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [8] 2180(32.5%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:122:0 loop [12] 91.4% eval-prog [14] 8.6% ----------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [9] 412(6.1%) 412(6.1%) ??? ...e/simpler-alts/src/syntax/syntax.rkt:214:17 ----------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [10] 234(3.5%) 0(0.0%) eval-errors ...e/simpler-alts/src/points.rkt:170:0 for-loop [13] 100.0% ----------------------------------------------------------------------- run-improve47 [7] 100.0% [11] 3626(54.0%) 0(0.0%) for-loop ...ie/simpler-alts/src/mainloop.rkt:384:4 run-iter! [15] 100.0% ----------------------------------------------------------------------- prepare-points-intervals [8] 100.0% [12] 1992(29.7%) 0(0.0%) loop ...s/herbie/simpler-alts/src/points.rkt:134:4 loop [16] 70.3% ??? [17] 19.7% do-curry [85] 10.0% ----------------------------------------------------------------------- eval-errors [10] 100.0% [13] 234(3.5%) 234(3.5%) for-loop ...rbie/simpler-alts/src/points.rkt:172:2 ----------------------------------------------------------------------- prepare-points-intervals [8] 100.0% [14] 188(2.8%) 0(0.0%) eval-prog ...e/simpler-alts/src/programs.rkt:106:0 hash-ref! [58] 100.0% ----------------------------------------------------------------------- for-loop [11] 100.0% [15] 3626(54.0%) 0(0.0%) run-iter! ...e/simpler-alts/src/mainloop.rkt:346:0 finalize-iter! [19] 33.6% simplify! [18] 29.1% gen-series! [20] 25.8% localize! [21] 6.0% gen-rewrites! [24] 5.5% ----------------------------------------------------------------------- loop [12] 100.0% [16] 1400(20.9%) 206(3.1%) loop ...es/herbie/simpler-alts/src/points.rkt:79:2 ??? [39] 56.4% ??? [22] 14.6% ??? [23] 14.3% ----------------------------------------------------------------------- loop [12] 100.0% [17] 392(5.8%) 0(0.0%) ??? ...es/herbie/simpler-alts/src/points.rkt:115:6 sample-multi-bounded [76] 52.6% loop [71] 47.4% ----------------------------------------------------------------------- run-improve47 [7] 29.9% run-iter! [15] 70.1% [18] 1506(22.4%) 0(0.0%) simplify! ...e/simpler-alts/src/mainloop.rkt:224:0 ??? [25] 100.0% ----------------------------------------------------------------------- run-iter! [15] 100.0% [19] 1220(18.2%) 0(0.0%) finalize-iter! ...pler-alts/src/mainloop.rkt:278:0 ??? [26] 100.0% ----------------------------------------------------------------------- run-iter! [15] 100.0% [20] 934(13.9%) 0(0.0%) gen-series! ...simpler-alts/src/mainloop.rkt:160:0 for-loop [27] 100.0% ----------------------------------------------------------------------- run-iter! [15] 100.0% [21] 216(3.2%) 0(0.0%) localize! ...e/simpler-alts/src/mainloop.rkt:127:0 localize-error [28] 100.0% ----------------------------------------------------------------------- loop [16] 100.0% [22] 204(3.0%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-add [29] 100.0% ----------------------------------------------------------------------- loop [16] 100.0% [23] 200(3.0%) 200(3.0%) ??? ...cket-7.5/collects/racket/function.rkt:93:12 ----------------------------------------------------------------------- run-iter! [15] 100.0% [24] 200(3.0%) 0(0.0%) gen-rewrites! ...mpler-alts/src/mainloop.rkt:183:0 for-loop [30] 100.0% ----------------------------------------------------------------------- simplify! [18] 100.0% [25] 1506(22.4%) 0(0.0%) ??? ...bie/simpler-alts/src/core/simplify.rkt:42:0 egraph-run [31] 100.0% ----------------------------------------------------------------------- finalize-iter! [19] 100.0% [26] 1220(18.2%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [32] 100.0% ----------------------------------------------------------------------- gen-series! [20] 100.0% [27] 934(13.9%) 0(0.0%) for-loop ...ie/simpler-alts/src/mainloop.rkt:167:7 taylor-alt [33] 100.0% ----------------------------------------------------------------------- localize! [21] 100.0% [28] 216(3.2%) 0(0.0%) localize-error ...-alts/src/core/localize.rkt:57:0 hash-ref! [58] 100.0% ----------------------------------------------------------------------- ??? [22] 100.0% [29] 204(3.0%) 0(0.0%) ival-add ...simpler-alts/src/biginterval.rkt:111:0 bfadd [84] 100.0% ----------------------------------------------------------------------- gen-rewrites! [24] 100.0% [30] 200(3.0%) 0(0.0%) for-loop ...e/simpler-alts/src/mainloop.rkt:191:11 rewrite-expression-head23 [34] 100.0% ----------------------------------------------------------------------- ??? [25] 100.0% [31] 1506(22.4%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [35] 100.0% ----------------------------------------------------------------------- ??? [26] 100.0% [32] 1220(18.2%) 0(0.0%) for-loop ...pler-alts/src/core/alt-table.rkt:201:2 atab-add-altn [36] 100.0% ----------------------------------------------------------------------- for-loop [27] 100.0% [33] 934(13.9%) 0(0.0%) taylor-alt .../simpler-alts/src/mainloop.rkt:146:0 for-loop [37] 100.0% ----------------------------------------------------------------------- for-loop [30] 100.0% [34] 200(3.0%) 0(0.0%) rewrite-expression-head23 ...core/matcher.rkt:83:0 rewriter [38] 100.0% ----------------------------------------------------------------------- egraph-run [31] 100.0% [35] 1506(22.4%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [40] 100.0% ----------------------------------------------------------------------- for-loop [32] 100.0% [36] 1220(18.2%) 0(0.0%) atab-add-altn ...alts/src/core/alt-table.rkt:204:0 errors [41] 82.1% best-and-tied-at-points [42] 17.9% ----------------------------------------------------------------------- taylor-alt [33] 100.0% [37] 934(13.9%) 0(0.0%) for-loop ...ie/simpler-alts/src/mainloop.rkt:152:6 ??? [39] 100.0% ----------------------------------------------------------------------- rewrite-expression-head23 [34] 25.0% matcher [65] 75.0% [38] 200(3.0%) 0(0.0%) rewriter ...simpler-alts/src/core/matcher.rkt:85:2 for-loop [43] 100.0% ----------------------------------------------------------------------- loop [54] 3.4% ??? [63] 4.0% .../more-scheme.rkt:261:28 [6] 9.7% location-do [45] 20.7% for-loop [37] 20.7% loop [16] 41.4% [39] 1910(28.4%) 186(2.8%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-mult [48] 31.1% location-do [45] 20.7% approximate9 [47] 13.8% ival-div [53] 10.3% hash-ref! [58] 7.5% f40 [50] 6.9% ----------------------------------------------------------------------- egraph-add-exprs [35] 100.0% [40] 1506(22.4%) 0(0.0%) ??? ...ie/simpler-alts/src/core/simplify.rkt:103:6 for-loop [44] 100.0% ----------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 18.3% atab-add-altn [36] 81.7% [41] 1226(18.3%) 224(3.3%) errors ...herbie/simpler-alts/src/points.rkt:192:0 for-loop [46] 65.3% temp85_0 [49] 16.5% ----------------------------------------------------------------------- atab-add-altn [36] 100.0% [42] 218(3.2%) 0(0.0%) best-and-tied-at-points ...core/alt-table.rkt:91:0 for-loop [51] 100.0% ----------------------------------------------------------------------- rewriter [38] 100.0% [43] 200(3.0%) 0(0.0%) for-loop ...simpler-alts/src/core/matcher.rkt:87:4 hash-ref! [58] 75.0% for-loop [52] 25.0% ----------------------------------------------------------------------- ??? [40] 100.0% [44] 1506(22.4%) 1506(22.4%) for-loop ...mpler-alts/src/core/simplify.rkt:121:2 ----------------------------------------------------------------------- ??? [39] 40.3% location-do [45] 59.7% [45] 934(13.9%) 0(0.0%) location-do .../simpler-alts/src/programs.rkt:87:0 location-do [45] 59.7% ??? [39] 40.3% ----------------------------------------------------------------------- errors [41] 100.0% [46] 800(11.9%) 0(0.0%) for-loop ...rbie/simpler-alts/src/points.rkt:194:2 .../more-scheme.rkt:261:28 [6] 100.0% ----------------------------------------------------------------------- ??? [39] 100.0% [47] 670(10.0%) 0(0.0%) approximate9 ...pler-alts/src/core/taylor.rkt:11:0 loop [54] 63.9% for-loop [56] 36.1% ----------------------------------------------------------------------- ??? [39] 100.0% [48] 594(8.8%) 184(2.7%) ival-mult ...impler-alts/src/biginterval.rkt:129:0 bfadd [84] 69.0% ----------------------------------------------------------------------- eval-const-expr [79] 49.2% errors [41] 50.8% [49] 398(5.9%) 0(0.0%) temp85_0 (unknown source) compile15 [55] 100.0% ----------------------------------------------------------------------- ??? [39] 33.3% map [69] 66.7% [50] 264(3.9%) 0(0.0%) f40 (unknown source) map [69] 100.0% ----------------------------------------------------------------------- best-and-tied-at-points [42] 100.0% [51] 218(3.2%) 218(3.2%) for-loop ...mpler-alts/src/core/alt-table.rkt:94:4 ----------------------------------------------------------------------- for-loop [43] 100.0% [52] 200(3.0%) 0(0.0%) for-loop ...simpler-alts/src/core/matcher.rkt:94:8 fix-up-variables [57] 100.0% ----------------------------------------------------------------------- ??? [39] 100.0% [53] 196(2.9%) 196(2.9%) ival-div ...simpler-alts/src/biginterval.rkt:149:0 ----------------------------------------------------------------------- approximate9 [47] 100.0% [54] 428(6.4%) 0(0.0%) loop ...rbie/simpler-alts/src/core/taylor.rkt:86:4 hash-ref! [58] 54.2% ??? [39] 45.8% ----------------------------------------------------------------------- temp85_0 [49] 100.0% [55] 398(5.9%) 0(0.0%) compile15 (unknown source) temp91_0 [59] 100.0% ----------------------------------------------------------------------- approximate9 [47] 100.0% [56] 242(3.6%) 0(0.0%) for-loop ...simpler-alts/src/core/taylor.rkt:29:18 taylor [61] 100.0% ----------------------------------------------------------------------- for-loop [52] 100.0% [57] 200(3.0%) 0(0.0%) fix-up-variables ...lts/src/core/matcher.rkt:106:2 pattern-substitute [60] 100.0% ----------------------------------------------------------------------- eval-prog [14] 4.6% for-loop [4] 9.7% for-loop [43] 9.7% loop [54] 11.2% loop [71] 13.7% localize-error [28] 20.9% ??? [39] 30.2% [58] 1032(15.4%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop15 [64] 20.9% matcher [65] 19.4% ??? [66] 19.0% ??? [68] 13.7% ??? [63] 11.2% taylor [61] 11.2% bigfloat-hash [67] 4.6% ----------------------------------------------------------------------- compile15 [55] 100.0% [59] 398(5.9%) 0(0.0%) temp91_0 (unknown source) temp118_0 [62] 100.0% ----------------------------------------------------------------------- fix-up-variables [57] 33.3% pattern-substitute [60] 66.7% [60] 200(3.0%) 200(3.0%) pattern-substitute ...ts/src/core/matcher.rkt:45:0 pattern-substitute [60] 66.7% ----------------------------------------------------------------------- for-loop [56] 10.2% taylor [61] 40.8% hash-ref! [58] 48.9% [61] 474(7.1%) 0(0.0%) taylor ...e/simpler-alts/src/core/taylor.rkt:169:0 do-curry [85] 48.9% taylor [61] 40.8% debug-print [72] 10.2% ----------------------------------------------------------------------- temp91_0 [59] 100.0% [62] 398(5.9%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [70] 100.0% ----------------------------------------------------------------------- hash-ref! [58] 100.0% [63] 232(3.5%) 0(0.0%) ??? ...rbie/simpler-alts/src/core/taylor.rkt:67:15 ??? [39] 100.0% ----------------------------------------------------------------------- hash-ref! [58] 100.0% [64] 216(3.2%) 0(0.0%) parse-loop15 (unknown source) map [69] 100.0% ----------------------------------------------------------------------- hash-ref! [58] 100.0% [65] 200(3.0%) 0(0.0%) matcher ...simpler-alts/src/core/matcher.rkt:117:2 ??? [2] 50.0% rewriter [38] 50.0% ----------------------------------------------------------------------- hash-ref! [58] 100.0% [66] 196(2.9%) 0(0.0%) ??? ...rbie/simpler-alts/src/core/taylor.rkt:44:15 f61 [73] 100.0% ----------------------------------------------------------------------- hash-ref! [58] 100.0% [67] 188(2.8%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:168:0 bfcanonicalize [74] 100.0% ----------------------------------------------------------------------- hash-ref! [58] 100.0% [68] 188(2.8%) 0(0.0%) ??? .../herbie/simpler-alts/src/programs.rkt:202:5 loop [71] 100.0% ----------------------------------------------------------------------- parse-loop15 [64] 45.0% f40 [50] 55.0% [69] 480(7.1%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 loop [78] 45.0% f40 [50] 36.7% simplify-node [77] 18.3% ----------------------------------------------------------------------- temp118_0 [62] 100.0% [70] 398(5.9%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [75] 100.0% ----------------------------------------------------------------------- ??? [17] 49.7% ??? [68] 50.3% [71] 374(5.6%) 0(0.0%) loop (unknown source) hash-ref! [58] 50.3% sample-multi-bounded [76] 49.7% ----------------------------------------------------------------------- taylor [61] 100.0% [72] 242(3.6%) 242(3.6%) debug-print ...ie/simpler-alts/src/debug.rkt:110:0 ----------------------------------------------------------------------- ??? [66] 100.0% [73] 196(2.9%) 0(0.0%) f61 (unknown source) eval-const-expr [79] 100.0% ----------------------------------------------------------------------- bigfloat-hash [67] 100.0% [74] 188(2.8%) 188(2.8%) bfcanonicalize .../private/bigfloat/mpfr.rkt:158:0 ----------------------------------------------------------------------- expand-capturing-lifts [70] 100.0% [75] 398(5.9%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [80] 100.0% ----------------------------------------------------------------------- loop [71] 47.4% ??? [17] 52.6% [76] 392(5.8%) 0(0.0%) sample-multi-bounded ...r-alts/src/points.rkt:14:0 random-ranges [81] 100.0% ----------------------------------------------------------------------- map [69] 100.0% [77] 264(3.9%) 0(0.0%) simplify-node ...ler-alts/src/core/reduce.rkt:45:0 gather-multiplicative-terms [82] 100.0% ----------------------------------------------------------------------- map [69] 3.2% loop [78] 96.8% [78] 216(3.2%) 0(0.0%) loop ...-7.5/collects/racket/private/map.rkt:40:19 loop [78] 96.8% ??? [83] 3.2% ----------------------------------------------------------------------- f61 [73] 100.0% [79] 196(2.9%) 0(0.0%) eval-const-expr ...ler-alts/src/programs.rkt:144:0 temp85_0 [49] 100.0% ----------------------------------------------------------------------- lambda-clause-expander [75] 21.0% for-loop [86] 79.0% [80] 398(5.9%) 0(0.0%) finish-bodys (unknown source) for-loop [86] 100.0% ----------------------------------------------------------------------- sample-multi-bounded [76] 100.0% [81] 392(5.8%) 0(0.0%) random-ranges ...simpler-alts/src/common.rkt:164:0 build--> [87] 52.6% cons/c [88] 47.4% ----------------------------------------------------------------------- simplify-node [77] 100.0% [82] 264(3.9%) 0(0.0%) gather-multiplicative-terms ...re/reduce.rkt:109:0 do-curry [85] 100.0% ----------------------------------------------------------------------- loop [78] 100.0% [83] 216(3.2%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfadd [84] 100.0% ----------------------------------------------------------------------- ival-add [29] 24.6% ??? [83] 26.0% ival-mult [48] 49.4% [84] 830(12.4%) 0(0.0%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [89] 72.8% new-mpfr [91] 27.2% ----------------------------------------------------------------------- loop [12] 28.7% taylor [61] 33.3% gather-multiplicative-terms [82] 37.9% [85] 696(10.4%) 696(10.4%) do-curry ...-7.5/collects/racket/function.rkt:71:2 ----------------------------------------------------------------------- for-loop [86] 27.5% finish-bodys [80] 72.5% [86] 398(5.9%) 0(0.0%) for-loop (unknown source) finish-bodys [80] 58.7% for-loop [86] 27.5% expand-implicit [93] 9.8% dispatch-transformer41 [92] 3.9% ----------------------------------------------------------------------- random-ranges [81] 100.0% [87] 206(3.1%) 0(0.0%) build--> ...act/private/arrow-val-first.rkt:1214:0 coerce-contract [90] 100.0% ----------------------------------------------------------------------- random-ranges [81] 100.0% [88] 186(2.8%) 0(0.0%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [90] 100.0% ----------------------------------------------------------------------- bfadd [84] 100.0% [89] 604(9.0%) 604(9.0%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ----------------------------------------------------------------------- cons/c [88] 47.4% build--> [87] 52.6% [90] 392(5.8%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [94] 100.0% ----------------------------------------------------------------------- bfadd [84] 100.0% [91] 226(3.4%) 226(3.4%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ----------------------------------------------------------------------- for-loop [86] 100.0% [92] 202(3.0%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [95] 100.0% ----------------------------------------------------------------------- for-loop [86] 100.0% [93] 196(2.9%) 196(2.9%) expand-implicit (unknown source) ----------------------------------------------------------------------- coerce-contract [90] 100.0% [94] 392(5.8%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [96] 100.0% ----------------------------------------------------------------------- dispatch-transformer41 [92] 100.0% [95] 202(3.0%) 0(0.0%) apply-transformer52 (unknown source) apply-transformer-in-context [97]100.0% ----------------------------------------------------------------------- coerce-contract/f [94] 100.0% [96] 392(5.8%) 392(5.8%) coerce-simple-value ...ract/private/guts.rkt:385:0 ----------------------------------------------------------------------- apply-transformer52 [95] 100.0% [97] 202(3.0%) 202(3.0%) apply-transformer-in-context (unknown source) -----------------------------------------------------------------------