Profiling results ----------------- Total cpu time observed: 130396ms (out of 134352ms) Number of samples taken: 302 (once every 432ms) ========================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================= run [14] 50.0% [1] 130074(99.8%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [7] 50.0% loop [15] 43.4% run-improve50 [9] 6.6% ------------------------------------------------------------------------- loop [42] 0.3% for-loop [77] 0.6% loop [79] 99.1% [2] 114470(87.8%) 0(0.0%) ??? ...acts-precision-steps/src/programs.rkt:154:4 ??? [8] 100.0% ------------------------------------------------------------------------- ??? [86] 100.0% [3] 6438(4.9%) 0(0.0%) iterate-egraph!13 ...s/src/core/simplify.rkt:102:0 one-iter [10] 94.3% map-enodes [12] 5.7% ------------------------------------------------------------------------- ??? [86] 100.0% [4] 1366(1.0%) 0(0.0%) loop ...recision-steps/src/core/simplify.rkt:215:2 pass [11] 100.0% ------------------------------------------------------------------------- parse-loop12 [74] 1.2% loop [5] 98.8% [5] 752(0.6%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:36:19 loop [5] 98.8% ??? [48] 0.6% f137 [21] 0.6% ------------------------------------------------------------------------- loop [79] 100.0% [6] 364(0.3%) 0(0.0%) for-loop ...sion-steps/src/core/simplify.rkt:173:2 eval-const-expr [13] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [7] 130074(99.8%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [14] 100.0% ------------------------------------------------------------------------- ??? [2] 100.0% [8] 114470(87.8%) 7356(5.6%) ??? ...acket/collects/racket/private/kw.rkt:444:14 bf-complex-mult [16] 84.0% bf-complex-add [17] 8.0% ??? [23] 1.6% ------------------------------------------------------------------------- ??? [1] 100.0% [9] 17200(13.2%) 0(0.0%) run-improve50 ...sion-steps/src/mainloop.rkt:234:0 setup-alt-simplified [18] 41.6% loop [15] 39.6% for-loop [22] 11.1% get-final-combination [25] 3.8% ??? [36] 2.1% setup-prog [26] 1.8% ------------------------------------------------------------------------- iterate-egraph!13 [3] 100.0% [10] 6074(4.7%) 0(0.0%) one-iter ...sion-steps/src/core/simplify.rkt:113:0 for-loop [19] 61.8% loop [20] 38.2% ------------------------------------------------------------------------- loop [4] 100.0% [11] 1366(1.0%) 0(0.0%) pass ...recision-steps/src/core/simplify.rkt:205:2 for-loop [24] 100.0% ------------------------------------------------------------------------- iterate-egraph!13 [3] 100.0% [12] 364(0.3%) 0(0.0%) map-enodes ...sion-steps/src/core/egraph.rkt:139:0 loop [79] 100.0% ------------------------------------------------------------------------- for-loop [6] 100.0% [13] 364(0.3%) 0(0.0%) eval-const-expr ...on-steps/src/programs.rkt:166:0 f137 [21] 100.0% ------------------------------------------------------------------------- profile-thunk16 [7] 100.0% [14] 130074(99.8%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------- run-improve50 [9] 5.7% ??? [1] 94.3% [15] 119680(91.8%) 0(0.0%) loop ...xacts-precision-steps/src/points.rkt:202:2 loop [27] 48.5% make-exacts* [41] 26.1% loop [42] 25.4% ------------------------------------------------------------------------- parse-loop12 [74] 0.4% loop [79] 0.4% ??? [8] 99.2% [16] 96964(74.4%) 3592(2.8%) bf-complex-mult ...n-steps/src/bigcomplex.rkt:33:0 bf* [28] 57.0% ??? [40] 35.8% ...higher-order.rkt:346:33 [30] 3.6% ------------------------------------------------------------------------- ??? [8] 100.0% [17] 9144(7.0%) 0(0.0%) bf-complex-add ...on-steps/src/bigcomplex.rkt:22:0 ??? [40] 88.2% ...higher-order.rkt:346:33 [30] 11.8% ------------------------------------------------------------------------- run-improve50 [9] 100.0% [18] 7154(5.5%) 0(0.0%) setup-alt-simplified ...on-steps/src/glue.rkt:49:0 simplify-alt [29] 100.0% ------------------------------------------------------------------------- for-loop [19] 50.0% one-iter [10] 50.0% [19] 3754(2.9%) 334(0.3%) for-loop ...ion-steps/src/core/simplify.rkt:123:12 for-loop [19] 50.0% rule-valid-at-type? [31] 45.6% ------------------------------------------------------------------------- one-iter [10] 100.0% [20] 2320(1.8%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [32] 100.0% ------------------------------------------------------------------------- loop [5] 7.9% eval-const-expr [13] 16.0% hash-ref! [67] 76.1% [21] 2274(1.7%) 0(0.0%) f137 .../collects/racket/match/compiler.rkt:507:40 map [34] 76.1% ...steps/src/common.rkt:47:2 [87] 16.0% ??? [37] 7.9% ------------------------------------------------------------------------- run-improve50 [9] 100.0% [22] 1910(1.5%) 0(0.0%) for-loop ...recision-steps/src/mainloop.rkt:249:10 run-iter! [33] 100.0% ------------------------------------------------------------------------- ??? [8] 100.0% [23] 1778(1.4%) 1778(1.4%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ------------------------------------------------------------------------- pass [11] 100.0% [24] 1366(1.0%) 0(0.0%) for-loop ...ion-steps/src/core/simplify.rkt:208:29 argmin [35] 76.4% loop [39] 23.6% ------------------------------------------------------------------------- run-improve50 [9] 100.0% [25] 650(0.5%) 0(0.0%) get-final-combination ...ps/src/mainloop.rkt:264:0 ??? [48] 50.5% extract-alt [38] 49.5% ------------------------------------------------------------------------- run-improve50 [9] 100.0% [26] 312(0.2%) 0(0.0%) setup-prog ...ts-precision-steps/src/glue.rkt:40:0 ??? [36] 100.0% ------------------------------------------------------------------------- loop [15] 100.0% [27] 58062(44.5%) 0(0.0%) loop ...xacts-precision-steps/src/points.rkt:158:2 make-exacts* [41] 55.8% loop [42] 44.2% ------------------------------------------------------------------------- bf-complex-mult [16] 100.0% [28] 55224(42.4%) 1130(0.9%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [40] 98.0% ------------------------------------------------------------------------- setup-alt-simplified [18] 100.0% [29] 7154(5.5%) 0(0.0%) simplify-alt ...-precision-steps/src/glue.rkt:76:0 ??? [86] 100.0% ------------------------------------------------------------------------- bf-complex-add [17] 23.7% bf-complex-mult [16] 76.3% [30] 4548(3.5%) 734(0.6%) ...higher-order.rkt:346:33 (unknown source) ??? [43] 83.9% ------------------------------------------------------------------------- for-loop [19] 100.0% [31] 3420(2.6%) 1716(1.3%) rule-valid-at-type? .../src/syntax/rules.rkt:487:0 for-loop [46] 49.8% ------------------------------------------------------------------------- loop [20] 100.0% [32] 2320(1.8%) 0(0.0%) apply-match ...n-steps/src/core/simplify.rkt:130:2 for-loop [47] 71.6% update-leader! [50] 28.4% ------------------------------------------------------------------------- for-loop [22] 100.0% [33] 1910(1.5%) 0(0.0%) run-iter! ...recision-steps/src/mainloop.rkt:215:0 localize-error [45] 100.0% ------------------------------------------------------------------------- ??? [44] 10.1% f137 [21] 89.9% [34] 1910(1.5%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 ??? [44] 89.9% ??? [48] 10.1% ------------------------------------------------------------------------- for-loop [24] 100.0% [35] 1044(0.8%) 0(0.0%) argmin ...re/racket/collects/racket/list.rkt:743:0 for-loop [49] 68.8% expression-cost [53] 31.2% ------------------------------------------------------------------------- setup-prog [26] 45.9% run-improve50 [9] 54.1% [36] 680(0.5%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:357:18 atab-add-altns [51] 54.1% make-alt-table [55] 45.9% ------------------------------------------------------------------------- f137 [21] 100.0% [37] 358(0.3%) 0(0.0%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [52] 100.0% ------------------------------------------------------------------------- get-final-combination [25] 100.0% [38] 322(0.2%) 0(0.0%) extract-alt ...s-precision-steps/src/glue.rkt:55:0 argmins [54] 100.0% ------------------------------------------------------------------------- for-loop [24] 100.0% [39] 322(0.2%) 0(0.0%) loop ...hare/racket/collects/racket/list.rkt:729:4 for-loop [49] 100.0% ------------------------------------------------------------------------- bf-complex-add [17] 8.3% bf-complex-mult [16] 35.8% bf* [28] 55.9% [40] 96838(74.3%) 7510(5.8%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [56] 79.5% bfneg [57] 12.7% ------------------------------------------------------------------------- loop [15] 49.1% loop [27] 50.9% [41] 63620(48.8%) 0(0.0%) make-exacts* ...ecision-steps/src/points.rkt:138:0 loop [79] 90.8% eval-prog [58] 9.2% ------------------------------------------------------------------------- loop [27] 45.8% loop [15] 54.2% [42] 56060(43.0%) 0(0.0%) loop ...xacts-precision-steps/src/points.rkt:141:4 loop [79] 99.3% ??? [2] 0.7% ------------------------------------------------------------------------- ??? [88] 16.1% ...higher-order.rkt:346:33 [30] 83.9% [43] 4544(3.5%) 2688(2.1%) ??? ...cts/racket/contract/private/list.rkt:187:10 ??? [60] 24.8% ??? [88] 8.1% for-loop [63] 8.0% ------------------------------------------------------------------------- map [34] 14.4% loop [79] 85.6% [44] 1910(1.5%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [67] 98.0% map [34] 2.0% ------------------------------------------------------------------------- run-iter! [33] 100.0% [45] 1910(1.5%) 0(0.0%) localize-error ...steps/src/core/localize.rkt:47:0 hash-ref! [67] 100.0% ------------------------------------------------------------------------- rule-valid-at-type? [31] 100.0% [46] 1704(1.3%) 1704(1.3%) for-loop ...ts-precision-steps/src/common.rkt:99:9 ------------------------------------------------------------------------- apply-match [32] 100.0% [47] 1662(1.3%) 0(0.0%) for-loop ...ion-steps/src/core/simplify.rkt:145:10 substitute-e [59] 81.8% mk-enode! [68] 18.2% ------------------------------------------------------------------------- get-final-combination [25] 29.6% map [34] 34.8% loop [5] 35.6% [48] 1108(0.8%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ??? [86] 100.0% ------------------------------------------------------------------------- loop [39] 31.0% argmin [35] 69.0% [49] 1040(0.8%) 0(0.0%) for-loop ...precision-steps/src/programs.rkt:199:2 ??? [86] 65.4% ...steps/src/common.rkt:47:2 [87] 34.6% ------------------------------------------------------------------------- apply-match [32] 100.0% [50] 658(0.5%) 0(0.0%) update-leader! ...-steps/src/core/egraph.rkt:217:0 for-loop [61] 100.0% ------------------------------------------------------------------------- ??? [36] 100.0% [51] 368(0.3%) 0(0.0%) atab-add-altns ...teps/src/core/alt-table.rkt:50:0 atab-add-altn [62] 100.0% ------------------------------------------------------------------------- ??? [37] 100.0% [52] 358(0.3%) 358(0.3%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ------------------------------------------------------------------------- argmin [35] 100.0% [53] 326(0.3%) 0(0.0%) expression-cost ...on-steps/src/programs.rkt:198:0 compile [64] 100.0% ------------------------------------------------------------------------- extract-alt [38] 100.0% [54] 322(0.2%) 0(0.0%) argmins ...ts-precision-steps/src/common.rkt:150:0 composed [65] 100.0% ------------------------------------------------------------------------- ??? [36] 100.0% [55] 312(0.2%) 0(0.0%) make-alt-table ...teps/src/core/alt-table.rkt:32:0 errors [70] 100.0% ------------------------------------------------------------------------- ??? [40] 100.0% [56] 77024(59.1%) 52044(39.9%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [66] 32.4% ------------------------------------------------------------------------- ??? [40] 100.0% [57] 12304(9.4%) 8800(6.7%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:616:4 ??? [66] 28.5% ------------------------------------------------------------------------- make-exacts* [41] 100.0% [58] 5844(4.5%) 0(0.0%) eval-prog ...recision-steps/src/programs.rkt:148:0 hash-ref! [67] 100.0% ------------------------------------------------------------------------- substitute-e [59] 12.3% for-loop [47] 87.7% [59] 1360(1.0%) 0(0.0%) substitute-e ...ion-steps/src/core/ematch.rkt:71:0 mk-enode! [68] 87.7% substitute-e [59] 12.3% ------------------------------------------------------------------------- ??? [43] 100.0% [60] 1126(0.9%) 1126(0.9%) ??? ...ects/racket/contract/private/guts.rkt:644:8 ------------------------------------------------------------------------- update-leader! [50] 100.0% [61] 658(0.5%) 0(0.0%) for-loop ...cision-steps/src/core/egraph.rkt:222:6 for-loop [69] 100.0% ------------------------------------------------------------------------- atab-add-altns [51] 100.0% [62] 368(0.3%) 0(0.0%) atab-add-altn ...teps/src/core/alt-table.rkt:208:0 best-and-tied-at-points [71] 100.0% ------------------------------------------------------------------------- ??? [43] 100.0% [63] 364(0.3%) 0(0.0%) for-loop ...acket/contract/private/list.rkt:190:15 ??? [88] 100.0% ------------------------------------------------------------------------- expression-cost [53] 100.0% [64] 326(0.3%) 0(0.0%) compile ...-precision-steps/src/programs.rkt:175:0 hash-ref! [67] 100.0% ------------------------------------------------------------------------- argmins [54] 100.0% [65] 322(0.2%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 errors [70] 100.0% ------------------------------------------------------------------------- bfneg [57] 12.3% bfmul [56] 87.7% [66] 28484(21.8%) 28484(21.8%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ------------------------------------------------------------------------- ??? [73] 2.0% compile [64] 2.0% localize-error [45] 3.0% eval-prog [58] 17.1% ??? [44] 20.7% loop [79] 55.2% [67] 8080(6.2%) 326(0.3%) hash-ref! ...racket/private/more-scheme.rkt:373:13 ??? [73] 57.3% parse-loop12 [74] 20.7% bigfloat-hash [72] 17.1% f137 [21] 3.0% ------------------------------------------------------------------------- for-loop [47] 18.2% substitute-e [59] 81.8% [68] 1662(1.3%) 334(0.3%) mk-enode! ...ision-steps/src/core/egraph.rkt:101:0 new-enode [75] 79.9% ------------------------------------------------------------------------- for-loop [61] 100.0% [69] 658(0.5%) 0(0.0%) for-loop ...cision-steps/src/core/egraph.rkt:223:8 hash-update! [76] 100.0% ------------------------------------------------------------------------- make-alt-table [55] 49.2% composed [65] 50.8% [70] 634(0.5%) 0(0.0%) errors ...cts-precision-steps/src/points.rkt:237:0 for-loop [77] 100.0% ------------------------------------------------------------------------- atab-add-altn [62] 100.0% [71] 368(0.3%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:122:0 for-loop [78] 100.0% ------------------------------------------------------------------------- hash-ref! [67] 100.0% [72] 5844(4.5%) 346(0.3%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:165:0 bfcanonicalize [80] 47.8% sig+exp->bigfloat [81] 46.3% ------------------------------------------------------------------------- hash-ref! [67] 100.0% [73] 5482(4.2%) 0(0.0%) ??? ...acts-precision-steps/src/programs.rkt:183:5 loop [79] 94.1% hash-ref! [67] 5.9% ------------------------------------------------------------------------- hash-ref! [67] 100.0% [74] 1910(1.5%) 0(0.0%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 loop [79] 90.5% loop [5] 7.3% bf-complex-mult [16] 2.2% ------------------------------------------------------------------------- mk-enode! [68] 100.0% [75] 1328(1.0%) 0(0.0%) new-enode ...ecision-steps/src/core/enode.rkt:97:0 type-of-enode-expr [82] 100.0% ------------------------------------------------------------------------- for-loop [69] 100.0% [76] 658(0.5%) 0(0.0%) hash-update! ...ket/private/more-scheme.rkt:362:13 ??? [83] 100.0% ------------------------------------------------------------------------- errors [70] 100.0% [77] 634(0.5%) 0(0.0%) for-loop ...s-precision-steps/src/points.rkt:240:4 ??? [2] 100.0% ------------------------------------------------------------------------- best-and-tied-at-points [71] 100.0% [78] 368(0.3%) 368(0.3%) for-loop ...on-steps/src/core/alt-table.rkt:124:16 ------------------------------------------------------------------------- map-enodes [12] 0.0% make-exacts* [41] 0.3% loop [42] 0.6% parse-loop12 [74] 1.1% ??? [73] 4.3% loop [79] 93.8% [79] 120896(92.7%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [79] 93.8% hash-ref! [67] 4.3% ??? [44] 1.0% ??? [2] 0.9% bf-complex-mult [16] 0.0% for-loop [6] 0.0% ------------------------------------------------------------------------- bigfloat-hash [72] 100.0% [80] 2794(2.1%) 2794(2.1%) bfcanonicalize .../private/bigfloat/mpfr.rkt:155:0 ------------------------------------------------------------------------- bigfloat-hash [72] 100.0% [81] 2704(2.1%) 2704(2.1%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:385:0 ------------------------------------------------------------------------- new-enode [75] 100.0% [82] 1328(1.0%) 0(0.0%) type-of-enode-expr ...teps/src/core/enode.rkt:68:0 get-sigs [84] 100.0% ------------------------------------------------------------------------- hash-update! [76] 100.0% [83] 658(0.5%) 0(0.0%) ??? ...-precision-steps/src/core/egraph.rkt:225:24 for-loop [85] 100.0% ------------------------------------------------------------------------- type-of-enode-expr [82] 100.0% [84] 1328(1.0%) 0(0.0%) get-sigs ...precision-steps/src/type-check.rkt:5:0 ...steps/src/common.rkt:47:2 [87] 52.6% ??? [86] 47.4% ------------------------------------------------------------------------- ??? [83] 100.0% [85] 658(0.5%) 658(0.5%) for-loop ...ision-steps/src/core/egraph.rkt:226:26 ------------------------------------------------------------------------- get-sigs [84] 2.4% for-loop [49] 2.6% ??? [48] 11.0% simplify-alt [29] 39.8% ??? [86] 42.9% [86] 8584(6.6%) 1024(0.8%) ??? ...llects/racket/private/norm-define.rkt:53:83 ??? [86] 42.9% iterate-egraph!13 [3] 36.3% loop [4] 6.6% return/no-unsupplied [90] 4.5% ??? [89] 2.6% ------------------------------------------------------------------------- for-loop [49] 25.3% f137 [21] 25.6% get-sigs [84] 49.1% [87] 1422(1.1%) 692(0.5%) ...steps/src/common.rkt:47:2 ...e/arr-i.rkt:906:19 ??? [88] 51.3% ------------------------------------------------------------------------- for-loop [63] 24.9% ??? [43] 25.1% ...steps/src/common.rkt:47:2 [87] 50.0% [88] 730(0.6%) 730(0.6%) ??? ...ects/racket/contract/private/list.rkt:342:4 ??? [43] 50.0% ------------------------------------------------------------------------- ??? [86] 100.0% [89] 680(0.5%) 358(0.3%) ??? ...ects/racket/contract/private/list.rkt:737:4 for-loop [92] 47.4% ------------------------------------------------------------------------- ??? [86] 100.0% [90] 386(0.3%) 0(0.0%) return/no-unsupplied ...ct/private/arr-i.rkt:533:0 filter [91] 100.0% ------------------------------------------------------------------------- return/no-unsupplied [90] 100.0% [91] 386(0.3%) 386(0.3%) filter ...t/collects/racket/private/list.rkt:256:2 ------------------------------------------------------------------------- ??? [89] 100.0% [92] 322(0.2%) 0(0.0%) for-loop ...acket/contract/private/list.rkt:743:12 ??? [93] 100.0% ------------------------------------------------------------------------- for-loop [92] 100.0% [93] 322(0.2%) 322(0.2%) ??? ...private/unconstrained-domain-arrow.rkt:74:4 -------------------------------------------------------------------------