Profiling results ----------------- Total cpu time observed: 7196ms (out of 7408ms) Number of samples taken: 35 (once every 206ms) ============================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================================== [1] 7196(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [2] 100.0% ------------------------------------------------------------------------------ ??? [1] 100.0% [2] 7196(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ------------------------------------------------------------------------------ profile-thunk16 [2] 100.0% [3] 7196(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [4] 100.0% ------------------------------------------------------------------------------ set-precompute! [45] 1.5% for-loop [13] 2.8% run [3] 95.7% [4] 7196(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [5] 56.6% prepare-points-intervals [6] 33.5% errors [7] 5.6% temp85_0 [8] 1.5% ulp-difference [9] 1.4% ordinary-value? [10] 1.4% ------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [4] 100.0% [5] 4184(58.1%) 0(0.0%) run-improve47 ...building-2/src/mainloop.rkt:346:0 simplify! [11] 100.0% ------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [4] 100.0% [6] 2408(33.5%) 0(0.0%) prepare-points-intervals ...2/src/points.rkt:120:0 loop [12] 100.0% ------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [4] 100.0% [7] 604(8.4%) 0(0.0%) errors ...egraph-rebuilding-2/src/points.rkt:190:0 for-loop [13] 100.0% ------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [4] 100.0% [8] 218(3.0%) 0(0.0%) temp85_0 (unknown source) compile15 [14] 100.0% ------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [4] 100.0% [9] 204(2.8%) 204(2.8%) ulp-difference ...-rebuilding-2/src/float.rkt:19:0 ------------------------------------------------------------------------------ .../more-scheme.rkt:261:28 [4] 100.0% [10] 198(2.8%) 0(0.0%) ordinary-value? ...rebuilding-2/src/float.rkt:51:0 list-member? [15] 100.0% ------------------------------------------------------------------------------ run-improve47 [5] 100.0% [11] 4184(58.1%) 0(0.0%) simplify! ...h-rebuilding-2/src/mainloop.rkt:224:0 ??? [16] 100.0% ------------------------------------------------------------------------------ prepare-points-intervals [6] 100.0% [12] 2408(33.5%) 202(2.8%) loop ...-regraph-rebuilding-2/src/points.rkt:132:4 loop [17] 75.1% ??? [18] 16.5% ------------------------------------------------------------------------------ errors [7] 100.0% [13] 604(8.4%) 202(2.8%) for-loop ...raph-rebuilding-2/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [4] 66.6% ------------------------------------------------------------------------------ temp85_0 [8] 100.0% [14] 218(3.0%) 0(0.0%) compile15 (unknown source) temp91_0 [19] 100.0% ------------------------------------------------------------------------------ ordinary-value? [10] 100.0% [15] 198(2.8%) 198(2.8%) list-member? ...llects/racket/private/set.rkt:24:0 ------------------------------------------------------------------------------ simplify! [11] 100.0% [16] 4184(58.1%) 0(0.0%) ??? ...aph-rebuilding-2/src/core/simplify.rkt:38:0 ??? [20] 100.0% ------------------------------------------------------------------------------ loop [12] 100.0% [17] 1808(25.1%) 200(2.8%) loop ...y-regraph-rebuilding-2/src/points.rkt:79:2 ??? [24] 77.9% real->precision [22] 11.1% ------------------------------------------------------------------------------ loop [12] 100.0% [18] 398(5.5%) 398(5.5%) ??? ...y-regraph-rebuilding-2/src/points.rkt:113:6 ------------------------------------------------------------------------------ compile15 [14] 100.0% [19] 218(3.0%) 0(0.0%) temp91_0 (unknown source) temp118_0 [21] 100.0% ------------------------------------------------------------------------------ ??? [16] 100.0% [20] 4184(58.1%) 0(0.0%) ??? ...aph-rebuilding-2/src/core/simplify.rkt:56:0 for-loop [23] 100.0% ------------------------------------------------------------------------------ temp91_0 [19] 100.0% [21] 218(3.0%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [25] 100.0% ------------------------------------------------------------------------------ loop [17] 100.0% [22] 200(2.8%) 0(0.0%) real->precision ...ilding-2/src/programs.rkt:94:11 ??? [24] 100.0% ------------------------------------------------------------------------------ ??? [20] 100.0% [23] 4184(58.1%) 0(0.0%) for-loop ...ebuilding-2/src/core/simplify.rkt:76:2 for-loop [26] 100.0% ------------------------------------------------------------------------------ real->precision [22] 12.4% loop [17] 87.6% [24] 1608(22.3%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-mult [27] 87.6% bf [29] 12.4% ------------------------------------------------------------------------------ temp118_0 [21] 100.0% [25] 218(3.0%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [28] 100.0% ------------------------------------------------------------------------------ for-loop [23] 100.0% [26] 4184(58.1%) 0(0.0%) for-loop ...ebuilding-2/src/core/simplify.rkt:80:4 ??? [30] 89.9% ??? [32] 5.2% egraph-rebuild [34] 4.9% ------------------------------------------------------------------------------ ??? [24] 100.0% [27] 1408(19.6%) 408(5.7%) ival-mult ...ebuilding-2/src/biginterval.rkt:120:0 bfmul [31] 71.0% ------------------------------------------------------------------------------ expand-capturing-lifts [25] 100.0% [28] 218(3.0%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [33] 100.0% ------------------------------------------------------------------------------ ??? [24] 100.0% [29] 200(2.8%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 ??? [37] 100.0% ------------------------------------------------------------------------------ for-loop [26] 100.0% [30] 3760(52.3%) 0(0.0%) ??? ...-regraph-rebuilding-2/regraph/main.rkt:45:0 find-matches [35] 73.5% for-loop [36] 26.5% ------------------------------------------------------------------------------ ival-mult [27] 100.0% [31] 1000(13.9%) 200(2.8%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [38] 40.0% ??? [37] 40.0% ------------------------------------------------------------------------------ for-loop [26] 100.0% [32] 218(3.0%) 0(0.0%) ??? ...-regraph-rebuilding-2/regraph/main.rkt:57:0 for-loop [39] 100.0% ------------------------------------------------------------------------------ lambda-clause-expander [28] 25.0% for-loop [40] 75.0% [33] 218(3.0%) 0(0.0%) finish-bodys (unknown source) for-loop [40] 100.0% ------------------------------------------------------------------------------ for-loop [26] 100.0% [34] 206(2.9%) 0(0.0%) egraph-rebuild ...ilding-2/regraph/egraph.rkt:61:0 egraph-rebuild-once [41] 100.0% ------------------------------------------------------------------------------ ??? [30] 100.0% [35] 2764(38.4%) 0(0.0%) find-matches ...rebuilding-2/regraph/main.rkt:37:0 for-loop [42] 100.0% ------------------------------------------------------------------------------ ??? [30] 100.0% [36] 996(13.8%) 0(0.0%) for-loop ...aph-rebuilding-2/regraph/main.rkt:48:2 for-loop [43] 100.0% ------------------------------------------------------------------------------ bf [29] 33.3% bfmul [31] 66.7% [37] 600(8.3%) 600(8.3%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ------------------------------------------------------------------------------ bfmul [31] 100.0% [38] 400(5.6%) 400(5.6%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ------------------------------------------------------------------------------ ??? [32] 100.0% [39] 218(3.0%) 0(0.0%) for-loop ...aph-rebuilding-2/regraph/main.rkt:60:2 set-precompute! [45] 100.0% ------------------------------------------------------------------------------ for-loop [40] 42.9% finish-bodys [33] 57.1% [40] 218(3.0%) 0(0.0%) for-loop (unknown source) finish-bodys [33] 42.9% for-loop [40] 42.9% dispatch-variable [44] 14.3% ------------------------------------------------------------------------------ egraph-rebuild [34] 100.0% [41] 206(2.9%) 0(0.0%) egraph-rebuild-once ...g-2/regraph/egraph.rkt:68:0 for-loop [46] 100.0% ------------------------------------------------------------------------------ for-loop [42] 50.0% find-matches [35] 50.0% [42] 2764(38.4%) 0(0.0%) for-loop ...aph-rebuilding-2/regraph/main.rkt:39:2 for-loop [42] 50.0% match-e [47] 50.0% ------------------------------------------------------------------------------ for-loop [36] 100.0% [43] 996(13.8%) 0(0.0%) for-loop ...aph-rebuilding-2/regraph/main.rkt:51:4 add-enode-rec! [48] 59.8% substitute-e [49] 40.2% ------------------------------------------------------------------------------ for-loop [40] 100.0% [44] 218(3.0%) 0(0.0%) dispatch-variable (unknown source) substitute-variable6 [50] 100.0% ------------------------------------------------------------------------------ for-loop [39] 100.0% [45] 218(3.0%) 0(0.0%) set-precompute! ...uilding-2/regraph/main.rkt:64:0 .../more-scheme.rkt:261:28 [4] 100.0% ------------------------------------------------------------------------------ egraph-rebuild-once [41] 100.0% [46] 206(2.9%) 206(2.9%) for-loop ...h-rebuilding-2/regraph/egraph.rkt:72:2 ------------------------------------------------------------------------------ for-loop [55] 34.4% for-loop [42] 65.6% [47] 2764(38.4%) 0(0.0%) match-e ...ph-rebuilding-2/regraph/ematch.rkt:35:0 for-loop [51] 100.0% ------------------------------------------------------------------------------ for-loop [43] 100.0% [48] 596(8.3%) 0(0.0%) add-enode-rec! ...lding-2/regraph/egraph.rkt:161:0 map [52] 67.1% mk-enode! [54] 32.9% ------------------------------------------------------------------------------ for-loop [43] 100.0% [49] 400(5.6%) 200(2.8%) substitute-e ...building-2/regraph/ematch.rkt:55:0 assoc-ref [53] 50.0% ------------------------------------------------------------------------------ dispatch-variable [44] 100.0% [50] 218(3.0%) 218(3.0%) substitute-variable6 (unknown source) ------------------------------------------------------------------------------ match-e [47] 100.0% [51] 2764(38.4%) 1248(17.3%) for-loop ...-rebuilding-2/regraph/ematch.rkt:41:11 for-loop [55] 34.4% loop [57] 15.9% procedure-reduce-keyword-arity-mask [56] 11.8% foldr [59] 4.1% foldl [60] 3.6% ------------------------------------------------------------------------------ add-enode-rec! [48] 100.0% [52] 400(5.6%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 mk-enode-rec! [58] 100.0% ------------------------------------------------------------------------------ substitute-e [49] 100.0% [53] 200(2.8%) 200(2.8%) assoc-ref ...collects/racket/private/dict.rkt:56:0 ------------------------------------------------------------------------------ add-enode-rec! [48] 100.0% [54] 196(2.7%) 196(2.7%) mk-enode! ...rebuilding-2/regraph/egraph.rkt:132:0 ------------------------------------------------------------------------------ for-loop [51] 100.0% [55] 1900(26.4%) 0(0.0%) for-loop ...-rebuilding-2/regraph/ematch.rkt:47:37 match-e [47] 100.0% ------------------------------------------------------------------------------ for-loop [51] 100.0% [56] 652(9.1%) 652(9.1%) procedure-reduce-keyword-arity-mask ....rkt:1597:4 ------------------------------------------------------------------------------ for-loop [51] 2.0% loop [57] 98.0% [57] 440(6.1%) 218(3.0%) loop (unknown source) loop [57] 98.0% step [62] 1.9% ------------------------------------------------------------------------------ map [52] 100.0% [58] 400(5.6%) 0(0.0%) mk-enode-rec! ...ilding-2/regraph/egraph.rkt:152:0 hash-has-key? [61] 100.0% ------------------------------------------------------------------------------ for-loop [51] 100.0% [59] 226(3.1%) 226(3.1%) foldr ....5/collects/racket/private/list.rkt:242:4 ------------------------------------------------------------------------------ for-loop [51] 100.0% [60] 198(2.8%) 0(0.0%) foldl ....5/collects/racket/private/list.rkt:229:4 merge2 [63] 100.0% ------------------------------------------------------------------------------ mk-enode-rec! [58] 100.0% [61] 400(5.6%) 400(5.6%) hash-has-key? ...ket/private/more-scheme.rkt:371:2 ------------------------------------------------------------------------------ loop [57] 100.0% [62] 222(3.1%) 222(3.1%) step ...ket-7.5/collects/racket/function.rkt:145:9 ------------------------------------------------------------------------------ foldl [60] 100.0% [63] 198(2.8%) 198(2.8%) merge2 ...aph-rebuilding-2/regraph/ematch.rkt:20:0 ------------------------------------------------------------------------------