Profiling results ----------------- Total cpu time observed: 4902ms (out of 5732ms) Number of samples taken: 30 (once every 163ms) =========================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee =========================================================================== ??? [10] 100.0% [1] 4752(96.9%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% --------------------------------------------------------------------------- ??? [33] 100.0% [2] 1972(40.2%) 0(0.0%) iterate-egraph!13 ...s/src/core/simplify.rkt:102:0 one-iter [6] 100.0% --------------------------------------------------------------------------- f137 [49] 12.2% ??? [50] 12.2% loop [39] 75.6% [3] 656(13.4%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ??? [33] 75.6% best-alt [8] 12.2% ??? [9] 12.2% --------------------------------------------------------------------------- match-e [23] 100.0% [4] 300(6.1%) 0(0.0%) for-loop ...y-conditions/src/core/ematch.rkt:59:11 for-loop [7] 100.0% --------------------------------------------------------------------------- profile-thunk16 [1] 100.0% [5] 4752(96.9%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [10] 100.0% --------------------------------------------------------------------------- iterate-egraph!13 [2] 100.0% [6] 1972(40.2%) 0(0.0%) one-iter ...conditions/src/core/simplify.rkt:113:0 loop [11] 92.4% for-loop [14] 7.6% --------------------------------------------------------------------------- match-e [23] 25.0% for-loop [4] 75.0% [7] 300(6.1%) 0(0.0%) for-loop ...y-conditions/src/core/ematch.rkt:65:37 match-e [23] 100.0% --------------------------------------------------------------------------- ??? [3] 100.0% [8] 160(3.3%) 0(0.0%) best-alt .../simplify-conditions/src/glue.rkt:71:0 argmins [13] 100.0% --------------------------------------------------------------------------- ??? [3] 100.0% [9] 160(3.3%) 0(0.0%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 get/build-late-neg-projection [12] 100.0% --------------------------------------------------------------------------- run [5] 50.0% [10] 4752(96.9%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% loop [20] 25.5% run-improve50 [15] 24.5% --------------------------------------------------------------------------- one-iter [6] 100.0% [11] 1822(37.2%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [16] 100.0% --------------------------------------------------------------------------- unconstrained-domain->-projection [18] 50.0% ??? [9] 50.0% [12] 160(3.3%) 0(0.0%) get/build-late-neg-projection ...te/guts.rkt:691:0 unconstrained-domain->-projection [18] 50.0% ??? [17] 50.0% --------------------------------------------------------------------------- best-alt [8] 100.0% [13] 160(3.3%) 0(0.0%) argmins ...implify-conditions/src/common.rkt:150:0 composed [19] 100.0% --------------------------------------------------------------------------- for-loop [14] 50.0% one-iter [6] 50.0% [14] 150(3.1%) 0(0.0%) for-loop ...onditions/src/core/simplify.rkt:123:12 for-loop [14] 50.0% match-e [23] 50.0% --------------------------------------------------------------------------- ??? [10] 100.0% [15] 2332(47.6%) 0(0.0%) run-improve50 ...conditions/src/mainloop.rkt:234:0 setup-alt-simplified [21] 85.2% loop [20] 7.9% for-loop [26] 6.9% --------------------------------------------------------------------------- loop [11] 100.0% [16] 1822(37.2%) 0(0.0%) apply-match ...ditions/src/core/simplify.rkt:130:2 for-loop [22] 83.5% match-e [23] 8.2% update-leader! [34] 8.2% --------------------------------------------------------------------------- get/build-late-neg-projection [12] 100.0% [17] 160(3.3%) 0(0.0%) ??? ...cts/racket/contract/private/prop.rkt:314:12 build-compound-type-name [24] 100.0% --------------------------------------------------------------------------- get/build-late-neg-projection [12] 100.0% [18] 160(3.3%) 0(0.0%) unconstrained-domain->-projection ...rrow.rkt:60:0 get/build-late-neg-projection [12] 100.0% --------------------------------------------------------------------------- argmins [13] 100.0% [19] 160(3.3%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 errors [25] 100.0% --------------------------------------------------------------------------- run-improve50 [15] 7.1% ??? [10] 92.9% [20] 2604(53.1%) 0(0.0%) loop ...e/simplify-conditions/src/points.rkt:205:2 loop [29] 40.0% loop [36] 33.4% make-exacts* [35] 26.6% --------------------------------------------------------------------------- run-improve50 [15] 100.0% [21] 1988(40.6%) 0(0.0%) setup-alt-simplified ...nditions/src/glue.rkt:49:0 simplify-alt [27] 100.0% --------------------------------------------------------------------------- apply-match [16] 100.0% [22] 1522(31.0%) 0(0.0%) for-loop ...onditions/src/core/simplify.rkt:145:10 merge-egraph-nodes! [28] 89.8% list-member? [31] 10.2% --------------------------------------------------------------------------- apply-match [16] 16.7% for-loop [14] 25.0% for-loop [7] 58.3% [23] 300(6.1%) 0(0.0%) match-e ...ify-conditions/src/core/ematch.rkt:46:0 for-loop [4] 41.7% variable? [32] 25.0% for-loop [7] 16.7% ??? [42] 16.7% --------------------------------------------------------------------------- ??? [17] 100.0% [24] 160(3.3%) 160(3.3%) build-compound-type-name ...private/guts.rkt:448:0 --------------------------------------------------------------------------- composed [19] 100.0% [25] 160(3.3%) 0(0.0%) errors ...simplify-conditions/src/points.rkt:241:0 eval-prog [41] 100.0% --------------------------------------------------------------------------- run-improve50 [15] 100.0% [26] 160(3.3%) 0(0.0%) for-loop ...ify-conditions/src/mainloop.rkt:249:10 run-iter! [30] 100.0% --------------------------------------------------------------------------- setup-alt-simplified [21] 100.0% [27] 1988(40.6%) 0(0.0%) simplify-alt ...plify-conditions/src/glue.rkt:76:0 ??? [33] 100.0% --------------------------------------------------------------------------- for-loop [22] 100.0% [28] 1366(27.9%) 0(0.0%) merge-egraph-nodes! ...s/src/core/egraph.rkt:152:0 update-leader! [34] 100.0% --------------------------------------------------------------------------- loop [20] 100.0% [29] 1042(21.3%) 0(0.0%) loop ...e/simplify-conditions/src/points.rkt:158:2 make-exacts* [35] 65.6% loop [36] 34.4% --------------------------------------------------------------------------- for-loop [26] 100.0% [30] 160(3.3%) 0(0.0%) run-iter! ...ify-conditions/src/mainloop.rkt:215:0 choose-best-alt! [37] 100.0% --------------------------------------------------------------------------- for-loop [22] 100.0% [31] 156(3.2%) 0(0.0%) list-member? ...llects/racket/private/set.rkt:24:0 loop [38] 100.0% --------------------------------------------------------------------------- match-e [23] 100.0% [32] 150(3.1%) 0(0.0%) variable? ...onditions/src/syntax/syntax.rkt:663:0 ??? [42] 100.0% --------------------------------------------------------------------------- ??? [3] 18.8% simplify-alt [27] 37.7% ??? [33] 40.6% [33] 2634(53.7%) 338(6.9%) ??? ...llects/racket/private/norm-define.rkt:53:83 ??? [33] 40.6% iterate-egraph!13 [2] 37.4% ??? [44] 6.0% mk-egraph [43] 3.2% --------------------------------------------------------------------------- apply-match [16] 9.9% merge-egraph-nodes! [28] 90.1% [34] 1516(30.9%) 0(0.0%) update-leader! ...itions/src/core/egraph.rkt:217:0 for-loop [40] 100.0% --------------------------------------------------------------------------- loop [29] 49.7% loop [20] 50.3% [35] 1376(28.1%) 0(0.0%) make-exacts* ...fy-conditions/src/points.rkt:138:0 loop [39] 75.9% eval-prog [41] 24.1% --------------------------------------------------------------------------- loop [29] 29.2% loop [20] 70.8% [36] 1228(25.1%) 0(0.0%) loop ...e/simplify-conditions/src/points.rkt:141:4 loop [39] 100.0% --------------------------------------------------------------------------- run-iter! [30] 100.0% [37] 160(3.3%) 0(0.0%) choose-best-alt! ...ditions/src/mainloop.rkt:115:0 ??? [42] 100.0% --------------------------------------------------------------------------- list-member? [31] 100.0% [38] 156(3.2%) 156(3.2%) loop (unknown source) --------------------------------------------------------------------------- make-exacts* [35] 0.1% loop [36] 0.3% loop [39] 99.6% [39] 2272(46.3%) 152(3.1%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [39] 99.6% ??? [45] 0.3% ??? [3] 0.1% --------------------------------------------------------------------------- update-leader! [34] 100.0% [40] 1516(30.9%) 0(0.0%) for-loop ...y-conditions/src/core/egraph.rkt:222:6 for-loop [46] 100.0% --------------------------------------------------------------------------- errors [25] 32.5% make-exacts* [35] 67.5% [41] 492(10.0%) 148(3.0%) eval-prog ...ify-conditions/src/programs.rkt:148:0 [running expand-time body] [47] 37.4% f137 [49] 32.5% --------------------------------------------------------------------------- variable? [32] 32.6% match-e [23] 32.6% choose-best-alt! [37] 34.8% [42] 460(9.4%) 150(3.1%) ??? ...contract/private/arrow-val-first.rkt:357:18 ??? [50] 34.8% hash-has-key? [52] 32.6% --------------------------------------------------------------------------- ??? [33] 100.0% [43] 166(3.4%) 0(0.0%) mk-egraph ...-conditions/src/core/egraph.rkt:123:0 expr->enode [48] 100.0% --------------------------------------------------------------------------- ??? [33] 100.0% [44] 158(3.2%) 0(0.0%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [51] 100.0% --------------------------------------------------------------------------- loop [39] 100.0% [45] 1624(33.1%) 194(4.0%) ??? .../simplify-conditions/src/programs.rkt:154:4 ??? [54] 52.8% ??? [55] 35.2% --------------------------------------------------------------------------- for-loop [40] 100.0% [46] 1516(30.9%) 0(0.0%) for-loop ...y-conditions/src/core/egraph.rkt:223:8 hash-update! [53] 100.0% --------------------------------------------------------------------------- eval-prog [41] 100.0% [47] 184(3.8%) 184(3.8%) [running expand-time body] ...se-constants.rkt:##f --------------------------------------------------------------------------- mk-egraph [43] 33.3% expr->enode [48] 66.7% [48] 166(3.4%) 0(0.0%) expr->enode ...onditions/src/core/egraph.rkt:124:2 expr->enode [48] 66.7% mk-enode! [56] 33.3% --------------------------------------------------------------------------- eval-prog [41] 100.0% [49] 160(3.3%) 0(0.0%) f137 .../collects/racket/match/compiler.rkt:507:40 ??? [3] 100.0% --------------------------------------------------------------------------- ??? [42] 100.0% [50] 160(3.3%) 0(0.0%) ??? ...lify-conditions/src/core/alt-table.rkt:54:0 ??? [3] 100.0% --------------------------------------------------------------------------- ??? [44] 100.0% [51] 158(3.2%) 158(3.2%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 --------------------------------------------------------------------------- ??? [42] 100.0% [52] 150(3.1%) 0(0.0%) hash-has-key? ...et/private/more-scheme.rkt:368:13 ??? [57] 100.0% --------------------------------------------------------------------------- for-loop [46] 100.0% [53] 1516(30.9%) 0(0.0%) hash-update! ...ket/private/more-scheme.rkt:362:13 ??? [58] 100.0% --------------------------------------------------------------------------- ??? [45] 100.0% [54] 858(17.5%) 182(3.7%) ??? ...acket/collects/racket/private/kw.rkt:444:14 bf* [60] 41.5% ??? [62] 37.3% --------------------------------------------------------------------------- ??? [45] 100.0% [55] 572(11.7%) 186(3.8%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [59] 67.5% --------------------------------------------------------------------------- expr->enode [48] 100.0% [56] 166(3.4%) 166(3.4%) mk-enode! ...-conditions/src/core/egraph.rkt:101:0 --------------------------------------------------------------------------- hash-has-key? [52] 100.0% [57] 150(3.1%) 150(3.1%) ??? ...ects/racket/contract/private/hash.rkt:245:7 --------------------------------------------------------------------------- hash-update! [53] 100.0% [58] 1516(30.9%) 0(0.0%) ??? ...plify-conditions/src/core/egraph.rkt:225:24 for-loop [61] 100.0% --------------------------------------------------------------------------- ??? [55] 100.0% [59] 386(7.9%) 386(7.9%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 --------------------------------------------------------------------------- ??? [54] 100.0% [60] 356(7.3%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [62] 100.0% --------------------------------------------------------------------------- ??? [58] 100.0% [61] 1516(30.9%) 1370(27.9%) for-loop ...-conditions/src/core/egraph.rkt:226:26 update-en-expr [64] 9.6% --------------------------------------------------------------------------- ??? [54] 47.3% bf* [60] 52.7% [62] 676(13.8%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [63] 100.0% --------------------------------------------------------------------------- ??? [62] 100.0% [63] 676(13.8%) 518(10.6%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [65] 23.4% --------------------------------------------------------------------------- for-loop [61] 100.0% [64] 146(3.0%) 146(3.0%) update-en-expr ...itions/src/core/egraph.rkt:211:0 --------------------------------------------------------------------------- bfmul [63] 100.0% [65] 158(3.2%) 158(3.2%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ---------------------------------------------------------------------------