Profiling results ----------------- Total cpu time observed: 21556ms (out of 21728ms) Number of samples taken: 102 (once every 211ms) (Hiding functions with self<1.0% and local<2.0%: 3 of 106 hidden) ================================================================================ Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ================================================================================ [1] 21556(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [5] 100.0% -------------------------------------------------------------------------------- ??? [47] 100.0% [2] 400(1.9%) 0(0.0%) approximate9 ...uilding-2/src/core/taylor.rkt:11:0 loop [6] 100.0% -------------------------------------------------------------------------------- matcher [58] 100.0% [3] 200(0.9%) 0(0.0%) ??? ...ph-rebuilding-2/src/core/matcher.rkt:127:11 for-loop [7] 100.0% -------------------------------------------------------------------------------- hash-ref! [53] 100.0% [4] 200(0.9%) 0(0.0%) ??? ...aph-rebuilding-2/src/core/taylor.rkt:290:26 for-loop [8] 100.0% -------------------------------------------------------------------------------- ??? [1] 100.0% [5] 21556(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [9] 100.0% -------------------------------------------------------------------------------- approximate9 [2] 100.0% [6] 400(1.9%) 0(0.0%) loop ...raph-rebuilding-2/src/core/taylor.rkt:86:4 ??? [47] 100.0% -------------------------------------------------------------------------------- ??? [3] 100.0% [7] 200(0.9%) 0(0.0%) for-loop ...building-2/src/core/matcher.rkt:129:15 matcher [58] 100.0% -------------------------------------------------------------------------------- ??? [4] 100.0% [8] 200(0.9%) 0(0.0%) for-loop ...ebuilding-2/src/core/taylor.rkt:290:52 hash-ref! [53] 100.0% -------------------------------------------------------------------------------- profile-thunk16 [5] 100.0% [9] 21556(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [10] 100.0% -------------------------------------------------------------------------------- for-loop [50] 1.9% run [9] 98.1% [10] 21556(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [11] 92.9% prepare-points-intervals [12] 3.7% eval-errors [15] 1.0% ??? [13] 0.9% errors [46] 0.5% ??? [14] 0.5% -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10] 100.0% [11] 20322(94.3%) 0(0.0%) run-improve47 ...building-2/src/mainloop.rkt:346:0 for-loop [16] 100.0% -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10] 100.0% [12] 808(3.7%) 0(0.0%) prepare-points-intervals ...2/src/points.rkt:120:0 loop [17] 100.0% -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10] 100.0% [13] 406(1.9%) 406(1.9%) ??? ...h-rebuilding-2/src/syntax/syntax.rkt:214:17 -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10] 100.0% [14] 216(1.0%) 216(1.0%) ??? ...cket-7.5/collects/racket/function.rkt:93:12 -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10] 100.0% [15] 210(1.0%) 0(0.0%) eval-errors ...h-rebuilding-2/src/points.rkt:168:0 for-loop [18] 100.0% -------------------------------------------------------------------------------- run-improve47 [11] 100.0% [16] 20322(94.3%) 0(0.0%) for-loop ...ph-rebuilding-2/src/mainloop.rkt:365:4 run-iter! [19] 100.0% -------------------------------------------------------------------------------- prepare-points-intervals [12] 100.0% [17] 808(3.7%) 0(0.0%) loop ...-regraph-rebuilding-2/src/points.rkt:132:4 ??? [20] 74.5% loop [21] 25.5% -------------------------------------------------------------------------------- eval-errors [15] 100.0% [18] 210(1.0%) 0(0.0%) for-loop ...raph-rebuilding-2/src/points.rkt:170:2 ??? [47] 100.0% -------------------------------------------------------------------------------- for-loop [16] 100.0% [19] 20322(94.3%) 0(0.0%) run-iter! ...h-rebuilding-2/src/mainloop.rkt:327:0 simplify! [22] 91.0% finalize-iter! [23] 6.0% gen-series! [25] 2.0% gen-rewrites! [28] 1.0% -------------------------------------------------------------------------------- loop [17] 100.0% [20] 602(2.8%) 0(0.0%) ??? ...y-regraph-rebuilding-2/src/points.rkt:113:6 sample-multi-bounded [24] 66.8% ??? [27] 33.2% -------------------------------------------------------------------------------- loop [17] 100.0% [21] 206(1.0%) 0(0.0%) loop ...y-regraph-rebuilding-2/src/points.rkt:79:2 real->precision [26] 100.0% -------------------------------------------------------------------------------- run-iter! [19] 100.0% [22] 18502(85.8%) 0(0.0%) simplify! ...h-rebuilding-2/src/mainloop.rkt:224:0 ??? [29] 100.0% -------------------------------------------------------------------------------- run-iter! [19] 100.0% [23] 1220(5.7%) 0(0.0%) finalize-iter! ...uilding-2/src/mainloop.rkt:278:0 ??? [30] 100.0% -------------------------------------------------------------------------------- ??? [20] 100.0% [24] 402(1.9%) 0(0.0%) sample-multi-bounded ...ding-2/src/points.rkt:14:0 random-ranges [31] 100.0% -------------------------------------------------------------------------------- run-iter! [19] 100.0% [25] 400(1.9%) 0(0.0%) gen-series! ...rebuilding-2/src/mainloop.rkt:160:0 for-loop [32] 100.0% -------------------------------------------------------------------------------- loop [21] 100.0% [26] 206(1.0%) 0(0.0%) real->precision ...ilding-2/src/programs.rkt:94:11 ??? [47] 100.0% -------------------------------------------------------------------------------- ??? [20] 100.0% [27] 200(0.9%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ??? [33] 100.0% -------------------------------------------------------------------------------- run-iter! [19] 100.0% [28] 200(0.9%) 0(0.0%) gen-rewrites! ...building-2/src/mainloop.rkt:183:0 for-loop [34] 100.0% -------------------------------------------------------------------------------- simplify! [22] 100.0% [29] 18502(85.8%) 0(0.0%) ??? ...aph-rebuilding-2/src/core/simplify.rkt:38:0 ??? [35] 100.0% -------------------------------------------------------------------------------- pattern-match [71] 14.1% finalize-iter! [23] 85.9% [30] 1420(6.6%) 200(0.9%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [36] 85.9% -------------------------------------------------------------------------------- sample-multi-bounded [24] 100.0% [31] 402(1.9%) 200(0.9%) random-ranges ...rebuilding-2/src/common.rkt:164:0 build--> [38] 50.2% -------------------------------------------------------------------------------- gen-series! [25] 100.0% [32] 400(1.9%) 0(0.0%) for-loop ...ph-rebuilding-2/src/mainloop.rkt:167:7 taylor-alt [37] 100.0% -------------------------------------------------------------------------------- ??? [27] 100.0% [33] 200(0.9%) 200(0.9%) ??? ...cts/racket/contract/private/list.rkt:209:10 -------------------------------------------------------------------------------- gen-rewrites! [28] 100.0% [34] 200(0.9%) 0(0.0%) for-loop ...h-rebuilding-2/src/mainloop.rkt:191:11 rewrite-expression-head24 [39] 100.0% -------------------------------------------------------------------------------- ??? [29] 100.0% [35] 18502(85.8%) 0(0.0%) ??? ...aph-rebuilding-2/src/core/simplify.rkt:56:0 for-loop [40] 100.0% -------------------------------------------------------------------------------- ??? [30] 100.0% [36] 1220(5.7%) 0(0.0%) for-loop ...building-2/src/core/alt-table.rkt:46:2 atab-add-altn [41] 66.1% loop [43] 17.5% errors [46] 16.4% -------------------------------------------------------------------------------- for-loop [32] 100.0% [37] 400(1.9%) 0(0.0%) taylor-alt ...-rebuilding-2/src/mainloop.rkt:146:0 for-loop [42] 100.0% -------------------------------------------------------------------------------- random-ranges [31] 100.0% [38] 202(0.9%) 202(0.9%) build--> ...act/private/arrow-val-first.rkt:1214:0 -------------------------------------------------------------------------------- for-loop [34] 100.0% [39] 200(0.9%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [44] 100.0% -------------------------------------------------------------------------------- ??? [35] 100.0% [40] 18502(85.8%) 0(0.0%) for-loop ...ebuilding-2/src/core/simplify.rkt:76:2 for-loop [45] 100.0% -------------------------------------------------------------------------------- for-loop [36] 100.0% [41] 806(3.7%) 0(0.0%) atab-add-altn ...ng-2/src/core/alt-table.rkt:194:0 errors [46] 100.0% -------------------------------------------------------------------------------- taylor-alt [37] 100.0% [42] 400(1.9%) 0(0.0%) for-loop ...ph-rebuilding-2/src/mainloop.rkt:152:6 ??? [47] 100.0% -------------------------------------------------------------------------------- for-loop [36] 100.0% [43] 214(1.0%) 0(0.0%) loop ...-rebuilding-2/src/core/alt-table.rkt:168:2 map [79] 100.0% -------------------------------------------------------------------------------- rewrite-expression-head24 [39] 25.0% matcher [58] 75.0% [44] 200(0.9%) 0(0.0%) rewriter ...rebuilding-2/src/core/matcher.rkt:87:2 for-loop [48] 100.0% -------------------------------------------------------------------------------- for-loop [40] 100.0% [45] 18502(85.8%) 0(0.0%) for-loop ...ebuilding-2/src/core/simplify.rkt:80:4 ??? [49] 95.5% loop [51] 2.3% egraph-rebuild-loop [55] 1.1% egraph-rebuild [56] 1.1% -------------------------------------------------------------------------------- for-loop [36] 16.4% .../more-scheme.rkt:261:28 [10] 17.7% atab-add-altn [41] 66.0% [46] 1222(5.7%) 200(0.9%) errors ...egraph-rebuilding-2/src/points.rkt:190:0 for-loop [50] 67.3% temp85_0 [78] 16.4% -------------------------------------------------------------------------------- loop [6] 16.3% location-do [52] 16.3% for-loop [42] 16.3% real->precision [26] 25.2% for-loop [18] 25.7% [47] 816(3.8%) 210(1.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 bf [54] 25.2% location-do [52] 16.3% approximate9 [2] 16.3% hash-ref! [53] 16.3% -------------------------------------------------------------------------------- rewriter [44] 100.0% [48] 200(0.9%) 0(0.0%) for-loop ...rebuilding-2/src/core/matcher.rkt:89:4 matcher [58] 75.0% for-loop [57] 25.0% -------------------------------------------------------------------------------- for-loop [45] 100.0% [49] 17670(82.0%) 0(0.0%) ??? ...-regraph-rebuilding-2/regraph/main.rkt:45:0 find-matches [59] 94.3% for-loop [60] 5.7% -------------------------------------------------------------------------------- errors [46] 100.0% [50] 822(3.8%) 0(0.0%) for-loop ...raph-rebuilding-2/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [10] 100.0% -------------------------------------------------------------------------------- for-loop [45] 100.0% [51] 422(2.0%) 0(0.0%) loop ...h-rebuilding-2/regraph/extraction.rkt:25:2 for-loop [61] 100.0% -------------------------------------------------------------------------------- location-do [52] 33.3% ??? [47] 66.7% [52] 400(1.9%) 0(0.0%) location-do ...-rebuilding-2/src/programs.rkt:63:0 ??? [47] 66.7% location-do [52] 33.3% -------------------------------------------------------------------------------- for-loop [8] 16.7% ??? [63] 16.7% ??? [47] 66.7% [53] 400(1.9%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [63] 66.7% ??? [4] 16.7% f61 [70] 16.7% -------------------------------------------------------------------------------- ??? [47] 100.0% [54] 206(1.0%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [64] 100.0% -------------------------------------------------------------------------------- for-loop [45] 100.0% [55] 206(1.0%) 0(0.0%) egraph-rebuild-loop ...g-2/regraph/egraph.rkt:64:0 egraph-rebuild-once [62] 100.0% -------------------------------------------------------------------------------- for-loop [45] 100.0% [56] 204(0.9%) 0(0.0%) egraph-rebuild ...ilding-2/regraph/egraph.rkt:61:0 egraph-rebuild-once [62] 100.0% -------------------------------------------------------------------------------- for-loop [48] 100.0% [57] 200(0.9%) 0(0.0%) for-loop ...rebuilding-2/src/core/matcher.rkt:96:8 fix-up-variables [65] 100.0% -------------------------------------------------------------------------------- for-loop [7] 50.0% for-loop [48] 50.0% [58] 200(0.9%) 0(0.0%) matcher ...rebuilding-2/src/core/matcher.rkt:115:2 ??? [3] 50.0% rewriter [44] 50.0% -------------------------------------------------------------------------------- ??? [49] 100.0% [59] 16664(77.3%) 0(0.0%) find-matches ...rebuilding-2/regraph/main.rkt:37:0 for-loop [66] 100.0% -------------------------------------------------------------------------------- ??? [49] 100.0% [60] 1006(4.7%) 0(0.0%) for-loop ...aph-rebuilding-2/regraph/main.rkt:48:2 for-loop [67] 100.0% -------------------------------------------------------------------------------- loop [51] 100.0% [61] 422(2.0%) 0(0.0%) for-loop ...building-2/regraph/extraction.rkt:28:4 for-loop [68] 100.0% -------------------------------------------------------------------------------- egraph-rebuild [56] 49.8% egraph-rebuild-loop [55] 50.2% [62] 410(1.9%) 0(0.0%) egraph-rebuild-once ...g-2/regraph/egraph.rkt:68:0 for-loop [69] 100.0% -------------------------------------------------------------------------------- hash-ref! [53] 100.0% [63] 400(1.9%) 0(0.0%) ??? ...raph-rebuilding-2/src/core/taylor.rkt:44:15 f61 [70] 50.0% hash-ref! [53] 50.0% -------------------------------------------------------------------------------- bf [54] 100.0% [64] 206(1.0%) 206(1.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 -------------------------------------------------------------------------------- for-loop [57] 100.0% [65] 200(0.9%) 0(0.0%) fix-up-variables ...g-2/src/core/matcher.rkt:108:2 pattern-match [71] 100.0% -------------------------------------------------------------------------------- for-loop [66] 50.0% find-matches [59] 50.0% [66] 16664(77.3%) 0(0.0%) for-loop ...aph-rebuilding-2/regraph/main.rkt:39:2 for-loop [66] 50.0% match-e [72] 50.0% -------------------------------------------------------------------------------- for-loop [60] 100.0% [67] 1006(4.7%) 0(0.0%) for-loop ...aph-rebuilding-2/regraph/main.rkt:51:4 substitute-e [73] 79.9% add-enode-rec! [76] 20.1% -------------------------------------------------------------------------------- for-loop [61] 100.0% [68] 422(2.0%) 422(2.0%) for-loop ...uilding-2/regraph/extraction.rkt:36:16 -------------------------------------------------------------------------------- egraph-rebuild-once [62] 100.0% [69] 410(1.9%) 204(0.9%) for-loop ...h-rebuilding-2/regraph/egraph.rkt:72:2 for-loop [75] 50.2% -------------------------------------------------------------------------------- hash-ref! [53] 50.0% ??? [63] 50.0% [70] 400(1.9%) 0(0.0%) f61 (unknown source) eval-const-expr [74] 100.0% -------------------------------------------------------------------------------- pattern-match [71] 50.0% fix-up-variables [65] 50.0% [71] 200(0.9%) 0(0.0%) pattern-match ...lding-2/src/core/matcher.rkt:29:0 pattern-match [71] 50.0% ??? [30] 50.0% -------------------------------------------------------------------------------- for-loop [80] 31.6% for-loop [66] 68.4% [72] 16664(77.3%) 1850(8.6%) match-e ...ph-rebuilding-2/regraph/ematch.rkt:35:0 for-loop [77] 93.3% -------------------------------------------------------------------------------- substitute-e [73] 24.9% for-loop [67] 75.1% [73] 804(3.7%) 804(3.7%) substitute-e ...building-2/regraph/ematch.rkt:55:0 substitute-e [73] 24.9% -------------------------------------------------------------------------------- f61 [70] 100.0% [74] 400(1.9%) 0(0.0%) eval-const-expr ...ilding-2/src/programs.rkt:120:0 temp85_0 [78] 100.0% -------------------------------------------------------------------------------- for-loop [69] 100.0% [75] 206(1.0%) 206(1.0%) for-loop ...h-rebuilding-2/regraph/egraph.rkt:73:4 -------------------------------------------------------------------------------- for-loop [67] 100.0% [76] 202(0.9%) 0(0.0%) add-enode-rec! ...lding-2/regraph/egraph.rkt:161:0 map [79] 100.0% -------------------------------------------------------------------------------- match-e [72] 100.0% [77] 16062(74.5%) 8024(37.2%) for-loop ...-rebuilding-2/regraph/ematch.rkt:41:11 for-loop [80] 39.1% loop [81] 19.9% procedure-reduce-keyword-arity-mask [82] 2.9% foldr [85] 1.9% do-curry [84] 1.8% ??? [89] 1.3% foldl [88] 0.4% -------------------------------------------------------------------------------- errors [46] 33.3% eval-const-expr [74] 66.7% [78] 600(2.8%) 0(0.0%) temp85_0 (unknown source) compile15 [83] 100.0% -------------------------------------------------------------------------------- add-enode-rec! [76] 48.6% loop [43] 51.4% [79] 416(1.9%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 loop [86] 51.4% mk-enode-rec! [87] 48.6% -------------------------------------------------------------------------------- for-loop [77] 100.0% [80] 10254(47.6%) 602(2.8%) for-loop ...-rebuilding-2/regraph/ematch.rkt:47:37 match-e [72] 95.1% -------------------------------------------------------------------------------- for-loop [77] 3.2% loop [81] 96.8% [81] 3190(14.8%) 1716(8.0%) loop (unknown source) loop [81] 96.8% foldl [88] 1.0% step [91] 0.9% ??? [89] 0.0% -------------------------------------------------------------------------------- for-loop [77] 100.0% [82] 1008(4.7%) 1008(4.7%) procedure-reduce-keyword-arity-mask ....rkt:1597:4 -------------------------------------------------------------------------------- temp85_0 [78] 100.0% [83] 600(2.8%) 0(0.0%) compile15 (unknown source) temp91_0 [90] 100.0% -------------------------------------------------------------------------------- for-loop [77] 100.0% [84] 574(2.7%) 574(2.7%) do-curry ...-7.5/collects/racket/function.rkt:71:2 -------------------------------------------------------------------------------- for-loop [77] 100.0% [85] 406(1.9%) 406(1.9%) foldr ....5/collects/racket/private/list.rkt:242:4 -------------------------------------------------------------------------------- map [79] 100.0% [86] 214(1.0%) 0(0.0%) loop ...-7.5/collects/racket/private/map.rkt:40:19 ??? [92] 100.0% -------------------------------------------------------------------------------- map [79] 100.0% [87] 202(0.9%) 202(0.9%) mk-enode-rec! ...ilding-2/regraph/egraph.rkt:152:0 -------------------------------------------------------------------------------- for-loop [77] 18.7% loop [81] 81.3% [88] 1070(5.0%) 0(0.0%) foldl ....5/collects/racket/private/list.rkt:229:4 merge2 [93] 100.0% -------------------------------------------------------------------------------- loop [81] 32.9% for-loop [77] 67.1% [89] 608(2.8%) 608(2.8%) ??? ...ket-7.5/collects/racket/function.rkt:138:13 -------------------------------------------------------------------------------- compile15 [83] 100.0% [90] 600(2.8%) 0(0.0%) temp91_0 (unknown source) expand [94] 33.3% temp118_0 [95] 33.3% compile-top9 [96] 33.3% -------------------------------------------------------------------------------- loop [81] 100.0% [91] 404(1.9%) 404(1.9%) step ...ket-7.5/collects/racket/function.rkt:145:9 -------------------------------------------------------------------------------- loop [86] 100.0% [92] 214(1.0%) 214(1.0%) ??? ...-rebuilding-2/src/core/alt-table.rkt:185:12 -------------------------------------------------------------------------------- foldl [88] 100.0% [93] 1070(5.0%) 1070(5.0%) merge2 ...aph-rebuilding-2/regraph/ematch.rkt:20:0 -------------------------------------------------------------------------------- temp91_0 [90] 100.0% [94] 200(0.9%) 200(0.9%) expand (unknown source) -------------------------------------------------------------------------------- temp91_0 [90] 100.0% [95] 200(0.9%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [97] 100.0% -------------------------------------------------------------------------------- temp91_0 [90] 100.0% [96] 200(0.9%) 0(0.0%) compile-top9 (unknown source) compile-forms33 [98] 100.0% -------------------------------------------------------------------------------- temp118_0 [95] 100.0% [97] 200(0.9%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [99] 100.0% -------------------------------------------------------------------------------- compile-top9 [96] 100.0% [98] 200(0.9%) 0(0.0%) compile-forms33 (unknown source) for-loop [101] 100.0% -------------------------------------------------------------------------------- expand-capturing-lifts [97] 100.0% [99] 200(0.9%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [100] 100.0% -------------------------------------------------------------------------------- lambda-clause-expander [99] 33.3% for-loop [101] 66.7% [100] 200(0.9%) 0(0.0%) finish-bodys (unknown source) for-loop [101] 100.0% -------------------------------------------------------------------------------- for-loop [101] 20.0% finish-bodys [100] 30.0% compile-forms33 [98] 50.0% [101] 400(1.9%) 0(0.0%) for-loop (unknown source) compile-module-linklet57 [103] 50.0% finish-bodys [100] 20.0% for-loop [101] 20.0% expand-implicit [102] 10.0% -------------------------------------------------------------------------------- for-loop [101] 100.0% [102] 200(0.9%) 200(0.9%) expand-implicit (unknown source) -------------------------------------------------------------------------------- for-loop [101] 100.0% [103] 200(0.9%) 200(0.9%) compile-module-linklet57 (unknown source) --------------------------------------------------------------------------------