Profiling results ----------------- Total cpu time observed: 41208ms (out of 41432ms) Number of samples taken: 194 (once every 212ms) (Hiding functions with self<1.0% and local<2.0%: 5 of 109 hidden) ================================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ================================================================================= [1] 41208(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [4] 100.0% --------------------------------------------------------------------------------- loop [88] 100.0% [2] 222(0.5%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [5] 100.0% --------------------------------------------------------------------------------- matcher [54] 100.0% [3] 200(0.5%) 0(0.0%) ??? ...s-no-duplicates/src/core/matcher.rkt:127:11 for-loop [6] 100.0% --------------------------------------------------------------------------------- ??? [1] 100.0% [4] 41208(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] 222(0.5%) 0(0.0%) syntax-e/no-taint (unknown source) loop [88] 100.0% --------------------------------------------------------------------------------- ??? [3] 100.0% [6] 200(0.5%) 0(0.0%) for-loop ...duplicates/src/core/matcher.rkt:129:15 matcher [54] 100.0% --------------------------------------------------------------------------------- profile-thunk16 [4] 100.0% [7] 41208(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [8] 100.0% --------------------------------------------------------------------------------- for-loop [68] 0.8% set-precompute! [62] 0.8% run [7] 98.5% [8] 41208(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [9] 94.9% prepare-points-intervals [10] 3.0% temp85_0 [11] 1.3% get-p&es [12] 0.6% eval-prog [13] 0.3% --------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [8] 100.0% [9] 39740(96.4%) 0(0.0%) run-improve47 ...duplicates/src/mainloop.rkt:346:0 simplify! [22] 81.9% for-loop [14] 18.1% --------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [8] 100.0% [10] 1240(3.0%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:120:0 loop [15] 100.0% --------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [8] 100.0% [11] 1050(2.5%) 0(0.0%) temp85_0 (unknown source) compile15 [16] 100.0% --------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [8] 100.0% [12] 228(0.6%) 0(0.0%) get-p&es ...rds-no-duplicates/src/sandbox.rkt:25:0 for-loop [17] 100.0% --------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [8] 100.0% [13] 222(0.5%) 0(0.0%) eval-prog ...s-no-duplicates/src/programs.rkt:82:0 ??? [24] 100.0% --------------------------------------------------------------------------------- run-improve47 [9] 100.0% [14] 7184(17.4%) 0(0.0%) for-loop ...s-no-duplicates/src/mainloop.rkt:365:4 run-iter! [18] 100.0% --------------------------------------------------------------------------------- prepare-points-intervals [10] 100.0% [15] 1240(3.0%) 0(0.0%) loop ...upwards-no-duplicates/src/points.rkt:132:4 loop [20] 50.5% ??? [21] 32.7% do-curry [99] 16.8% --------------------------------------------------------------------------------- temp85_0 [11] 100.0% [16] 1050(2.5%) 0(0.0%) compile15 (unknown source) temp91_0 [19] 100.0% --------------------------------------------------------------------------------- get-p&es [12] 100.0% [17] 228(0.6%) 228(0.6%) for-loop ...rds-no-duplicates/src/sandbox.rkt:26:2 --------------------------------------------------------------------------------- for-loop [14] 100.0% [18] 7184(17.4%) 0(0.0%) run-iter! ...-no-duplicates/src/mainloop.rkt:327:0 simplify! [22] 94.3% finalize-iter! [26] 2.9% gen-rewrites! [27] 2.8% --------------------------------------------------------------------------------- compile15 [16] 100.0% [19] 1050(2.5%) 0(0.0%) temp91_0 (unknown source) temp118_0 [23] 100.0% --------------------------------------------------------------------------------- loop [15] 100.0% [20] 626(1.5%) 208(0.5%) loop ...-upwards-no-duplicates/src/points.rkt:79:2 ??? [24] 34.8% hash-update! [92] 31.9% --------------------------------------------------------------------------------- loop [15] 100.0% [21] 406(1.0%) 0(0.0%) ??? ...-upwards-no-duplicates/src/points.rkt:113:6 sample-multi-bounded [25] 100.0% --------------------------------------------------------------------------------- run-iter! [18] 17.2% run-improve47 [9] 82.8% [22] 39334(95.5%) 0(0.0%) simplify! ...-no-duplicates/src/mainloop.rkt:224:0 ??? [28] 100.0% --------------------------------------------------------------------------------- temp91_0 [19] 100.0% [23] 1050(2.5%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [29] 100.0% --------------------------------------------------------------------------------- loop [20] 49.5% eval-prog [13] 50.5% [24] 440(1.1%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ??? [31] 50.5% ival-sub [32] 49.5% --------------------------------------------------------------------------------- ??? [21] 100.0% [25] 406(1.0%) 0(0.0%) sample-multi-bounded ...icates/src/points.rkt:14:0 random-ranges [30] 100.0% --------------------------------------------------------------------------------- run-iter! [18] 100.0% [26] 206(0.5%) 0(0.0%) finalize-iter! ...uplicates/src/mainloop.rkt:278:0 ??? [33] 100.0% --------------------------------------------------------------------------------- run-iter! [18] 100.0% [27] 200(0.5%) 0(0.0%) gen-rewrites! ...duplicates/src/mainloop.rkt:183:0 for-loop [34] 100.0% --------------------------------------------------------------------------------- simplify! [22] 100.0% [28] 39334(95.5%) 0(0.0%) ??? ...ds-no-duplicates/src/core/simplify.rkt:38:0 ??? [35] 100.0% --------------------------------------------------------------------------------- temp118_0 [23] 100.0% [29] 1050(2.5%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [36] 80.8% expand-id-application-form17 [39] 19.2% --------------------------------------------------------------------------------- sample-multi-bounded [25] 100.0% [30] 406(1.0%) 406(1.0%) random-ranges ...o-duplicates/src/common.rkt:164:0 --------------------------------------------------------------------------------- ??? [24] 100.0% [31] 222(0.5%) 222(0.5%) ??? ...cts/racket/contract/private/list.rkt:209:10 --------------------------------------------------------------------------------- ??? [24] 100.0% [32] 218(0.5%) 0(0.0%) ival-sub ...o-duplicates/src/biginterval.rkt:108:0 bfsub [37] 100.0% --------------------------------------------------------------------------------- finalize-iter! [26] 100.0% [33] 206(0.5%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [38] 100.0% --------------------------------------------------------------------------------- gen-rewrites! [27] 100.0% [34] 200(0.5%) 0(0.0%) for-loop ...-no-duplicates/src/mainloop.rkt:191:11 rewrite-expression-head24 [40] 100.0% --------------------------------------------------------------------------------- ??? [28] 100.0% [35] 39334(95.5%) 0(0.0%) ??? ...ds-no-duplicates/src/core/simplify.rkt:56:0 for-loop [41] 100.0% --------------------------------------------------------------------------------- expand-capturing-lifts [29] 100.0% [36] 848(2.1%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [42] 52.6% loop [88] 47.4% --------------------------------------------------------------------------------- ival-sub [32] 100.0% [37] 218(0.5%) 0(0.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [43] 100.0% --------------------------------------------------------------------------------- ??? [33] 100.0% [38] 206(0.5%) 0(0.0%) for-loop ...duplicates/src/core/alt-table.rkt:46:2 loop [44] 100.0% --------------------------------------------------------------------------------- expand-capturing-lifts [29] 100.0% [39] 202(0.5%) 0(0.0%) expand-id-application-form17 (unknown source) binding-lookup52 [45] 100.0% --------------------------------------------------------------------------------- for-loop [34] 100.0% [40] 200(0.5%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [46] 100.0% --------------------------------------------------------------------------------- ??? [35] 100.0% [41] 39334(95.5%) 200(0.5%) for-loop ...-duplicates/src/core/simplify.rkt:76:2 for-loop [47] 99.5% --------------------------------------------------------------------------------- lambda-clause-expander [36] 41.6% for-loop [48] 58.4% [42] 446(1.1%) 0(0.0%) finish-bodys (unknown source) for-loop [48] 100.0% --------------------------------------------------------------------------------- bfsub [37] 100.0% [43] 218(0.5%) 218(0.5%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 --------------------------------------------------------------------------------- for-loop [38] 100.0% [44] 206(0.5%) 206(0.5%) loop ...no-duplicates/src/core/alt-table.rkt:168:2 --------------------------------------------------------------------------------- expand-id-application-form17 [39] 100.0% [45] 202(0.5%) 202(0.5%) binding-lookup52 (unknown source) --------------------------------------------------------------------------------- rewrite-expression-head24 [40] 33.3% matcher [54] 66.7% [46] 200(0.5%) 0(0.0%) rewriter ...o-duplicates/src/core/matcher.rkt:87:2 for-loop [49] 100.0% --------------------------------------------------------------------------------- for-loop [41] 100.0% [47] 39134(95.0%) 0(0.0%) for-loop ...-duplicates/src/core/simplify.rkt:80:4 ??? [50] 95.7% ??? [51] 4.3% --------------------------------------------------------------------------------- for-loop [48] 29.1% finish-bodys [42] 70.9% [48] 446(1.1%) 224(0.5%) for-loop (unknown source) finish-bodys [42] 41.7% for-loop [48] 29.1% dispatch-transformer41 [52] 16.6% --------------------------------------------------------------------------------- rewriter [46] 100.0% [49] 200(0.5%) 0(0.0%) for-loop ...o-duplicates/src/core/matcher.rkt:89:4 matcher [54] 66.7% for-loop [53] 33.3% --------------------------------------------------------------------------------- for-loop [47] 100.0% [50] 37440(90.9%) 0(0.0%) ??? ...upwards-no-duplicates/regraph/main.rkt:44:0 find-matches [55] 87.9% for-loop [56] 12.1% --------------------------------------------------------------------------------- for-loop [47] 100.0% [51] 1694(4.1%) 0(0.0%) ??? ...upwards-no-duplicates/regraph/main.rkt:55:0 for-loop [57] 100.0% --------------------------------------------------------------------------------- for-loop [48] 35.6% loop [88] 64.4% [52] 624(1.5%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [58] 100.0% --------------------------------------------------------------------------------- for-loop [49] 100.0% [53] 200(0.5%) 0(0.0%) for-loop ...o-duplicates/src/core/matcher.rkt:96:8 fix-up-variables [59] 100.0% --------------------------------------------------------------------------------- for-loop [6] 50.0% for-loop [49] 50.0% [54] 200(0.5%) 0(0.0%) matcher ...o-duplicates/src/core/matcher.rkt:115:2 ??? [3] 50.0% rewriter [46] 50.0% --------------------------------------------------------------------------------- ??? [50] 100.0% [55] 32916(79.9%) 0(0.0%) find-matches ...o-duplicates/regraph/main.rkt:36:0 for-loop [60] 100.0% --------------------------------------------------------------------------------- ??? [50] 100.0% [56] 4524(11.0%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:47:2 for-loop [61] 100.0% --------------------------------------------------------------------------------- ??? [51] 100.0% [57] 1694(4.1%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:58:2 set-precompute! [62] 100.0% --------------------------------------------------------------------------------- dispatch-transformer41 [52] 100.0% [58] 624(1.5%) 0(0.0%) apply-transformer52 (unknown source) apply-transformer-in-context [63] 100.0% --------------------------------------------------------------------------------- for-loop [53] 100.0% [59] 200(0.5%) 0(0.0%) fix-up-variables ...tes/src/core/matcher.rkt:108:2 pattern-match [64] 100.0% --------------------------------------------------------------------------------- for-loop [60] 49.7% find-matches [55] 50.3% [60] 32916(79.9%) 204(0.5%) for-loop ...ds-no-duplicates/regraph/main.rkt:38:2 for-loop [60] 49.7% match-e [65] 49.7% --------------------------------------------------------------------------------- for-loop [56] 100.0% [61] 4524(11.0%) 216(0.5%) for-loop ...ds-no-duplicates/regraph/main.rkt:50:4 merge-egraph-nodes! [66] 55.0% mk-enode-rec! [95] 22.4% substitute-e [67] 17.8% --------------------------------------------------------------------------------- for-loop [57] 100.0% [62] 1694(4.1%) 0(0.0%) set-precompute! ...uplicates/regraph/main.rkt:62:0 .../more-scheme.rkt:261:28 [8] 38.1% for-loop [68] 37.0% merge-egraph-nodes! [66] 24.9% --------------------------------------------------------------------------------- apply-transformer52 [58] 100.0% [63] 624(1.5%) 402(1.0%) apply-transformer-in-context (unknown source) ??? [69] 35.6% --------------------------------------------------------------------------------- fix-up-variables [59] 100.0% [64] 200(0.5%) 0(0.0%) pattern-match ...licates/src/core/matcher.rkt:29:0 for-loop [70] 100.0% --------------------------------------------------------------------------------- for-loop [78] 31.6% for-loop [60] 68.4% [65] 32712(79.4%) 2444(5.9%) match-e ...s-no-duplicates/regraph/ematch.rkt:35:0 for-loop [71] 95.5% --------------------------------------------------------------------------------- for-loop [73] 10.3% set-precompute! [62] 14.5% for-loop [61] 75.2% [66] 2910(7.1%) 0(0.0%) merge-egraph-nodes! ...es/regraph/egraph.rkt:144:0 update-leader! [72] 82.8% for-loop [73] 10.3% loop! [97] 6.9% --------------------------------------------------------------------------------- substitute-e [67] 37.6% for-loop [61] 62.4% [67] 806(2.0%) 200(0.5%) substitute-e ...duplicates/regraph/ematch.rkt:55:0 substitute-e [67] 37.6% ??? [74] 37.2% return/no-unsupplied [76] 12.8% --------------------------------------------------------------------------------- set-precompute! [62] 100.0% [68] 626(1.5%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:63:2 .../more-scheme.rkt:261:28 [8] 100.0% --------------------------------------------------------------------------------- apply-transformer-in-context [63] 100.0% [69] 222(0.5%) 0(0.0%) ??? ...collects/racket/private/qq-and-or.rkt:155:9 ??? [75] 100.0% --------------------------------------------------------------------------------- pattern-match [64] 100.0% [70] 200(0.5%) 0(0.0%) for-loop ...o-duplicates/src/core/matcher.rkt:26:9 core457 [77] 100.0% --------------------------------------------------------------------------------- match-e [65] 100.0% [71] 32512(78.9%) 12282(29.8%) for-loop ...no-duplicates/regraph/ematch.rkt:41:11 for-loop [78] 36.6% loop [88] 27.2% do-curry [99] 3.5% procedure-reduce-keyword-arity-mask [80] 2.6% ??? [93] 1.6% foldr [81] 1.4% make-curried [82] 0.7% keyword-apply [96] 0.6% step [94] 0.6% foldl [91] 0.6% cp-2 [87] 0.3% --------------------------------------------------------------------------------- merge-egraph-nodes! [66] 100.0% [72] 2710(6.6%) 0(0.0%) update-leader! ...licates/regraph/egraph.rkt:213:0 for-loop [79] 92.6% for-loop [86] 7.4% --------------------------------------------------------------------------------- merge-egraph-nodes! [66] 100.0% [73] 600(1.5%) 0(0.0%) for-loop ...no-duplicates/regraph/egraph.rkt:199:4 merge-egraph-nodes! [66] 100.0% --------------------------------------------------------------------------------- substitute-e [67] 100.0% [74] 400(1.0%) 0(0.0%) ??? ...ects/racket/contract/private/guts.rkt:770:8 dict? [83] 100.0% --------------------------------------------------------------------------------- ??? [69] 100.0% [75] 222(0.5%) 0(0.0%) ??? ...ollects/racket/private/qq-and-or.rkt:164:21 syntax->list [84] 100.0% --------------------------------------------------------------------------------- substitute-e [67] 100.0% [76] 206(0.5%) 206(0.5%) return/no-unsupplied ...ct/private/arr-i.rkt:566:0 --------------------------------------------------------------------------------- for-loop [70] 100.0% [77] 200(0.5%) 0(0.0%) core457 ...acket/contract/private/arr-i.rkt:976:19 build-unary-very-simple--> [85] 100.0% --------------------------------------------------------------------------------- for-loop [71] 100.0% [78] 20180(49.0%) 406(1.0%) for-loop ...no-duplicates/regraph/ematch.rkt:47:37 match-e [65] 98.5% --------------------------------------------------------------------------------- update-leader! [72] 100.0% [79] 2510(6.1%) 0(0.0%) for-loop ...no-duplicates/regraph/egraph.rkt:218:6 for-loop [89] 58.5% hash-update! [92] 41.5% --------------------------------------------------------------------------------- for-loop [71] 100.0% [80] 1472(3.6%) 1472(3.6%) procedure-reduce-keyword-arity-mask ....rkt:1597:4 --------------------------------------------------------------------------------- for-loop [71] 100.0% [81] 878(2.1%) 878(2.1%) foldr ....5/collects/racket/private/list.rkt:242:4 --------------------------------------------------------------------------------- for-loop [71] 100.0% [82] 424(1.0%) 424(1.0%) make-curried ...collects/racket/function.rkt:130:9 --------------------------------------------------------------------------------- ??? [74] 100.0% [83] 400(1.0%) 400(1.0%) dict? ...ollects/racket/private/generic.rkt:146:11 --------------------------------------------------------------------------------- ??? [75] 100.0% [84] 222(0.5%) 0(0.0%) syntax->list (unknown source) loop [88] 100.0% --------------------------------------------------------------------------------- core457 [77] 100.0% [85] 200(0.5%) 200(0.5%) build-unary-very-simple--> ...val-first.rkt:1150:0 --------------------------------------------------------------------------------- update-leader! [72] 100.0% [86] 200(0.5%) 0(0.0%) for-loop ...no-duplicates/regraph/egraph.rkt:228:6 update-en-expr [104] 100.0% --------------------------------------------------------------------------------- for-loop [71] 100.0% [87] 200(0.5%) 0(0.0%) cp-2 .../racket-7.5/collects/racket/list.rkt:826:2 for-loop [90] 100.0% --------------------------------------------------------------------------------- loop! [97] 0.8% syntax-e/no-taint [5] 1.1% syntax->list [84] 1.1% mk-enode-rec! [95] 2.0% for-loop [71] 3.9% lambda-clause-expander [36] 4.1% loop [88] 86.9% [88] 9874(24.0%) 3234(7.8%) loop (unknown source) loop [88] 86.9% dispatch-transformer41 [52] 4.1% foldl [91] 2.3% mk-enode-rec! [95] 2.0% syntax-e [2] 1.1% loop! [97] 0.8% step [94] 0.8% ??? [93] 0.2% keyword-apply [96] 0.0% --------------------------------------------------------------------------------- for-loop [79] 100.0% [89] 1468(3.6%) 0(0.0%) for-loop ...no-duplicates/regraph/egraph.rkt:219:8 hash-update! [92] 100.0% --------------------------------------------------------------------------------- cp-2 [87] 100.0% [90] 200(0.5%) 200(0.5%) for-loop ...ket-7.5/collects/racket/list.rkt:827:4 --------------------------------------------------------------------------------- for-loop [71] 11.6% loop [88] 88.4% [91] 3444(8.4%) 666(1.6%) foldl ....5/collects/racket/private/list.rkt:229:4 merge2 [98] 80.7% --------------------------------------------------------------------------------- loop [20] 7.4% for-loop [79] 38.5% for-loop [89] 54.2% [92] 2710(6.6%) 200(0.5%) hash-update! ...cket/private/more-scheme.rkt:365:4 ??? [100] 92.6% --------------------------------------------------------------------------------- for-loop [71] 44.2% loop [88] 55.8% [93] 1828(4.4%) 1828(4.4%) ??? ...ket-7.5/collects/racket/function.rkt:138:13 --------------------------------------------------------------------------------- for-loop [71] 23.7% loop [88] 76.3% [94] 1722(4.2%) 1722(4.2%) step ...ket-7.5/collects/racket/function.rkt:145:9 --------------------------------------------------------------------------------- loop [88] 9.9% for-loop [61] 90.1% [95] 1014(2.5%) 200(0.5%) mk-enode-rec! ...plicates/regraph/egraph.rkt:116:0 for-loop [101] 40.0% do-curry [99] 20.5% hash-has-key? [102] 19.7% loop [88] 9.9% --------------------------------------------------------------------------------- for-loop [71] 47.0% loop [88] 53.0% [96] 868(2.1%) 868(2.1%) keyword-apply ...lects/racket/private/kw.rkt:455:2 --------------------------------------------------------------------------------- merge-egraph-nodes! [66] 33.3% loop [88] 66.7% [97] 200(0.5%) 200(0.5%) loop! ...rds-no-duplicates/regraph/enode.rkt:158:2 loop [88] 66.7% --------------------------------------------------------------------------------- foldl [91] 100.0% [98] 2778(6.7%) 2778(6.7%) merge2 ...ds-no-duplicates/regraph/ematch.rkt:20:0 --------------------------------------------------------------------------------- mk-enode-rec! [95] 7.7% loop [15] 7.7% for-loop [71] 84.7% [99] 2718(6.6%) 2718(6.6%) do-curry ...-7.5/collects/racket/function.rkt:71:2 --------------------------------------------------------------------------------- hash-update! [92] 100.0% [100] 2510(6.1%) 0(0.0%) ??? ...rds-no-duplicates/regraph/egraph.rkt:221:24 for-loop [103] 100.0% --------------------------------------------------------------------------------- mk-enode-rec! [95] 100.0% [101] 406(1.0%) 406(1.0%) for-loop ...o-duplicates/regraph/egraph.rkt:108:10 --------------------------------------------------------------------------------- mk-enode-rec! [95] 100.0% [102] 200(0.5%) 200(0.5%) hash-has-key? ...ket/private/more-scheme.rkt:371:2 --------------------------------------------------------------------------------- ??? [100] 100.0% [103] 2510(6.1%) 2304(5.6%) for-loop ...o-duplicates/regraph/egraph.rkt:222:26 update-en-expr [104] 8.2% --------------------------------------------------------------------------------- for-loop [86] 49.3% for-loop [103] 50.7% [104] 406(1.0%) 406(1.0%) update-en-expr ...licates/regraph/egraph.rkt:207:0 ---------------------------------------------------------------------------------