Profiling results ----------------- Total cpu time observed: 14074ms (out of 14188ms) Number of samples taken: 77 (once every 183ms) ================================================================================ Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ================================================================================ [1] 14074(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% -------------------------------------------------------------------------------- matcher [46] 100.0% [2] 188(1.3%) 0(0.0%) ??? ...s-no-duplicates/src/core/matcher.rkt:127:11 for-loop [4] 100.0% -------------------------------------------------------------------------------- ??? [1] 100.0% [3] 14074(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% -------------------------------------------------------------------------------- ??? [2] 100.0% [4] 188(1.3%) 0(0.0%) for-loop ...duplicates/src/core/matcher.rkt:129:15 matcher [46] 100.0% -------------------------------------------------------------------------------- profile-thunk16 [3] 100.0% [5] 14074(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [6] 100.0% -------------------------------------------------------------------------------- for-loop [66] 0.6% for-loop [44] 1.4% run [5] 98.0% [6] 14074(100.0%) 402(2.9%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [7] 90.6% prepare-points-intervals [8] 5.1% eval-errors [9] 1.5% errors [39] 0.7% temp85_0 [82] 0.6% -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [7] 12948(92.0%) 0(0.0%) run-improve47 ...duplicates/src/mainloop.rkt:346:0 for-loop [10] 100.0% -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [8] 718(5.1%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:120:0 loop [11] 100.0% -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [9] 216(1.5%) 0(0.0%) eval-errors ...-no-duplicates/src/points.rkt:168:0 for-loop [12] 100.0% -------------------------------------------------------------------------------- run-improve47 [7] 100.0% [10] 12948(92.0%) 0(0.0%) for-loop ...s-no-duplicates/src/mainloop.rkt:365:4 run-iter! [13] 100.0% -------------------------------------------------------------------------------- prepare-points-intervals [8] 100.0% [11] 718(5.1%) 0(0.0%) loop ...upwards-no-duplicates/src/points.rkt:132:4 loop [14] 76.9% ??? [15] 23.1% -------------------------------------------------------------------------------- eval-errors [9] 100.0% [12] 216(1.5%) 0(0.0%) for-loop ...rds-no-duplicates/src/points.rkt:170:2 ??? [38] 100.0% -------------------------------------------------------------------------------- for-loop [10] 100.0% [13] 12948(92.0%) 0(0.0%) run-iter! ...-no-duplicates/src/mainloop.rkt:327:0 simplify! [16] 92.7% finalize-iter! [17] 4.4% gen-rewrites! [19] 1.5% gen-series! [20] 1.4% -------------------------------------------------------------------------------- loop [11] 100.0% [14] 552(3.9%) 162(1.2%) loop ...-upwards-no-duplicates/src/points.rkt:79:2 real->precision [18] 70.7% -------------------------------------------------------------------------------- loop [11] 100.0% [15] 166(1.2%) 0(0.0%) ??? ...-upwards-no-duplicates/src/points.rkt:113:6 sample-multi-bounded [21] 100.0% -------------------------------------------------------------------------------- run-iter! [13] 100.0% [16] 12000(85.3%) 0(0.0%) simplify! ...-no-duplicates/src/mainloop.rkt:224:0 ??? [22] 100.0% -------------------------------------------------------------------------------- run-iter! [13] 100.0% [17] 576(4.1%) 0(0.0%) finalize-iter! ...uplicates/src/mainloop.rkt:278:0 ??? [23] 100.0% -------------------------------------------------------------------------------- loop [14] 100.0% [18] 390(2.8%) 0(0.0%) real->precision ...plicates/src/programs.rkt:94:11 ??? [38] 100.0% -------------------------------------------------------------------------------- run-iter! [13] 100.0% [19] 188(1.3%) 0(0.0%) gen-rewrites! ...duplicates/src/mainloop.rkt:183:0 for-loop [24] 100.0% -------------------------------------------------------------------------------- run-iter! [13] 100.0% [20] 184(1.3%) 0(0.0%) gen-series! ...o-duplicates/src/mainloop.rkt:160:0 for-loop [25] 100.0% -------------------------------------------------------------------------------- ??? [15] 100.0% [21] 166(1.2%) 0(0.0%) sample-multi-bounded ...icates/src/points.rkt:14:0 random-ranges [26] 100.0% -------------------------------------------------------------------------------- simplify! [16] 100.0% [22] 12000(85.3%) 0(0.0%) ??? ...ds-no-duplicates/src/core/simplify.rkt:38:0 ??? [27] 100.0% -------------------------------------------------------------------------------- finalize-iter! [17] 100.0% [23] 576(4.1%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [28] 100.0% -------------------------------------------------------------------------------- gen-rewrites! [19] 100.0% [24] 188(1.3%) 0(0.0%) for-loop ...-no-duplicates/src/mainloop.rkt:191:11 rewrite-expression-head24 [29] 100.0% -------------------------------------------------------------------------------- gen-series! [20] 100.0% [25] 184(1.3%) 0(0.0%) for-loop ...s-no-duplicates/src/mainloop.rkt:167:7 taylor-alt [30] 100.0% -------------------------------------------------------------------------------- sample-multi-bounded [21] 100.0% [26] 166(1.2%) 0(0.0%) random-ranges ...o-duplicates/src/common.rkt:164:0 build--> [31] 100.0% -------------------------------------------------------------------------------- ??? [22] 100.0% [27] 12000(85.3%) 0(0.0%) ??? ...ds-no-duplicates/src/core/simplify.rkt:56:0 for-loop [32] 98.5% loop [93] 1.5% -------------------------------------------------------------------------------- ??? [23] 100.0% [28] 576(4.1%) 0(0.0%) for-loop ...duplicates/src/core/alt-table.rkt:46:2 atab-add-altn [33] 68.4% override-at-pnts [36] 31.6% -------------------------------------------------------------------------------- for-loop [24] 100.0% [29] 188(1.3%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [34] 100.0% -------------------------------------------------------------------------------- for-loop [25] 100.0% [30] 184(1.3%) 0(0.0%) taylor-alt ...no-duplicates/src/mainloop.rkt:146:0 for-loop [35] 100.0% -------------------------------------------------------------------------------- random-ranges [26] 100.0% [31] 166(1.2%) 166(1.2%) build--> ...act/private/arrow-val-first.rkt:1214:0 -------------------------------------------------------------------------------- ??? [27] 100.0% [32] 11820(84.0%) 0(0.0%) for-loop ...-duplicates/src/core/simplify.rkt:76:2 for-loop [37] 100.0% -------------------------------------------------------------------------------- for-loop [28] 100.0% [33] 394(2.8%) 184(1.3%) atab-add-altn ...ates/src/core/alt-table.rkt:194:0 errors [39] 53.3% -------------------------------------------------------------------------------- rewrite-expression-head24 [29] 33.3% matcher [46] 66.7% [34] 188(1.3%) 188(1.3%) rewriter ...o-duplicates/src/core/matcher.rkt:87:2 for-loop [40] 66.7% -------------------------------------------------------------------------------- taylor-alt [30] 100.0% [35] 184(1.3%) 0(0.0%) for-loop ...s-no-duplicates/src/mainloop.rkt:152:6 ??? [38] 100.0% -------------------------------------------------------------------------------- for-loop [28] 100.0% [36] 182(1.3%) 0(0.0%) override-at-pnts ...s/src/core/alt-table.rkt:129:0 for-loop [41] 100.0% -------------------------------------------------------------------------------- for-loop [32] 100.0% [37] 11820(84.0%) 0(0.0%) for-loop ...-duplicates/src/core/simplify.rkt:80:4 ??? [42] 94.1% ??? [43] 4.5% loop [49] 1.4% -------------------------------------------------------------------------------- location-do [47] 11.6% for-loop [35] 11.6% for-loop [12] 27.3% real->precision [18] 49.4% [38] 790(5.6%) 216(1.5%) ??? ...tract/private/arrow-higher-order.rkt:375:33 bf [45] 49.4% location-do [47] 11.6% approximate9 [48] 11.6% -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 47.8% atab-add-altn [33] 52.2% [39] 402(2.9%) 0(0.0%) errors ...wards-no-duplicates/src/points.rkt:190:0 for-loop [44] 100.0% -------------------------------------------------------------------------------- rewriter [34] 100.0% [40] 188(1.3%) 0(0.0%) for-loop ...o-duplicates/src/core/matcher.rkt:89:4 matcher [46] 100.0% -------------------------------------------------------------------------------- override-at-pnts [36] 100.0% [41] 182(1.3%) 182(1.3%) for-loop ...plicates/src/core/alt-table.rkt:130:22 -------------------------------------------------------------------------------- for-loop [37] 100.0% [42] 11126(79.1%) 0(0.0%) ??? ...upwards-no-duplicates/regraph/main.rkt:44:0 find-matches [50] 65.4% for-loop [51] 34.6% -------------------------------------------------------------------------------- for-loop [37] 100.0% [43] 534(3.8%) 0(0.0%) ??? ...upwards-no-duplicates/regraph/main.rkt:55:0 for-loop [52] 100.0% -------------------------------------------------------------------------------- errors [39] 100.0% [44] 402(2.9%) 0(0.0%) for-loop ...rds-no-duplicates/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [6] 100.0% -------------------------------------------------------------------------------- ??? [38] 100.0% [45] 390(2.8%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [53] 100.0% -------------------------------------------------------------------------------- for-loop [4] 50.0% for-loop [40] 50.0% [46] 188(1.3%) 0(0.0%) matcher ...o-duplicates/src/core/matcher.rkt:115:2 ??? [2] 50.0% rewriter [34] 50.0% -------------------------------------------------------------------------------- location-do [47] 50.0% ??? [38] 50.0% [47] 184(1.3%) 0(0.0%) location-do ...no-duplicates/src/programs.rkt:63:0 location-do [47] 50.0% ??? [38] 50.0% -------------------------------------------------------------------------------- ??? [38] 100.0% [48] 184(1.3%) 0(0.0%) approximate9 ...uplicates/src/core/taylor.rkt:11:0 taylor-invert [54] 100.0% -------------------------------------------------------------------------------- for-loop [37] 100.0% [49] 160(1.1%) 0(0.0%) loop ...-no-duplicates/regraph/extraction.rkt:25:2 for-loop [55] 100.0% -------------------------------------------------------------------------------- ??? [42] 100.0% [50] 7272(51.7%) 0(0.0%) find-matches ...o-duplicates/regraph/main.rkt:36:0 for-loop [56] 100.0% -------------------------------------------------------------------------------- ??? [42] 100.0% [51] 3854(27.4%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:47:2 for-loop [57] 100.0% -------------------------------------------------------------------------------- ??? [43] 100.0% [52] 534(3.8%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:58:2 set-precompute! [58] 100.0% -------------------------------------------------------------------------------- bf [45] 100.0% [53] 390(2.8%) 390(2.8%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 -------------------------------------------------------------------------------- approximate9 [48] 100.0% [54] 184(1.3%) 0(0.0%) taylor-invert ...licates/src/core/taylor.rkt:317:0 first-nonzero-exp [59] 100.0% -------------------------------------------------------------------------------- loop [49] 100.0% [55] 160(1.1%) 0(0.0%) for-loop ...duplicates/regraph/extraction.rkt:28:4 for-loop [60] 100.0% -------------------------------------------------------------------------------- for-loop [56] 48.8% find-matches [50] 51.2% [56] 7272(51.7%) 380(2.7%) for-loop ...ds-no-duplicates/regraph/main.rkt:38:2 for-loop [56] 48.8% match-e [61] 47.4% -------------------------------------------------------------------------------- for-loop [51] 100.0% [57] 3854(27.4%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:50:4 merge-egraph-nodes! [62] 64.8% mk-enode-rec! [63] 18.0% substitute-e [64] 17.2% -------------------------------------------------------------------------------- for-loop [52] 100.0% [58] 534(3.8%) 0(0.0%) set-precompute! ...uplicates/regraph/main.rkt:62:0 merge-egraph-nodes! [62] 68.2% for-loop [66] 31.8% -------------------------------------------------------------------------------- taylor-invert [54] 100.0% [59] 184(1.3%) 0(0.0%) first-nonzero-exp ...tes/src/core/taylor.rkt:265:0 hash-ref! [65] 100.0% -------------------------------------------------------------------------------- for-loop [55] 100.0% [60] 160(1.1%) 160(1.1%) for-loop ...uplicates/regraph/extraction.rkt:36:16 -------------------------------------------------------------------------------- for-loop [74] 28.5% for-loop [56] 71.5% [61] 6892(49.0%) 840(6.0%) match-e ...s-no-duplicates/regraph/ematch.rkt:35:0 for-loop [67] 89.2% custom-in-set [72] 1.2% -------------------------------------------------------------------------------- for-loop [71] 3.0% merge-egraph-nodes! [62] 3.6% set-precompute! [58] 12.7% for-loop [57] 80.6% [62] 2860(20.3%) 0(0.0%) merge-egraph-nodes! ...es/regraph/egraph.rkt:144:0 update-leader! [68] 82.0% loop! [96] 11.3% merge-egraph-nodes! [62] 3.6% for-loop [71] 3.0% -------------------------------------------------------------------------------- for-loop [57] 100.0% [63] 694(4.9%) 0(0.0%) mk-enode-rec! ...plicates/regraph/egraph.rkt:116:0 loop [93] 100.0% -------------------------------------------------------------------------------- substitute-e [64] 12.2% for-loop [57] 87.8% [64] 664(4.7%) 0(0.0%) substitute-e ...duplicates/regraph/ematch.rkt:55:0 return/no-unsupplied [69] 75.6% substitute-e [64] 12.2% ??? [73] 12.2% -------------------------------------------------------------------------------- first-nonzero-exp [59] 100.0% [65] 184(1.3%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop74 [70] 100.0% -------------------------------------------------------------------------------- set-precompute! [58] 100.0% [66] 170(1.2%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:63:2 .../more-scheme.rkt:261:28 [6] 100.0% -------------------------------------------------------------------------------- match-e [61] 100.0% [67] 6356(45.2%) 3038(21.6%) for-loop ...no-duplicates/regraph/ematch.rkt:41:11 for-loop [74] 34.2% loop [93] 10.8% procedure-reduce-keyword-arity-mask [76] 10.1% do-curry [77] 9.7% cp-2 [78] 4.8% -------------------------------------------------------------------------------- merge-egraph-nodes! [62] 100.0% [68] 2536(18.0%) 0(0.0%) update-leader! ...licates/regraph/egraph.rkt:213:0 for-loop [75] 100.0% -------------------------------------------------------------------------------- substitute-e [64] 100.0% [69] 502(3.6%) 502(3.6%) return/no-unsupplied ...ct/private/arr-i.rkt:566:0 -------------------------------------------------------------------------------- hash-ref! [65] 100.0% [70] 184(1.3%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [79] 100.0% -------------------------------------------------------------------------------- merge-egraph-nodes! [62] 100.0% [71] 174(1.2%) 0(0.0%) for-loop ...no-duplicates/regraph/egraph.rkt:199:4 merge-egraph-nodes! [62] 100.0% -------------------------------------------------------------------------------- match-e [61] 100.0% [72] 168(1.2%) 168(1.2%) custom-in-set ...acket/private/set-types.rkt:578:0 -------------------------------------------------------------------------------- substitute-e [64] 100.0% [73] 162(1.2%) 0(0.0%) ??? ...ects/racket/contract/private/guts.rkt:770:8 dict? [80] 100.0% -------------------------------------------------------------------------------- for-loop [67] 100.0% [74] 3830(27.2%) 0(0.0%) for-loop ...no-duplicates/regraph/ematch.rkt:47:37 match-e [61] 100.0% -------------------------------------------------------------------------------- update-leader! [68] 100.0% [75] 2536(18.0%) 0(0.0%) for-loop ...no-duplicates/regraph/egraph.rkt:218:6 for-loop [81] 55.8% hash-update! [84] 44.2% -------------------------------------------------------------------------------- for-loop [67] 100.0% [76] 982(7.0%) 982(7.0%) procedure-reduce-keyword-arity-mask ....rkt:1597:4 -------------------------------------------------------------------------------- for-loop [67] 100.0% [77] 872(6.2%) 872(6.2%) do-curry ...-7.5/collects/racket/function.rkt:71:2 -------------------------------------------------------------------------------- for-loop [67] 100.0% [78] 308(2.2%) 0(0.0%) cp-2 .../racket-7.5/collects/racket/list.rkt:826:2 for-loop [83] 100.0% -------------------------------------------------------------------------------- parse-loop74 [70] 100.0% [79] 184(1.3%) 0(0.0%) eval-const-expr ...plicates/src/programs.rkt:120:0 temp85_0 [82] 100.0% -------------------------------------------------------------------------------- ??? [73] 100.0% [80] 162(1.2%) 162(1.2%) dict? ...ollects/racket/private/generic.rkt:146:11 -------------------------------------------------------------------------------- for-loop [75] 100.0% [81] 1416(10.1%) 0(0.0%) for-loop ...no-duplicates/regraph/egraph.rkt:219:8 hash-update! [84] 100.0% -------------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 48.0% eval-const-expr [79] 52.0% [82] 354(2.5%) 0(0.0%) temp85_0 (unknown source) compile15 [85] 100.0% -------------------------------------------------------------------------------- cp-2 [78] 100.0% [83] 308(2.2%) 308(2.2%) for-loop ...ket-7.5/collects/racket/list.rkt:827:4 -------------------------------------------------------------------------------- for-loop [75] 44.2% for-loop [81] 55.8% [84] 2536(18.0%) 0(0.0%) hash-update! ...cket/private/more-scheme.rkt:365:4 ??? [86] 100.0% -------------------------------------------------------------------------------- temp85_0 [82] 100.0% [85] 354(2.5%) 0(0.0%) compile15 (unknown source) temp91_0 [87] 100.0% -------------------------------------------------------------------------------- hash-update! [84] 100.0% [86] 2536(18.0%) 192(1.4%) ??? ...rds-no-duplicates/regraph/egraph.rkt:221:24 for-loop [88] 92.4% -------------------------------------------------------------------------------- compile15 [85] 100.0% [87] 354(2.5%) 0(0.0%) temp91_0 (unknown source) temp118_0 [89] 100.0% -------------------------------------------------------------------------------- ??? [86] 100.0% [88] 2344(16.7%) 2138(15.2%) for-loop ...o-duplicates/regraph/egraph.rkt:222:26 update-en-expr [91] 8.8% -------------------------------------------------------------------------------- temp91_0 [87] 100.0% [89] 354(2.5%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [90] 100.0% -------------------------------------------------------------------------------- temp118_0 [89] 100.0% [90] 354(2.5%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [92] 100.0% -------------------------------------------------------------------------------- for-loop [88] 100.0% [91] 206(1.5%) 206(1.5%) update-en-expr ...licates/regraph/egraph.rkt:207:0 -------------------------------------------------------------------------------- expand-capturing-lifts [90] 100.0% [92] 354(2.5%) 0(0.0%) lambda-clause-expander (unknown source) loop [93] 52.0% finish-bodys [94] 48.0% -------------------------------------------------------------------------------- for-loop [67] 2.9% munge [98] 2.9% ??? [27] 2.9% lambda-clause-expander [92] 8.9% loop! [96] 10.2% mk-enode-rec! [63] 33.6% loop [93] 38.6% [93] 2066(14.7%) 518(3.7%) loop (unknown source) loop [93] 38.6% ??? [95] 33.6% loop! [96] 10.2% munge [98] 5.8% foldl [100] 0.4% step [97] 0.3% -------------------------------------------------------------------------------- for-loop [99] 50.0% lambda-clause-expander [92] 50.0% [94] 170(1.2%) 0(0.0%) finish-bodys (unknown source) for-loop [99] 100.0% -------------------------------------------------------------------------------- loop [93] 100.0% [95] 694(4.9%) 694(4.9%) ??? ...cket-7.5/collects/racket/function.rkt:93:12 -------------------------------------------------------------------------------- loop [93] 50.0% merge-egraph-nodes! [62] 50.0% [96] 324(2.3%) 172(1.2%) loop! ...rds-no-duplicates/regraph/enode.rkt:158:2 loop [93] 50.0% custom-set-union [103] 23.5% -------------------------------------------------------------------------------- loop [93] 100.0% [97] 200(1.4%) 200(1.4%) step ...ket-7.5/collects/racket/function.rkt:145:9 -------------------------------------------------------------------------------- loop [93] 100.0% [98] 180(1.3%) 0(0.0%) munge ...no-duplicates/src/core/simplify.rkt:125:0 loop [93] 50.0% variable? [101] 50.0% -------------------------------------------------------------------------------- for-loop [99] 50.0% finish-bodys [94] 50.0% [99] 170(1.2%) 0(0.0%) for-loop (unknown source) for-loop [99] 50.0% finish-bodys [94] 25.0% syntax-e [102] 25.0% -------------------------------------------------------------------------------- loop [93] 100.0% [100] 150(1.1%) 150(1.1%) foldl ....5/collects/racket/private/list.rkt:229:4 -------------------------------------------------------------------------------- munge [98] 100.0% [101] 180(1.3%) 0(0.0%) variable? ...uplicates/src/syntax/syntax.rkt:729:0 value? [104] 100.0% -------------------------------------------------------------------------------- for-loop [99] 100.0% [102] 170(1.2%) 170(1.2%) syntax-e (unknown source) -------------------------------------------------------------------------------- loop! [96] 100.0% [103] 152(1.1%) 152(1.1%) custom-set-union ...et/private/set-types.rkt:168:0 -------------------------------------------------------------------------------- variable? [101] 100.0% [104] 180(1.3%) 180(1.3%) value? ...-no-duplicates/src/syntax/types.rkt:18:0 --------------------------------------------------------------------------------