Profiling results ----------------- Total cpu time observed: 7424ms (out of 7648ms) Number of samples taken: 24 (once every 309ms) =================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee =================================================================== run [15] 50.0% [1] 7424(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [9] 50.0% run-improve43 [8] 50.0% ------------------------------------------------------------------- hash-ref! [76] 100.0% [2] 634(8.5%) 0(0.0%) ??? .../various-cleanup/src/core/taylor.rkt:291:26 for-loop [10] 100.0% ------------------------------------------------------------------- taylor [71] 100.0% [3] 632(8.5%) 0(0.0%) taylor-invert ...cleanup/src/core/taylor.rkt:318:0 first-nonzero-exp [11] 100.0% ------------------------------------------------------------------- hash-ref! [76] 100.0% [4] 628(8.5%) 0(0.0%) ??? ...e/various-cleanup/src/core/taylor.rkt:45:15 ??? [14] 52.2% hash-ref! [76] 47.8% ------------------------------------------------------------------- match-e [72] 100.0% [5] 624(8.4%) 0(0.0%) for-loop ...ious-cleanup/src/core/ematch.rkt:52:11 for-loop [12] 100.0% ------------------------------------------------------------------- hash-ref! [76] 100.0% [6] 328(4.4%) 0(0.0%) ??? .../various-cleanup/src/core/taylor.rkt:301:23 for-loop [13] 100.0% ------------------------------------------------------------------- taylor [71] 100.0% [7] 310(4.2%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 simplify [80] 100.0% ------------------------------------------------------------------- ??? [1] 100.0% [8] 7424(100.0%) 0(0.0%) run-improve43 ...us-cleanup/src/mainloop.rkt:339:0 for-loop [16] 83.0% simplify! [22] 8.8% setup-prog!34 [17] 4.1% finalize-iter! [18] 4.0% ------------------------------------------------------------------- ??? [1] 100.0% [9] 7424(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [15] 100.0% ------------------------------------------------------------------- ??? [2] 100.0% [10] 634(8.5%) 0(0.0%) for-loop ...ous-cleanup/src/core/taylor.rkt:291:52 hash-ref! [76] 100.0% ------------------------------------------------------------------- taylor-invert [3] 100.0% [11] 632(8.5%) 0(0.0%) first-nonzero-exp ...nup/src/core/taylor.rkt:266:0 hash-ref! [76] 100.0% ------------------------------------------------------------------- for-loop [5] 100.0% [12] 624(8.4%) 0(0.0%) for-loop ...ious-cleanup/src/core/ematch.rkt:58:37 match-e [72] 100.0% ------------------------------------------------------------------- ??? [6] 100.0% [13] 328(4.4%) 0(0.0%) for-loop ...ous-cleanup/src/core/taylor.rkt:304:27 hash-ref! [76] 100.0% ------------------------------------------------------------------- ??? [4] 100.0% [14] 328(4.4%) 0(0.0%) ??? .../various-cleanup/src/core/taylor.rkt:294:19 hash-ref! [76] 100.0% ------------------------------------------------------------------- profile-thunk16 [9] 100.0% [15] 7424(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------- run-improve43 [8] 100.0% [16] 6160(83.0%) 0(0.0%) for-loop ...various-cleanup/src/mainloop.rkt:354:4 run-iter! [19] 100.0% ------------------------------------------------------------------- run-improve43 [8] 100.0% [17] 308(4.1%) 0(0.0%) setup-prog!34 ...ous-cleanup/src/mainloop.rkt:67:0 prepare-points [20] 100.0% ------------------------------------------------------------------- run-improve43 [8] 100.0% [18] 300(4.0%) 0(0.0%) finalize-iter! ...s-cleanup/src/mainloop.rkt:271:0 ??? [21] 100.0% ------------------------------------------------------------------- for-loop [16] 100.0% [19] 6160(83.0%) 0(0.0%) run-iter! ...arious-cleanup/src/mainloop.rkt:320:0 gen-series! [23] 40.8% simplify! [22] 39.7% gen-rewrites! [24] 14.6% localize! [26] 4.9% ------------------------------------------------------------------- setup-prog!34 [17] 100.0% [20] 308(4.1%) 0(0.0%) prepare-points ...ous-cleanup/src/points.rkt:166:0 loop [25] 100.0% ------------------------------------------------------------------- finalize-iter! [18] 100.0% [21] 300(4.0%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 atab-add-altns [27] 100.0% ------------------------------------------------------------------- run-improve43 [8] 21.1% run-iter! [19] 78.9% [22] 3102(41.8%) 0(0.0%) simplify! ...arious-cleanup/src/mainloop.rkt:217:0 ??? [28] 89.5% for-loop [31] 10.5% ------------------------------------------------------------------- run-iter! [19] 100.0% [23] 2512(33.8%) 0(0.0%) gen-series! ...ious-cleanup/src/mainloop.rkt:153:0 for-loop [29] 100.0% ------------------------------------------------------------------- run-iter! [19] 100.0% [24] 902(12.1%) 0(0.0%) gen-rewrites! ...us-cleanup/src/mainloop.rkt:176:0 for-loop [30] 66.5% for-loop [33] 33.5% ------------------------------------------------------------------- prepare-points [20] 100.0% [25] 308(4.1%) 0(0.0%) loop ...erbie/various-cleanup/src/points.rkt:143:4 loop [32] 100.0% ------------------------------------------------------------------- run-iter! [19] 100.0% [26] 300(4.0%) 0(0.0%) localize! ...arious-cleanup/src/mainloop.rkt:120:0 localize-error [34] 100.0% ------------------------------------------------------------------- ??? [21] 100.0% [27] 300(4.0%) 0(0.0%) atab-add-altns ...anup/src/core/alt-table.rkt:50:0 atab-add-altn [35] 100.0% ------------------------------------------------------------------- simplify! [22] 100.0% [28] 2776(37.4%) 0(0.0%) ??? .../various-cleanup/src/core/simplify.rkt:26:0 for-loop [37] 56.8% one-iter [45] 21.6% loop [44] 21.6% ------------------------------------------------------------------- gen-series! [23] 100.0% [29] 2512(33.8%) 0(0.0%) for-loop ...various-cleanup/src/mainloop.rkt:160:7 taylor-alt [36] 100.0% ------------------------------------------------------------------- gen-rewrites! [24] 100.0% [30] 600(8.1%) 0(0.0%) for-loop ...arious-cleanup/src/mainloop.rkt:184:11 rewrite-expression-head20 [38]100.0% ------------------------------------------------------------------- for-loop [31] 50.0% simplify! [22] 50.0% [31] 326(4.4%) 0(0.0%) for-loop ...various-cleanup/src/mainloop.rkt:244:6 for-loop [31] 50.0% ??? [49] 50.0% ------------------------------------------------------------------- loop [25] 100.0% [32] 308(4.1%) 0(0.0%) loop ...erbie/various-cleanup/src/points.rkt:102:2 ??? [39] 100.0% ------------------------------------------------------------------- gen-rewrites! [24] 100.0% [33] 302(4.1%) 0(0.0%) for-loop ...various-cleanup/src/mainloop.rkt:201:4 for-loop [40] 100.0% ------------------------------------------------------------------- localize! [26] 100.0% [34] 300(4.0%) 0(0.0%) localize-error ...eanup/src/core/localize.rkt:57:0 ??? [41] 100.0% ------------------------------------------------------------------- atab-add-altns [27] 100.0% [35] 300(4.0%) 0(0.0%) atab-add-altn ...anup/src/core/alt-table.rkt:202:0 errors [42] 100.0% ------------------------------------------------------------------- for-loop [29] 100.0% [36] 2512(33.8%) 0(0.0%) taylor-alt ...rious-cleanup/src/mainloop.rkt:139:0 for-loop [43] 100.0% ------------------------------------------------------------------- ??? [28] 100.0% [37] 1576(21.2%) 0(0.0%) for-loop ...ous-cleanup/src/core/simplify.rkt:35:2 loop [44] 58.4% one-iter [45] 41.6% ------------------------------------------------------------------- for-loop [30] 100.0% [38] 600(8.1%) 0(0.0%) rewrite-expression-head20 ...core/matcher.rkt:87:0 rewriter [46] 100.0% ------------------------------------------------------------------- loop [32] 100.0% [39] 308(4.1%) 0(0.0%) ??? ...erbie/various-cleanup/src/programs.rkt:99:2 ??? [47] 100.0% ------------------------------------------------------------------- for-loop [33] 100.0% [40] 302(4.1%) 0(0.0%) for-loop ...various-cleanup/src/mainloop.rkt:202:6 ??? [49] 100.0% ------------------------------------------------------------------- localize-error [34] 100.0% [41] 300(4.0%) 0(0.0%) ??? ...-7.0/collects/racket/private/sort.rkt:369:3 generic-sort/key [48] 100.0% ------------------------------------------------------------------- atab-add-altn [35] 100.0% [42] 300(4.0%) 0(0.0%) errors ...bie/various-cleanup/src/points.rkt:223:0 eval-prog [92] 100.0% ------------------------------------------------------------------- taylor-alt [36] 100.0% [43] 2512(33.8%) 0(0.0%) for-loop ...various-cleanup/src/mainloop.rkt:145:6 ??? [49] 100.0% ------------------------------------------------------------------- ??? [28] 39.5% for-loop [37] 60.5% [44] 1520(20.5%) 0(0.0%) loop ...arious-cleanup/src/core/simplify.rkt:158:2 for-loop [50] 80.3% debug-print [86] 19.7% ------------------------------------------------------------------- ??? [28] 47.8% for-loop [37] 52.2% [45] 1256(16.9%) 0(0.0%) one-iter ...ous-cleanup/src/core/simplify.rkt:92:0 find-matches [51] 76.1% for-loop [55] 23.9% ------------------------------------------------------------------- rewrite-expression-head20 [38]100.0% [46] 600(8.1%) 0(0.0%) rewriter ...ious-cleanup/src/core/matcher.rkt:90:2 for-loop [52] 100.0% ------------------------------------------------------------------- ??? [39] 100.0% [47] 308(4.1%) 0(0.0%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 ??? [53] 100.0% ------------------------------------------------------------------- ??? [41] 100.0% [48] 300(4.0%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:156:2 errors-score [54] 100.0% ------------------------------------------------------------------- ??? [81] 6.7% for-loop [40] 9.6% for-loop [31] 10.4% location-do [56] 36.7% for-loop [43] 36.7% [49] 3140(42.3%) 302(4.1%) ??? ...tract/private/arrow-higher-order.rkt:357:33 location-do [56] 36.7% approximate9 [57] 36.7% ??? [98] 10.4% hash-ref! [76] 6.7% ------------------------------------------------------------------- loop [44] 100.0% [50] 1220(16.4%) 300(4.0%) for-loop ...us-cleanup/src/core/simplify.rkt:162:4 argmin [59] 50.0% loop [61] 25.4% ------------------------------------------------------------------- one-iter [45] 100.0% [51] 956(12.9%) 0(0.0%) find-matches ...cleanup/src/core/simplify.rkt:62:0 for-loop [58] 100.0% ------------------------------------------------------------------- rewriter [46] 100.0% [52] 600(8.1%) 0(0.0%) for-loop ...ious-cleanup/src/core/matcher.rkt:92:4 matcher [60] 100.0% ------------------------------------------------------------------- ??? [47] 100.0% [53] 308(4.1%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-and [62] 100.0% ------------------------------------------------------------------- generic-sort/key [48] 100.0% [54] 300(4.0%) 0(0.0%) errors-score ...rious-cleanup/src/points.rkt:215:0 loop [63] 100.0% ------------------------------------------------------------------- one-iter [45] 100.0% [55] 300(4.0%) 0(0.0%) for-loop ...us-cleanup/src/core/simplify.rkt:101:2 loop [64] 100.0% ------------------------------------------------------------------- ??? [49] 46.4% location-do [56] 53.6% [56] 2512(33.8%) 0(0.0%) location-do ...rious-cleanup/src/programs.rkt:64:0 location-do [56] 53.6% ??? [49] 46.4% ------------------------------------------------------------------- ??? [49] 100.0% [57] 2512(33.8%) 0(0.0%) approximate9 ...s-cleanup/src/core/taylor.rkt:12:0 for-loop [65] 50.9% loop [66] 25.0% taylor [71] 24.1% ------------------------------------------------------------------- for-loop [58] 50.0% find-matches [51] 50.0% [58] 956(12.9%) 300(4.0%) for-loop ...ous-cleanup/src/core/simplify.rkt:64:8 for-loop [58] 50.0% match-e [72] 34.3% ------------------------------------------------------------------- for-loop [50] 100.0% [59] 610(8.2%) 0(0.0%) argmin ...acket-7.0/collects/racket/list.rkt:765:0 expression-cost [67] 100.0% ------------------------------------------------------------------- for-loop [52] 100.0% [60] 600(8.1%) 0(0.0%) matcher ...ious-cleanup/src/core/matcher.rkt:118:2 ??? [68] 100.0% ------------------------------------------------------------------- for-loop [50] 100.0% [61] 310(4.2%) 0(0.0%) loop .../racket-7.0/collects/racket/list.rkt:751:4 for-loop [69] 100.0% ------------------------------------------------------------------- ??? [53] 100.0% [62] 308(4.1%) 308(4.1%) ival-and ...ious-cleanup/src/biginterval.rkt:264:0 ------------------------------------------------------------------- errors-score [54] 100.0% [63] 300(4.0%) 300(4.0%) loop .../racket-7.0/collects/racket/list.rkt:559:2 ------------------------------------------------------------------- for-loop [55] 100.0% [64] 300(4.0%) 0(0.0%) loop ...arious-cleanup/src/core/simplify.rkt:106:4 apply-match [70] 100.0% ------------------------------------------------------------------- approximate9 [57] 100.0% [65] 1278(17.2%) 0(0.0%) for-loop ...ious-cleanup/src/core/taylor.rkt:30:18 taylor [71] 73.9% taylor-sqrt [75] 26.1% ------------------------------------------------------------------- approximate9 [57] 100.0% [66] 628(8.5%) 0(0.0%) loop ...e/various-cleanup/src/core/taylor.rkt:87:4 hash-ref! [76] 100.0% ------------------------------------------------------------------- argmin [59] 100.0% [67] 610(8.2%) 0(0.0%) expression-cost ...-cleanup/src/programs.rkt:157:0 compile [73] 100.0% ------------------------------------------------------------------- matcher [60] 100.0% [68] 600(8.1%) 0(0.0%) ??? ...various-cleanup/src/core/matcher.rkt:130:11 for-loop [74] 100.0% ------------------------------------------------------------------- loop [61] 100.0% [69] 310(4.2%) 310(4.2%) for-loop ...various-cleanup/src/programs.rkt:158:2 ------------------------------------------------------------------- loop [64] 100.0% [70] 300(4.0%) 0(0.0%) apply-match ...-cleanup/src/core/simplify.rkt:71:0 match-e [72] 100.0% ------------------------------------------------------------------- map [78] 3.8% approximate9 [57] 8.8% for-loop [65] 25.7% taylor [71] 61.7% [71] 1550(20.9%) 0(0.0%) taylor ...arious-cleanup/src/core/taylor.rkt:170:0 taylor [71] 61.7% map [78] 23.0% taylor-invert [3] 7.4% loop [7] 5.0% debug-print [86] 2.9% ------------------------------------------------------------------- apply-match [70] 10.5% for-loop [12] 37.9% for-loop [58] 51.7% [72] 956(12.9%) 656(8.8%) match-e ...arious-cleanup/src/core/ematch.rkt:39:0 for-loop [5] 37.9% constant? [79] 10.5% ------------------------------------------------------------------- expression-cost [67] 100.0% [73] 610(8.2%) 0(0.0%) compile .../various-cleanup/src/programs.rkt:134:0 hash-ref! [76] 100.0% ------------------------------------------------------------------- ??? [68] 100.0% [74] 600(8.1%) 0(0.0%) for-loop ...ous-cleanup/src/core/matcher.rkt:106:4 foldl [77] 100.0% ------------------------------------------------------------------- for-loop [65] 100.0% [75] 334(4.5%) 0(0.0%) taylor-sqrt ...s-cleanup/src/core/taylor.rkt:352:0 hash-ref! [76] 100.0% ------------------------------------------------------------------- ??? [83] 2.5% ??? [14] 2.5% ??? [4] 2.7% ??? [81] 2.7% for-loop [13] 5.0% ??? [49] 5.2% loop [66] 5.2% taylor-sqrt [75] 7.6% compile [73] 8.1% for-loop [10] 10.3% ??? [82] 19.6% first-nonzero-exp [11] 28.7% [76] 2204(29.7%) 610(8.2%) hash-ref! .../racket/private/more-scheme.rkt:376:2 simplify [80] 41.5% ??? [82] 19.6% ??? [2] 10.3% ??? [81] 7.9% ??? [4] 5.2% ??? [6] 5.0% ??? [83] 2.5% ------------------------------------------------------------------- for-loop [74] 100.0% [77] 600(8.1%) 300(4.0%) foldl ....0/collects/racket/private/list.rkt:229:4 ??? [85] 50.0% ------------------------------------------------------------------- taylor [71] 100.0% [78] 594(8.0%) 298(4.0%) map ...t-7.0/collects/racket/private/map.rkt:35:13 taylor [71] 49.8% ------------------------------------------------------------------- match-e [72] 100.0% [79] 300(4.0%) 0(0.0%) constant? ...s-cleanup/src/syntax/syntax.rkt:721:0 value? [84] 100.0% ------------------------------------------------------------------- loop [7] 16.3% hash-ref! [76] 83.7% [80] 1904(25.6%) 0(0.0%) simplify ...rious-cleanup/src/core/reduce.rkt:16:0 debug-print [86] 33.9% f67 [87] 33.3% parse-loop80 [88] 32.8% ------------------------------------------------------------------- hash-ref! [76] 100.0% [81] 628(8.5%) 0(0.0%) ??? ...e/various-cleanup/src/core/taylor.rkt:68:15 ??? [49] 76.1% hash-ref! [76] 23.9% ------------------------------------------------------------------- hash-ref! [76] 100.0% [82] 610(8.2%) 0(0.0%) ??? ...rbie/various-cleanup/src/programs.rkt:142:5 hash-ref! [76] 100.0% ------------------------------------------------------------------- hash-ref! [76] 100.0% [83] 328(4.4%) 0(0.0%) ??? .../various-cleanup/src/core/taylor.rkt:328:33 hash-ref! [76] 100.0% ------------------------------------------------------------------- constant? [79] 100.0% [84] 300(4.0%) 300(4.0%) value? ...arious-cleanup/src/syntax/types.rkt:18:0 ------------------------------------------------------------------- foldl [77] 100.0% [85] 300(4.0%) 300(4.0%) ??? ...e/various-cleanup/src/core/matcher.rkt:26:7 ------------------------------------------------------------------- loop [44] 23.9% taylor [71] 24.7% simplify [80] 51.4% [86] 1256(16.9%) 0(0.0%) debug-print ...various-cleanup/src/debug.rkt:110:0 ??? [90] 76.1% for-loop [91] 23.9% ------------------------------------------------------------------- simplify [80] 100.0% [87] 634(8.5%) 0(0.0%) f67 ...0/collects/racket/match/compiler.rkt:507:40 eval-const-expr [89] 100.0% ------------------------------------------------------------------- simplify [80] 100.0% [88] 624(8.4%) 0(0.0%) parse-loop80 ...s/racket/match/compiler.rkt:418:15 eval-const-expr [89] 100.0% ------------------------------------------------------------------- parse-loop80 [88] 49.6% f67 [87] 50.4% [89] 1258(16.9%) 0(0.0%) eval-const-expr ...-cleanup/src/programs.rkt:102:0 eval-prog [92] 100.0% ------------------------------------------------------------------- debug-print [86] 100.0% [90] 956(12.9%) 310(4.2%) ??? .../contract/private/arrow-val-first.rkt:428:3 mk-call [93] 35.1% keyword-apply [94] 32.4% ------------------------------------------------------------------- debug-print [86] 100.0% [91] 300(4.0%) 300(4.0%) for-loop ...ie/various-cleanup/src/debug.rkt:116:2 ------------------------------------------------------------------- errors [42] 19.3% eval-const-expr [89] 80.7% [92] 1558(21.0%) 0(0.0%) eval-prog ...various-cleanup/src/programs.rkt:83:0 temp68_2 [95] 100.0% ------------------------------------------------------------------- ??? [90] 100.0% [93] 336(4.5%) 0(0.0%) mk-call ...tract/private/arrow-val-first.rkt:431:5 loop [96] 100.0% ------------------------------------------------------------------- ??? [90] 100.0% [94] 310(4.2%) 310(4.2%) keyword-apply ...lects/racket/private/kw.rkt:421:2 ------------------------------------------------------------------- eval-prog [92] 100.0% [95] 1558(21.0%) 0(0.0%) temp68_2 (unknown source) compile16 [97] 100.0% ------------------------------------------------------------------- mk-call [93] 100.0% [96] 336(4.5%) 0(0.0%) loop ...contract/private/arrow-val-first.rkt:435:8 ??? [98] 100.0% ------------------------------------------------------------------- temp68_2 [95] 100.0% [97] 1558(21.0%) 0(0.0%) compile16 (unknown source) temp74_0 [99] 100.0% ------------------------------------------------------------------- ??? [49] 49.2% loop [96] 50.8% [98] 662(8.9%) 336(4.5%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ??? [100] 49.2% ------------------------------------------------------------------- compile16 [97] 100.0% [99] 1558(21.0%) 0(0.0%) temp74_0 (unknown source) expand-single [101] 100.0% ------------------------------------------------------------------- ??? [98] 100.0% [100] 326(4.4%) 0(0.0%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ??? [102] 100.0% ------------------------------------------------------------------- temp74_0 [99] 100.0% [101] 1558(21.0%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [103] 100.0% ------------------------------------------------------------------- ??? [100] 100.0% [102] 326(4.4%) 326(4.4%) ??? ...ects/racket/contract/private/list.rkt:163:5 ------------------------------------------------------------------- expand-single [101] 100.0% [103] 1558(21.0%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [104] 100.0% ------------------------------------------------------------------- expand-capturing-lifts [103] 100.0% [104] 1558(21.0%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [105] 100.0% ------------------------------------------------------------------- lambda-clause-expander [104] 39.1% for-loop [106] 60.9% [105] 1558(21.0%) 0(0.0%) finish-bodys (unknown source) for-loop [106] 100.0% ------------------------------------------------------------------- for-loop [106] 23.2% finish-bodys [105] 76.8% [106] 1558(21.0%) 596(8.0%) for-loop (unknown source) finish-bodys [105] 50.4% for-loop [106] 23.2% syntax-e [108] 4.2% dispatch-variable [109] 3.2% expand-implicit [107] 3.1% ------------------------------------------------------------------- for-loop [106] 100.0% [107] 334(4.5%) 334(4.5%) expand-implicit (unknown source) ------------------------------------------------------------------- for-loop [106] 100.0% [108] 328(4.4%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [110] 100.0% ------------------------------------------------------------------- for-loop [106] 100.0% [109] 300(4.0%) 300(4.0%) dispatch-variable (unknown source) ------------------------------------------------------------------- syntax-e [108] 100.0% [110] 328(4.4%) 0(0.0%) syntax-e/no-taint (unknown source) loop [111] 100.0% ------------------------------------------------------------------- syntax-e/no-taint [110] 100.0% [111] 328(4.4%) 0(0.0%) loop (unknown source) gf [112] 100.0% ------------------------------------------------------------------- loop [111] 100.0% [112] 328(4.4%) 328(4.4%) gf (unknown source) -------------------------------------------------------------------