Profiling results ----------------- Total cpu time observed: 6304ms (out of 6400ms) Number of samples taken: 31 (once every 203ms) ============================================================================ Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================================ [1] 6304(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [4] 100.0% ---------------------------------------------------------------------------- loop [15] 50.0% for-loop [86] 50.0% [2] 404(6.4%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [5] 100.0% ---------------------------------------------------------------------------- taylor [67] 100.0% [3] 208(3.3%) 0(0.0%) taylor-invert ...uilding/src/core/taylor.rkt:317:0 parse-loop74 [6] 100.0% ---------------------------------------------------------------------------- ??? [1] 100.0% [4] 6304(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [7] 100.0% ---------------------------------------------------------------------------- syntax-e [2] 100.0% [5] 404(6.4%) 0(0.0%) syntax-e/no-taint (unknown source) loop [15] 100.0% ---------------------------------------------------------------------------- taylor-invert [3] 100.0% [6] 208(3.3%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [8] 100.0% ---------------------------------------------------------------------------- profile-thunk16 [4] 100.0% [7] 6304(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [9] 100.0% ---------------------------------------------------------------------------- parse-loop74 [6] 100.0% [8] 208(3.3%) 0(0.0%) eval-const-expr ...building/src/programs.rkt:120:0 loop [15] 100.0% ---------------------------------------------------------------------------- set-precompute! [68] 1.6% for-loop [47] 1.9% run [7] 96.5% [9] 6304(100.0%) 240(3.8%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [10] 62.4% prepare-points-intervals [11] 28.7% errors-score [12] 3.6% errors [41] 1.9% loop [15] 1.6% ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [9] 100.0% [10] 4032(64.0%) 0(0.0%) run-improve47 ...rebuilding/src/mainloop.rkt:346:0 for-loop [13] 100.0% ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [9] 100.0% [11] 1808(28.7%) 0(0.0%) prepare-points-intervals ...g/src/points.rkt:120:0 loop [14] 100.0% ---------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [9] 100.0% [12] 224(3.6%) 0(0.0%) errors-score ...ph-rebuilding/src/points.rkt:185:0 loop [15] 100.0% ---------------------------------------------------------------------------- run-improve47 [10] 100.0% [13] 4032(64.0%) 0(0.0%) for-loop ...raph-rebuilding/src/mainloop.rkt:365:4 run-iter! [16] 100.0% ---------------------------------------------------------------------------- prepare-points-intervals [11] 100.0% [14] 1808(28.7%) 0(0.0%) loop ...fy-regraph-rebuilding/src/points.rkt:132:4 loop [17] 77.8% ??? [19] 22.2% ---------------------------------------------------------------------------- errors-score [12] 0.0% for-loop [75] 3.2% apply-transformer52 [83] 6.5% .../more-scheme.rkt:261:28 [9] 6.5% eval-const-expr [8] 20.1% syntax-e/no-taint [5] 26.0% loop [15] 37.7% [15] 1036(16.4%) 224(3.6%) loop (unknown source) loop [15] 37.7% expand-capturing-lifts [71] 26.6% gf [18] 26.0% syntax-e [2] 6.5% step [20] 3.2% ---------------------------------------------------------------------------- for-loop [13] 100.0% [16] 4032(64.0%) 0(0.0%) run-iter! ...aph-rebuilding/src/mainloop.rkt:327:0 simplify! [21] 84.9% finalize-iter! [22] 10.0% gen-series! [24] 5.2% ---------------------------------------------------------------------------- loop [14] 100.0% [17] 1406(22.3%) 606(9.6%) loop ...ify-regraph-rebuilding/src/points.rkt:79:2 ...higher-order.rkt:375:33 [23] 28.4% real->precision [29] 14.2% ??? [28] 14.2% ---------------------------------------------------------------------------- loop [15] 100.0% [18] 404(6.4%) 0(0.0%) gf (unknown source) propagation-apply [25] 50.0% cache-or-reuse-hash [27] 50.0% ---------------------------------------------------------------------------- loop [14] 100.0% [19] 402(6.4%) 200(3.2%) ??? ...ify-regraph-rebuilding/src/points.rkt:113:6 sample-multi-bounded [26] 50.2% ---------------------------------------------------------------------------- loop [15] 100.0% [20] 200(3.2%) 200(3.2%) step ...ket-7.5/collects/racket/function.rkt:145:9 ---------------------------------------------------------------------------- run-iter! [16] 100.0% [21] 3422(54.3%) 0(0.0%) simplify! ...aph-rebuilding/src/mainloop.rkt:224:0 ??? [30] 100.0% ---------------------------------------------------------------------------- run-iter! [16] 100.0% [22] 402(6.4%) 0(0.0%) finalize-iter! ...ebuilding/src/mainloop.rkt:278:0 ??? [31] 100.0% ---------------------------------------------------------------------------- loop [17] 100.0% [23] 400(6.3%) 0(0.0%) ...higher-order.rkt:375:33 (unknown source) loop [32] 100.0% ---------------------------------------------------------------------------- run-iter! [16] 100.0% [24] 208(3.3%) 0(0.0%) gen-series! ...h-rebuilding/src/mainloop.rkt:160:0 for-loop [33] 100.0% ---------------------------------------------------------------------------- gf [18] 100.0% [25] 202(3.2%) 202(3.2%) propagation-apply (unknown source) ---------------------------------------------------------------------------- ??? [19] 100.0% [26] 202(3.2%) 0(0.0%) sample-multi-bounded ...ilding/src/points.rkt:14:0 for-loop [34] 100.0% ---------------------------------------------------------------------------- gf [18] 100.0% [27] 202(3.2%) 0(0.0%) cache-or-reuse-hash (unknown source) for-loop [86] 100.0% ---------------------------------------------------------------------------- loop [17] 100.0% [28] 200(3.2%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-sub [35] 100.0% ---------------------------------------------------------------------------- loop [17] 100.0% [29] 200(3.2%) 0(0.0%) real->precision ...building/src/programs.rkt:94:11 ??? [46] 100.0% ---------------------------------------------------------------------------- simplify! [21] 100.0% [30] 3422(54.3%) 0(0.0%) ??? ...graph-rebuilding/src/core/simplify.rkt:38:0 ??? [36] 100.0% ---------------------------------------------------------------------------- finalize-iter! [22] 100.0% [31] 402(6.4%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [37] 100.0% ---------------------------------------------------------------------------- ...higher-order.rkt:375:33 [23] 100.0% [32] 400(6.3%) 400(6.3%) loop ...graph-rebuilding/src/biginterval.rkt:467:9 ---------------------------------------------------------------------------- gen-series! [24] 100.0% [33] 208(3.3%) 0(0.0%) for-loop ...raph-rebuilding/src/mainloop.rkt:167:7 taylor-alt [38] 100.0% ---------------------------------------------------------------------------- sample-multi-bounded [26] 100.0% [34] 202(3.2%) 202(3.2%) for-loop ...regraph-rebuilding/src/points.rkt:20:4 ---------------------------------------------------------------------------- ??? [28] 100.0% [35] 200(3.2%) 0(0.0%) ival-sub ...h-rebuilding/src/biginterval.rkt:108:0 bfsub [39] 100.0% ---------------------------------------------------------------------------- ??? [30] 100.0% [36] 3422(54.3%) 0(0.0%) ??? ...graph-rebuilding/src/core/simplify.rkt:56:0 for-loop [40] 100.0% ---------------------------------------------------------------------------- ??? [31] 100.0% [37] 402(6.4%) 0(0.0%) for-loop ...rebuilding/src/core/alt-table.rkt:46:2 errors [41] 50.2% atab-add-altn [44] 49.8% ---------------------------------------------------------------------------- for-loop [33] 100.0% [38] 208(3.3%) 0(0.0%) taylor-alt ...ph-rebuilding/src/mainloop.rkt:146:0 for-loop [42] 100.0% ---------------------------------------------------------------------------- ival-sub [35] 100.0% [39] 200(3.2%) 0(0.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [43] 100.0% ---------------------------------------------------------------------------- ??? [36] 100.0% [40] 3422(54.3%) 0(0.0%) for-loop ...-rebuilding/src/core/simplify.rkt:76:2 for-loop [45] 100.0% ---------------------------------------------------------------------------- for-loop [37] 45.7% .../more-scheme.rkt:261:28 [9] 54.3% [41] 442(7.0%) 0(0.0%) errors ...-regraph-rebuilding/src/points.rkt:190:0 for-loop [47] 54.3% temp85_0 [48] 45.7% ---------------------------------------------------------------------------- taylor-alt [38] 100.0% [42] 208(3.3%) 0(0.0%) for-loop ...raph-rebuilding/src/mainloop.rkt:152:6 ??? [46] 100.0% ---------------------------------------------------------------------------- bfsub [39] 100.0% [43] 200(3.2%) 200(3.2%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ---------------------------------------------------------------------------- for-loop [37] 100.0% [44] 200(3.2%) 0(0.0%) atab-add-altn ...ding/src/core/alt-table.rkt:194:0 for-loop [49] 100.0% ---------------------------------------------------------------------------- for-loop [40] 100.0% [45] 3422(54.3%) 0(0.0%) for-loop ...-rebuilding/src/core/simplify.rkt:80:4 ??? [50] 82.2% egraph-rebuild [51] 11.9% ??? [54] 5.9% ---------------------------------------------------------------------------- location-do [52] 25.5% for-loop [42] 25.5% real->precision [29] 49.0% [46] 408(6.5%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 bf [56] 49.0% location-do [52] 25.5% approximate9 [53] 25.5% ---------------------------------------------------------------------------- errors [41] 100.0% [47] 240(3.8%) 0(0.0%) for-loop ...egraph-rebuilding/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [9] 100.0% ---------------------------------------------------------------------------- errors [41] 100.0% [48] 202(3.2%) 0(0.0%) temp85_0 (unknown source) compile15 [55] 100.0% ---------------------------------------------------------------------------- atab-add-altn [44] 100.0% [49] 200(3.2%) 200(3.2%) for-loop ...ebuilding/src/core/alt-table.rkt:110:2 ---------------------------------------------------------------------------- for-loop [45] 100.0% [50] 2814(44.6%) 0(0.0%) ??? ...fy-regraph-rebuilding/regraph/main.rkt:45:0 find-matches [57] 64.2% for-loop [58] 35.8% ---------------------------------------------------------------------------- for-loop [45] 100.0% [51] 406(6.4%) 0(0.0%) egraph-rebuild ...building/regraph/egraph.rkt:61:0 egraph-rebuild-once [59] 100.0% ---------------------------------------------------------------------------- ??? [46] 100.0% [52] 208(3.3%) 0(0.0%) location-do ...ph-rebuilding/src/programs.rkt:63:0 ??? [46] 100.0% ---------------------------------------------------------------------------- ??? [46] 100.0% [53] 208(3.3%) 0(0.0%) approximate9 ...ebuilding/src/core/taylor.rkt:11:0 for-loop [60] 100.0% ---------------------------------------------------------------------------- for-loop [45] 100.0% [54] 202(3.2%) 0(0.0%) ??? ...fy-regraph-rebuilding/regraph/main.rkt:57:0 for-loop [61] 100.0% ---------------------------------------------------------------------------- temp85_0 [48] 100.0% [55] 202(3.2%) 0(0.0%) compile15 (unknown source) temp91_0 [62] 100.0% ---------------------------------------------------------------------------- ??? [46] 100.0% [56] 200(3.2%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [63] 100.0% ---------------------------------------------------------------------------- ??? [50] 100.0% [57] 1806(28.6%) 0(0.0%) find-matches ...h-rebuilding/regraph/main.rkt:37:0 for-loop [64] 100.0% ---------------------------------------------------------------------------- ??? [50] 100.0% [58] 1008(16.0%) 0(0.0%) for-loop ...graph-rebuilding/regraph/main.rkt:48:2 for-loop [65] 100.0% ---------------------------------------------------------------------------- egraph-rebuild [51] 100.0% [59] 406(6.4%) 0(0.0%) egraph-rebuild-once ...ing/regraph/egraph.rkt:68:0 for-loop [66] 100.0% ---------------------------------------------------------------------------- approximate9 [53] 100.0% [60] 208(3.3%) 0(0.0%) for-loop ...h-rebuilding/src/core/taylor.rkt:29:18 taylor [67] 100.0% ---------------------------------------------------------------------------- ??? [54] 100.0% [61] 202(3.2%) 0(0.0%) for-loop ...graph-rebuilding/regraph/main.rkt:60:2 set-precompute! [68] 100.0% ---------------------------------------------------------------------------- compile15 [55] 100.0% [62] 202(3.2%) 0(0.0%) temp91_0 (unknown source) temp118_0 [69] 100.0% ---------------------------------------------------------------------------- bf [56] 100.0% [63] 200(3.2%) 200(3.2%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ---------------------------------------------------------------------------- for-loop [64] 50.0% find-matches [57] 50.0% [64] 1806(28.6%) 0(0.0%) for-loop ...graph-rebuilding/regraph/main.rkt:39:2 for-loop [64] 50.0% match-e [70] 50.0% ---------------------------------------------------------------------------- for-loop [58] 100.0% [65] 1008(16.0%) 0(0.0%) for-loop ...graph-rebuilding/regraph/main.rkt:51:4 add-enode-rec! [72] 59.5% substitute-e [73] 40.5% ---------------------------------------------------------------------------- egraph-rebuild-once [59] 100.0% [66] 406(6.4%) 0(0.0%) for-loop ...aph-rebuilding/regraph/egraph.rkt:72:2 for-loop [74] 100.0% ---------------------------------------------------------------------------- taylor [67] 50.0% for-loop [60] 50.0% [67] 208(3.3%) 0(0.0%) taylor ...aph-rebuilding/src/core/taylor.rkt:169:0 taylor [67] 50.0% taylor-invert [3] 50.0% ---------------------------------------------------------------------------- for-loop [61] 100.0% [68] 202(3.2%) 0(0.0%) set-precompute! ...ebuilding/regraph/main.rkt:64:0 .../more-scheme.rkt:261:28 [9] 100.0% ---------------------------------------------------------------------------- temp91_0 [62] 100.0% [69] 202(3.2%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [71] 100.0% ---------------------------------------------------------------------------- for-loop [79] 27.6% for-loop [64] 72.4% [70] 1806(28.6%) 0(0.0%) match-e ...raph-rebuilding/regraph/ematch.rkt:35:0 for-loop [75] 100.0% ---------------------------------------------------------------------------- temp118_0 [69] 33.0% loop [15] 67.0% [71] 612(9.7%) 208(3.3%) expand-capturing-lifts (unknown source) lambda-clause-expander [78] 33.0% dispatch-transformer41 [77] 33.0% ---------------------------------------------------------------------------- for-loop [65] 100.0% [72] 600(9.5%) 0(0.0%) add-enode-rec! ...uilding/regraph/egraph.rkt:161:0 map [76] 66.7% do-curry [80] 33.3% ---------------------------------------------------------------------------- substitute-e [73] 24.5% for-loop [65] 75.5% [73] 408(6.5%) 408(6.5%) substitute-e ...rebuilding/regraph/ematch.rkt:55:0 substitute-e [73] 24.5% ---------------------------------------------------------------------------- for-loop [66] 100.0% [74] 406(6.4%) 406(6.4%) for-loop ...aph-rebuilding/regraph/egraph.rkt:73:4 ---------------------------------------------------------------------------- match-e [70] 100.0% [75] 1806(28.6%) 602(9.5%) for-loop ...ph-rebuilding/regraph/ematch.rkt:41:11 for-loop [79] 27.6% do-curry [80] 16.8% procedure-reduce-keyword-arity-mask [81] 16.7% loop [15] 11.1% ??? [85] 5.5% ---------------------------------------------------------------------------- add-enode-rec! [72] 100.0% [76] 400(6.3%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 mk-enode-rec! [82] 100.0% ---------------------------------------------------------------------------- expand-capturing-lifts [71] 100.0% [77] 202(3.2%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [83] 100.0% ---------------------------------------------------------------------------- expand-capturing-lifts [71] 100.0% [78] 202(3.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [84] 100.0% ---------------------------------------------------------------------------- for-loop [75] 100.0% [79] 998(15.8%) 0(0.0%) for-loop ...ph-rebuilding/regraph/ematch.rkt:47:37 match-e [70] 100.0% ---------------------------------------------------------------------------- add-enode-rec! [72] 33.1% for-loop [75] 66.9% [80] 604(9.6%) 604(9.6%) do-curry ...-7.5/collects/racket/function.rkt:71:2 ---------------------------------------------------------------------------- for-loop [75] 100.0% [81] 402(6.4%) 402(6.4%) procedure-reduce-keyword-arity-mask ....rkt:1597:4 ---------------------------------------------------------------------------- map [76] 100.0% [82] 400(6.3%) 200(3.2%) mk-enode-rec! ...building/regraph/egraph.rkt:152:0 hash-has-key? [87] 50.0% ---------------------------------------------------------------------------- dispatch-transformer41 [77] 100.0% [83] 202(3.2%) 0(0.0%) apply-transformer52 (unknown source) loop [15] 100.0% ---------------------------------------------------------------------------- lambda-clause-expander [78] 12.5% for-loop [86] 87.5% [84] 202(3.2%) 0(0.0%) finish-bodys (unknown source) for-loop [86] 100.0% ---------------------------------------------------------------------------- for-loop [75] 100.0% [85] 198(3.1%) 198(3.1%) ??? ...ket-7.5/collects/racket/function.rkt:138:13 ---------------------------------------------------------------------------- for-loop [86] 5.6% finish-bodys [84] 44.4% cache-or-reuse-hash [27] 50.0% [86] 404(6.4%) 202(3.2%) for-loop (unknown source) finish-bodys [84] 38.9% for-loop [86] 5.6% syntax-e [2] 5.6% ---------------------------------------------------------------------------- mk-enode-rec! [82] 100.0% [87] 200(3.2%) 200(3.2%) hash-has-key? ...ket/private/more-scheme.rkt:371:2 ----------------------------------------------------------------------------