Profiling results ----------------- Total cpu time observed: 643880ms (out of 646524ms) Number of samples taken: 1864 (once every 345ms) (Hiding functions with self<1.0% and local<2.0%: 19 of 211 hidden) ============================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================================== ??? [51] 100.0% [1] 503848(78.3%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [9] 100.0% ------------------------------------------------------------------------------ ??? [51] 100.0% [2] 471046(73.2%) 0(0.0%) run-improve50 ...ng-logging/src/mainloop.rkt:234:0 for-loop [10] 99.3% loop [68] 0.4% setup-alt-simplified [16] 0.3% ------------------------------------------------------------------------------ ??? [114] 100.0% [3] 347848(54.0%) 0(0.0%) iterate-egraph!13 ...g/src/core/simplify.rkt:102:0 one-iter [11] 97.5% map-enodes [15] 2.5% ------------------------------------------------------------------------------ ??? [114] 100.0% [4] 138412(21.5%) 0(0.0%) loop ...mpling-logging/src/core/simplify.rkt:215:2 pass [12] 100.0% ------------------------------------------------------------------------------ rewriter [66] 100.0% [5] 30652(4.8%) 2430(0.4%) *rules* ...ling-logging/src/syntax/rules.rkt:512:0 for-loop [13] 88.8% ormap [24] 3.3% ------------------------------------------------------------------------------ f176 [23] 2.5% for-loop [14] 12.3% rewriter [66] 85.2% [6] 14580(2.3%) 0(0.0%) expression->type ...ogging/src/type-check.rkt:45:0 for-loop [14] 100.0% ------------------------------------------------------------------------------ matcher [97] 100.0% [7] 2418(0.4%) 0(0.0%) for-loop ...ing-logging/src/core/matcher.rkt:159:6 pattern-substitute [17] 56.7% pattern-match [18] 28.5% foldl [160] 14.7% ------------------------------------------------------------------------------ loop [144] 100.0% [8] 2072(0.3%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [117] 72.5% map [109] 27.5% ------------------------------------------------------------------------------ profile-thunk16 [1] 100.0% [9] 503848(78.3%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [51] 100.0% ------------------------------------------------------------------------------ run-improve50 [2] 100.0% [10] 467854(72.7%) 0(0.0%) for-loop ...mpling-logging/src/mainloop.rkt:249:10 run-iter! [19] 100.0% ------------------------------------------------------------------------------ iterate-egraph!13 [3] 100.0% [11] 339170(52.7%) 4810(0.7%) one-iter ...ng-logging/src/core/simplify.rkt:113:0 loop [20] 73.0% for-loop [22] 23.5% apply-match [30] 1.7% ------------------------------------------------------------------------------ loop [4] 100.0% [12] 138412(21.5%) 1064(0.2%) pass ...mpling-logging/src/core/simplify.rkt:205:2 for-loop [21] 99.2% ------------------------------------------------------------------------------ merge-egraph-nodes! [54] 2.5% *rules* [5] 97.5% [13] 27902(4.3%) 7088(1.1%) for-loop ...e/sampling-logging/src/common.rkt:99:9 ormap [24] 62.4% flag-set? [34] 9.6% curry* [78] 1.3% update-en-expr [135] 1.3% ------------------------------------------------------------------------------ expression->type [6] 100.0% [14] 14580(2.3%) 1068(0.2%) for-loop ...mpling-logging/src/type-check.rkt:52:5 f176 [23] 82.0% expression->type [6] 12.3% ------------------------------------------------------------------------------ iterate-egraph!13 [3] 100.0% [15] 8678(1.3%) 0(0.0%) map-enodes ...ng-logging/src/core/egraph.rkt:139:0 loop [144] 85.5% for-loop [157] 11.0% hash-keys [28] 3.5% ------------------------------------------------------------------------------ run-improve50 [2] 100.0% [16] 1414(0.2%) 0(0.0%) setup-alt-simplified ...-logging/src/glue.rkt:49:0 simplify-alt [26] 100.0% ------------------------------------------------------------------------------ pattern-substitute [17] 44.5% for-loop [7] 55.5% [17] 1372(0.2%) 1040(0.2%) pattern-substitute ...ng/src/core/matcher.rkt:73:0 pattern-substitute [17] 44.5% ??? [43] 4.8% ------------------------------------------------------------------------------ for-loop [27] 23.9% for-loop [7] 76.1% [18] 690(0.1%) 0(0.0%) pattern-match ...logging/src/core/matcher.rkt:48:0 for-loop [27] 76.1% variable? [25] 23.9% ------------------------------------------------------------------------------ for-loop [10] 100.0% [19] 467854(72.7%) 0(0.0%) run-iter! ...mpling-logging/src/mainloop.rkt:215:0 simplify! [29] 77.0% gen-rewrites! [32] 15.8% finalize-iter! [33] 6.5% localize-error [38] 0.6% ------------------------------------------------------------------------------ one-iter [11] 100.0% [20] 247728(38.5%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [30] 100.0% ------------------------------------------------------------------------------ pass [12] 100.0% [21] 137348(21.3%) 674(0.1%) for-loop ...g-logging/src/core/simplify.rkt:208:29 argmin [31] 86.3% loop [35] 10.0% for-loop [37] 2.7% filter [158] 0.3% make-sequence [130] 0.2% ------------------------------------------------------------------------------ for-loop [22] 49.8% one-iter [11] 50.2% [22] 79782(12.4%) 15650(2.4%) for-loop ...g-logging/src/core/simplify.rkt:123:12 for-loop [22] 49.8% match-e [44] 40.2% ------------------------------------------------------------------------------ eval-prog [110] 3.1% eval-const-expr [165] 5.3% f176 [23] 13.0% for-loop [14] 35.7% rewriter [66] 42.9% [23] 37360(5.8%) 1020(0.2%) f176 .../collects/racket/match/compiler.rkt:507:40 ??? [115] 26.0% ??? [114] 23.2% ??? [43] 21.3% f176 [23] 13.0% ...gging/src/common.rkt:47:2 [56] 9.4% ??? [36] 3.8% parse-loop12 [137] 0.9% expression->type [6] 0.5% ------------------------------------------------------------------------------ *rules* [5] 5.5% for-loop [13] 94.5% [24] 18432(2.9%) 3072(0.5%) ormap ...et/collects/racket/private/map.rkt:105:13 flag-set? [34] 83.3% ------------------------------------------------------------------------------ pattern-match [18] 3.3% matcher [97] 3.6% substitute-e [53] 20.4% match-e [44] 72.6% [25] 9930(1.5%) 666(0.1%) variable? ...g-logging/src/syntax/syntax.rkt:660:0 ??? [43] 93.3% ------------------------------------------------------------------------------ setup-alt-simplified [16] 100.0% [26] 1414(0.2%) 0(0.0%) simplify-alt ...sampling-logging/src/glue.rkt:76:0 ??? [114] 100.0% ------------------------------------------------------------------------------ pattern-match [18] 100.0% [27] 690(0.1%) 360(0.1%) for-loop ...ling-logging/src/core/matcher.rkt:66:9 pattern-match [18] 47.8% ------------------------------------------------------------------------------ map-enodes [15] 100.0% [28] 300(0.0%) 0(0.0%) hash-keys .../collects/racket/private/hash.rkt:2:2 loop [39] 100.0% ------------------------------------------------------------------------------ run-iter! [19] 100.0% [29] 360086(55.9%) 0(0.0%) simplify! ...mpling-logging/src/mainloop.rkt:155:0 for-loop [40] 100.0% ------------------------------------------------------------------------------ one-iter [11] 2.3% loop [20] 97.7% [30] 253532(39.4%) 1000(0.2%) apply-match ...logging/src/core/simplify.rkt:130:2 for-loop [41] 92.7% match-e [44] 6.6% reduce-to-single! [48] 0.3% ------------------------------------------------------------------------------ for-loop [21] 100.0% [31] 118572(18.4%) 324(0.1%) argmin ...re/racket/collects/racket/list.rkt:743:0 for-loop [42] 86.1% expression-cost [46] 13.7% ------------------------------------------------------------------------------ run-iter! [19] 100.0% [32] 73976(11.5%) 0(0.0%) gen-rewrites! ...ng-logging/src/mainloop.rkt:142:0 for-loop [45] 100.0% ------------------------------------------------------------------------------ run-iter! [19] 100.0% [33] 30340(4.7%) 0(0.0%) finalize-iter! ...g-logging/src/mainloop.rkt:169:0 ??? [43] 100.0% ------------------------------------------------------------------------------ for-loop [13] 14.8% ormap [24] 85.2% [34] 18036(2.8%) 5784(0.9%) flag-set? .../sampling-logging/src/config.rkt:34:0 return/no-unsupplied [148] 44.5% ??? [149] 23.5% ------------------------------------------------------------------------------ for-loop [21] 100.0% [35] 13686(2.1%) 0(0.0%) loop ...hare/racket/collects/racket/list.rkt:729:4 for-loop [42] 85.3% expression-cost [46] 14.7% ------------------------------------------------------------------------------ loop [152] 3.0% for-loop [157] 3.0% ??? [60] 4.9% for-loop [108] 6.3% map [109] 9.7% loop [144] 20.3% f176 [23] 52.7% [36] 10952(1.7%) 356(0.1%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ??? [114] 55.5% ??? [171] 26.9% ...gging/src/common.rkt:47:2 [56] 6.7% best-alt [47] 4.9% ??? [50] 2.7% ------------------------------------------------------------------------------ for-loop [21] 100.0% [37] 3752(0.6%) 3752(0.6%) for-loop ...g-logging/src/core/simplify.rkt:195:13 ------------------------------------------------------------------------------ run-iter! [19] 100.0% [38] 2728(0.4%) 0(0.0%) localize-error ...gging/src/core/localize.rkt:47:0 hash-ref! [117] 88.0% ??? [49] 12.0% ------------------------------------------------------------------------------ hash-keys [28] 2.9% loop [39] 97.1% [39] 300(0.0%) 300(0.0%) loop ...acket/collects/racket/private/hash.rkt:3:4 loop [39] 97.1% ------------------------------------------------------------------------------ simplify! [29] 100.0% [40] 360086(55.9%) 0(0.0%) for-loop ...ampling-logging/src/mainloop.rkt:159:6 ??? [51] 99.9% ------------------------------------------------------------------------------ apply-match [30] 100.0% [41] 234996(36.5%) 996(0.2%) for-loop ...g-logging/src/core/simplify.rkt:145:10 mk-enode! [65] 31.2% substitute-e [53] 29.2% merge-egraph-nodes! [54] 24.3% loop! [84] 12.4% list-member? [59] 2.5% ------------------------------------------------------------------------------ loop [35] 10.3% argmin [31] 89.7% [42] 113736(17.7%) 4086(0.6%) for-loop ...ampling-logging/src/programs.rkt:199:2 ??? [114] 69.5% ...gging/src/common.rkt:47:2 [56] 24.8% ??? [115] 2.1% ------------------------------------------------------------------------------ pattern-substitute [17] 0.4% ??? [171] 1.9% substitute-e [53] 5.1% f176 [23] 9.6% variable? [25] 11.2% match-e [44] 14.1% get-sigs [105] 22.0% finalize-iter! [33] 35.0% [43] 82668(12.8%) 21336(3.3%) ??? ...contract/private/arrow-val-first.rkt:357:18 hash-has-key? [85] 38.1% for-loop [57] 34.3% ??? [60] 0.7% ??? [171] 0.4% ------------------------------------------------------------------------------ apply-match [30] 13.0% for-loop [67] 26.8% for-loop [22] 60.3% [44] 80946(12.6%) 26272(4.1%) match-e ...mpling-logging/src/core/ematch.rkt:46:0 for-loop [55] 46.3% for-loop [67] 11.1% ??? [43] 7.2% variable? [25] 3.8% list-cartesian-product [75] 1.2% loop [144] 1.1% custom-in-set [151] 0.8% curry* [78] 0.5% ------------------------------------------------------------------------------ gen-rewrites! [32] 100.0% [45] 73976(11.5%) 0(0.0%) for-loop ...mpling-logging/src/mainloop.rkt:147:11 ??? [52] 100.0% ------------------------------------------------------------------------------ loop [35] 11.0% argmin [31] 89.0% [46] 18198(2.8%) 634(0.1%) expression-cost ...-logging/src/programs.rkt:198:0 compile [58] 96.5% ------------------------------------------------------------------------------ ??? [36] 100.0% [47] 724(0.1%) 0(0.0%) best-alt ...bie/sampling-logging/src/glue.rkt:71:0 argmins [61] 100.0% ------------------------------------------------------------------------------ apply-match [30] 100.0% [48] 722(0.1%) 360(0.1%) reduce-to-single! ...ing/src/core/egraph.rkt:324:0 for-loop [62] 50.1% ------------------------------------------------------------------------------ localize-error [38] 100.0% [49] 328(0.1%) 0(0.0%) ??? ...cket/collects/racket/private/sort.rkt:403:3 loop [63] 100.0% ------------------------------------------------------------------------------ ??? [36] 100.0% [50] 298(0.0%) 0(0.0%) ??? ...contract/private/../../private/kw.rkt:761:9 integer->bigfloat [64] 100.0% ------------------------------------------------------------------------------ for-loop [40] 19.1% run [9] 30.6% [51] 626804(97.3%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 ??? [114] 38.5% profile-thunk16 [1] 30.6% run-improve50 [2] 28.1% loop [68] 2.7% ------------------------------------------------------------------------------ for-loop [45] 100.0% [52] 73976(11.5%) 0(0.0%) ??? ...e/sampling-logging/src/alternative.rkt:88:0 rewriter [66] 100.0% ------------------------------------------------------------------------------ substitute-e [53] 6.5% for-loop [41] 93.5% [53] 68676(10.7%) 1402(0.2%) substitute-e ...g-logging/src/core/ematch.rkt:71:0 mk-enode! [65] 88.9% substitute-e [53] 6.5% ??? [43] 2.4% variable? [25] 1.0% ------------------------------------------------------------------------------ for-loop [74] 4.7% merge-egraph-nodes! [54] 6.8% for-loop [41] 88.5% [54] 57042(8.9%) 1404(0.2%) merge-egraph-nodes! ...g/src/core/egraph.rkt:152:0 update-leader! [70] 46.9% for-loop [73] 17.3% loop! [84] 11.9% merge-egraph-nodes! [54] 6.8% for-loop [74] 6.1% enode-merge! [77] 6.1% make-sequence [130] 1.2% for-loop [13] 1.2% ------------------------------------------------------------------------------ match-e [44] 100.0% [55] 50474(7.8%) 18296(2.8%) for-loop ...ling-logging/src/core/ematch.rkt:59:11 for-loop [67] 55.3% list-cartesian-product [75] 8.9% loop [144] 3.0% curry* [78] 1.4% foldl [160] 1.1% ------------------------------------------------------------------------------ ??? [36] 1.6% f176 [23] 7.7% get-sigs [105] 28.8% for-loop [42] 61.9% [56] 45596(7.1%) 12402(1.9%) ...gging/src/common.rkt:47:2 ...e/arr-i.rkt:906:19 ??? [71] 45.4% ??? [72] 27.4% ------------------------------------------------------------------------------ ??? [43] 100.0% [57] 29738(4.6%) 0(0.0%) for-loop ...ng-logging/src/core/alt-table.rkt:51:2 atab-add-altn [69] 100.0% ------------------------------------------------------------------------------ expression-cost [46] 100.0% [58] 17564(2.7%) 360(0.1%) compile ...sampling-logging/src/programs.rkt:175:0 hash-ref! [117] 98.0% ------------------------------------------------------------------------------ for-loop [41] 100.0% [59] 5828(0.9%) 356(0.1%) list-member? ...llects/racket/private/set.rkt:24:0 loop [76] 64.0% member [79] 29.9% ------------------------------------------------------------------------------ ??? [43] 100.0% [60] 724(0.1%) 0(0.0%) ??? ...ampling-logging/src/core/alt-table.rkt:54:0 ??? [36] 100.0% ------------------------------------------------------------------------------ best-alt [47] 100.0% [61] 724(0.1%) 0(0.0%) argmins ...e/sampling-logging/src/common.rkt:150:0 composed [80] 100.0% ------------------------------------------------------------------------------ reduce-to-single! [48] 100.0% [62] 362(0.1%) 362(0.1%) for-loop ...ling-logging/src/core/egraph.rkt:325:8 ------------------------------------------------------------------------------ ??? [49] 100.0% [63] 328(0.1%) 0(0.0%) loop ...ket/collects/racket/private/sort.rkt:97:12 errors-score [81] 100.0% ------------------------------------------------------------------------------ ??? [50] 100.0% [64] 298(0.0%) 298(0.0%) integer->bigfloat ...ivate/bigfloat/mpfr.rkt:399:0 ------------------------------------------------------------------------------ mk-egraph [129] 0.2% expr->enode [136] 3.1% substitute-e [53] 43.9% for-loop [41] 52.8% [65] 139064(21.6%) 9904(1.5%) mk-enode! ...ing-logging/src/core/egraph.rkt:101:0 new-enode [82] 90.9% hash-has-key? [85] 1.9% ------------------------------------------------------------------------------ ??? [52] 14.4% matcher [97] 85.6% [66] 73976(11.5%) 6654(1.0%) rewriter ...ing-logging/src/core/matcher.rkt:131:2 for-loop [83] 86.6% *rules* [5] 5.7% f176 [23] 3.3% expression->type [6] 3.1% ------------------------------------------------------------------------------ match-e [44] 33.7% for-loop [55] 66.3% [67] 44424(6.9%) 2732(0.4%) for-loop ...ling-logging/src/core/ematch.rkt:65:37 match-e [44] 88.7% ??? [89] 5.5% ------------------------------------------------------------------------------ run-improve50 [2] 5.0% ??? [51] 95.0% [68] 35858(5.6%) 0(0.0%) loop ...rbie/sampling-logging/src/points.rkt:194:2 make-exacts* [98] 50.9% loop [88] 49.1% ------------------------------------------------------------------------------ for-loop [57] 98.0% [69] 30340(4.7%) 0(0.0%) atab-add-altn ...ging/src/core/alt-table.rkt:208:0 best-and-tied-at-points [86] 97.6% override-at-pnts [93] 2.4% ------------------------------------------------------------------------------ merge-egraph-nodes! [54] 100.0% [70] 30258(4.7%) 3678(0.6%) update-leader! ...ogging/src/core/egraph.rkt:217:0 for-loop [87] 77.7% hash-ref! [117] 4.4% custom-set-union! [95] 2.2% update-en-expr [135] 1.2% make-sequence [130] 1.2% ------------------------------------------------------------------------------ ??? [153] 9.3% for-loop [164] 9.9% ...gging/src/common.rkt:47:2 [56] 80.8% [71] 20680(3.2%) 6250(1.0%) ??? ...ects/racket/contract/private/list.rkt:342:4 ??? [153] 65.7% ??? [171] 8.4% ??? [150] 6.4% ------------------------------------------------------------------------------ ...gging/src/common.rkt:47:2 [56] 100.0% [72] 12514(1.9%) 5326(0.8%) ??? ...s/racket/contract/private/arr-i.rkt:1268:39 ??? [149] 25.7% return/no-unsupplied [148] 20.7% assoc-ref [91] 11.1% ------------------------------------------------------------------------------ merge-egraph-nodes! [54] 100.0% [73] 10078(1.6%) 7684(1.2%) for-loop ...ling-logging/src/core/egraph.rkt:232:6 update-en-expr [135] 23.8% ------------------------------------------------------------------------------ merge-egraph-nodes! [54] 100.0% [74] 6658(1.0%) 0(0.0%) for-loop ...ing-logging/src/core/egraph.rkt:200:10 merge-egraph-nodes! [54] 85.1% loop! [84] 14.9% ------------------------------------------------------------------------------ match-e [44] 18.4% list-cartesian-product [75] 21.1% for-loop [55] 60.5% [75] 6378(1.0%) 6378(1.0%) list-cartesian-product ...src/core/ematch.rkt:20:0 list-cartesian-product [75] 21.1% ------------------------------------------------------------------------------ list-member? [59] 100.0% [76] 3730(0.6%) 3730(0.6%) loop (unknown source) ------------------------------------------------------------------------------ merge-egraph-nodes! [54] 100.0% [77] 3458(0.5%) 0(0.0%) enode-merge! ...g-logging/src/core/enode.rkt:129:0 adopt-enode! [90] 69.6% custom-set-intersect! [92] 30.4% ------------------------------------------------------------------------------ for-loop [13] 20.1% match-e [44] 20.5% for-loop [55] 59.4% [78] 1788(0.3%) 1078(0.2%) curry* ...racket/collects/racket/function.rkt:44:2 procedure-arity [94] 39.7% ------------------------------------------------------------------------------ list-member? [59] 100.0% [79] 1742(0.3%) 1742(0.3%) member (unknown source) ------------------------------------------------------------------------------ argmins [61] 100.0% [80] 724(0.1%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 errors [99] 100.0% ------------------------------------------------------------------------------ loop [63] 100.0% [81] 328(0.1%) 328(0.1%) errors-score ...pling-logging/src/points.rkt:239:0 ------------------------------------------------------------------------------ mk-enode! [65] 100.0% [82] 126452(19.6%) 1010(0.2%) new-enode ...pling-logging/src/core/enode.rkt:97:0 type-of-enode-expr [96] 98.2% set [102] 0.5% ------------------------------------------------------------------------------ rewriter [66] 100.0% [83] 73610(11.4%) 0(0.0%) for-loop ...ng-logging/src/core/matcher.rkt:134:10 matcher [97] 99.9% ------------------------------------------------------------------------------ for-loop [74] 1.7% merge-egraph-nodes! [54] 14.9% loop [144] 31.1% for-loop [41] 52.3% [84] 39512(6.1%) 7048(1.1%) loop! ...sampling-logging/src/core/enode.rkt:192:2 custom-set-union [101] 38.8% loop [144] 34.7% set [102] 12.5% update-en-expr [135] 4.0% ------------------------------------------------------------------------------ mk-enode! [65] 7.6% ??? [43] 92.4% [85] 35742(5.6%) 9918(1.5%) hash-has-key? ...et/private/more-scheme.rkt:368:13 ??? [124] 70.3% ------------------------------------------------------------------------------ atab-add-altn [69] 100.0% [86] 29618(4.6%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:122:0 errors [99] 96.7% for-loop [104] 2.2% ------------------------------------------------------------------------------ update-leader! [70] 100.0% [87] 23504(3.7%) 960(0.1%) for-loop ...ling-logging/src/core/egraph.rkt:222:6 for-loop [100] 95.9% ------------------------------------------------------------------------------ loop [68] 100.0% [88] 17612(2.7%) 0(0.0%) loop ...rbie/sampling-logging/src/points.rkt:153:2 make-exacts* [98] 100.0% ------------------------------------------------------------------------------ for-loop [67] 100.0% [89] 2450(0.4%) 1734(0.3%) ??? ...e/sampling-logging/src/core/ematch.rkt:50:5 for-loop [103] 29.2% ------------------------------------------------------------------------------ enode-merge! [77] 100.0% [90] 2406(0.4%) 1018(0.2%) adopt-enode! ...g-logging/src/core/enode.rkt:105:0 custom-set-union [101] 57.7% ------------------------------------------------------------------------------ ??? [72] 100.0% [91] 1388(0.2%) 1388(0.2%) assoc-ref ...collects/racket/private/dict.rkt:56:0 ------------------------------------------------------------------------------ enode-merge! [77] 100.0% [92] 1052(0.2%) 1052(0.2%) custom-set-intersect! ...ivate/set-types.rkt:269:0 ------------------------------------------------------------------------------ atab-add-altn [69] 100.0% [93] 722(0.1%) 0(0.0%) override-at-pnts ...g/src/core/alt-table.rkt:145:0 errors [99] 100.0% ------------------------------------------------------------------------------ curry* [78] 100.0% [94] 710(0.1%) 710(0.1%) procedure-arity ...ket/private/norm-arity.rkt:7:27 ------------------------------------------------------------------------------ update-leader! [70] 100.0% [95] 658(0.1%) 658(0.1%) custom-set-union! ...t/private/set-types.rkt:245:0 ------------------------------------------------------------------------------ new-enode [82] 100.0% [96] 124116(19.3%) 2090(0.3%) type-of-enode-expr ...ging/src/core/enode.rkt:68:0 get-sigs [105] 98.3% ------------------------------------------------------------------------------ matcher [97] 24.9% for-loop [106] 25.2% for-loop [83] 49.9% [97] 73610(11.4%) 1728(0.3%) matcher ...ling-logging/src/core/matcher.rkt:167:2 rewriter [66] 49.4% for-loop [106] 25.2% matcher [97] 24.9% for-loop [7] 0.3% foldr [112] 0.1% variable? [25] 0.0% ------------------------------------------------------------------------------ loop [88] 49.1% loop [68] 50.9% [98] 35858(5.6%) 0(0.0%) make-exacts* ...pling-logging/src/points.rkt:138:0 loop [144] 49.0% map [109] 46.3% eval-prog [110] 4.8% ------------------------------------------------------------------------------ override-at-pnts [93] 2.4% composed [80] 2.4% best-and-tied-at-points [86] 95.2% [99] 30074(4.7%) 0(0.0%) errors ...ie/sampling-logging/src/points.rkt:229:0 for-loop [108] 70.9% eval-prog [110] 29.1% ------------------------------------------------------------------------------ for-loop [87] 100.0% [100] 22544(3.5%) 0(0.0%) for-loop ...ling-logging/src/core/egraph.rkt:223:8 hash-update! [107] 100.0% ------------------------------------------------------------------------------ adopt-enode! [90] 7.4% loop! [84] 92.6% [101] 18854(2.9%) 7970(1.2%) custom-set-union ...et/private/set-types.rkt:168:0 for-loop [111] 54.1% for-loop [113] 3.6% ------------------------------------------------------------------------------ new-enode [82] 6.2% loop! [84] 93.8% [102] 10884(1.7%) 10884(1.7%) set ...collects/racket/private/set-types.rkt:981:0 ------------------------------------------------------------------------------ ??? [89] 100.0% [103] 716(0.1%) 716(0.1%) for-loop ...pling-logging/src/core/ematch.rkt:51:7 ------------------------------------------------------------------------------ best-and-tied-at-points [86] 100.0% [104] 662(0.1%) 662(0.1%) for-loop ...-logging/src/core/alt-table.rkt:124:16 ------------------------------------------------------------------------------ type-of-enode-expr [96] 100.0% [105] 122026(19.0%) 1762(0.3%) get-sigs ...ampling-logging/src/type-check.rkt:5:0 ??? [115] 40.8% ??? [114] 32.1% ??? [43] 14.9% ...gging/src/common.rkt:47:2 [56] 10.8% ------------------------------------------------------------------------------ matcher [97] 100.0% [106] 71670(11.1%) 0(0.0%) for-loop ...ng-logging/src/core/matcher.rkt:183:21 matcher [97] 100.0% ------------------------------------------------------------------------------ for-loop [100] 100.0% [107] 22544(3.5%) 358(0.1%) hash-update! ...ket/private/more-scheme.rkt:362:13 ??? [118] 98.4% ------------------------------------------------------------------------------ errors [99] 100.0% [108] 21332(3.3%) 1018(0.2%) for-loop .../sampling-logging/src/points.rkt:232:4 ??? [116] 90.3% ??? [36] 3.2% ------------------------------------------------------------------------------ ??? [8] 6.0% make-exacts* [98] 94.0% [109] 17658(2.7%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [144] 92.0% ??? [36] 6.0% ??? [116] 2.0% ------------------------------------------------------------------------------ make-exacts* [98] 16.3% errors [99] 83.7% [110] 10450(1.6%) 1368(0.2%) eval-prog ...mpling-logging/src/programs.rkt:148:0 f176 [23] 57.6% hash-ref! [117] 23.0% ??? [121] 3.2% keyword-procedure-extract/method [122] 3.1% ------------------------------------------------------------------------------ custom-set-union [101] 100.0% [111] 10198(1.6%) 1642(0.3%) for-loop ...cts/racket/private/set-types.rkt:174:3 for-loop [119] 83.9% ------------------------------------------------------------------------------ matcher [97] 100.0% [112] 718(0.1%) 358(0.1%) foldr ...et/collects/racket/private/list.rkt:242:4 cp-2 [120] 50.1% ------------------------------------------------------------------------------ custom-set-union [101] 100.0% [113] 686(0.1%) 686(0.1%) for-loop ...cts/racket/private/set-types.rkt:152:2 ------------------------------------------------------------------------------ simplify-alt [26] 0.1% ??? [36] 1.2% f176 [23] 1.6% get-sigs [105] 2.6% for-loop [42] 5.2% ??? [114] 15.3% for-loop [123] 29.4% ??? [51] 43.8% [114] 504264(78.3%) 36138(5.6%) ??? ...llects/racket/private/norm-define.rkt:53:83 iterate-egraph!13 [3] 33.2% for-loop [123] 29.4% ??? [114] 15.3% loop [4] 11.1% ??? [124] 6.3% ??? [149] 0.5% mk-egraph [129] 0.4% return/no-unsupplied [148] 0.3% ??? [153] 0.1% ------------------------------------------------------------------------------ for-loop [42] 3.8% f176 [23] 15.9% get-sigs [105] 80.3% [115] 62064(9.6%) 4344(0.7%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 ??? [126] 42.4% for-loop [145] 37.0% get/build-late-neg-projection [163] 9.6% ??? [150] 1.7% ??? [168] 0.5% ------------------------------------------------------------------------------ map [109] 0.7% for-loop [108] 37.4% loop [144] 62.0% [116] 51554(8.0%) 0(0.0%) ??? ...bie/sampling-logging/src/programs.rkt:154:4 ??? [125] 100.0% ------------------------------------------------------------------------------ eval-prog [110] 1.8% localize-error [38] 4.8% ??? [8] 5.5% update-leader! [70] 5.7% loop [144] 8.5% compile [58] 28.4% ??? [128] 45.3% [117] 23346(3.6%) 16596(2.6%) hash-ref! ...racket/private/more-scheme.rkt:373:13 ??? [128] 59.2% parse-loop12 [137] 10.3% bigfloat-hash [131] 1.1% ------------------------------------------------------------------------------ hash-update! [107] 100.0% [118] 22186(3.4%) 1700(0.3%) ??? ...sampling-logging/src/core/egraph.rkt:225:24 for-loop [127] 90.9% make-sequence [130] 1.5% ------------------------------------------------------------------------------ for-loop [111] 100.0% [119] 8556(1.3%) 8556(1.3%) for-loop ...cts/racket/private/set-types.rkt:178:5 ------------------------------------------------------------------------------ foldr [112] 100.0% [120] 360(0.1%) 360(0.1%) cp-2 ...hare/racket/collects/racket/list.rkt:804:2 ------------------------------------------------------------------------------ eval-prog [110] 100.0% [121] 338(0.1%) 0(0.0%) ??? ...collects/racket/private/qq-and-or.rkt:155:9 ??? [132] 100.0% ------------------------------------------------------------------------------ eval-prog [110] 100.0% [122] 326(0.1%) 326(0.1%) keyword-procedure-extract/method .../kw.rkt:1325:2 ------------------------------------------------------------------------------ ??? [114] 100.0% [123] 320414(49.8%) 0(0.0%) for-loop ...ng-logging/src/core/simplify.rkt:63:12 ??? [114] 100.0% ------------------------------------------------------------------------------ hash-has-key? [85] 23.4% ??? [114] 76.6% [124] 107288(16.7%) 41812(6.5%) ??? ...ects/racket/contract/private/list.rkt:737:4 for-loop [133] 48.5% ??? [146] 8.9% ??? [153] 2.7% arrow-higher-order:lnp [190] 0.3% ------------------------------------------------------------------------------ ??? [116] 100.0% [125] 51554(8.0%) 22942(3.6%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [179] 25.0% bf* [172] 14.7% ??? [138] 6.2% ??? [139] 4.7% ...higher-order.rkt:346:33 [140] 3.5% parse-loop12 [137] 1.3% ------------------------------------------------------------------------------ ??? [115] 100.0% [126] 26322(4.1%) 996(0.2%) ??? ...ects/racket/contract/private/hash.rkt:217:4 ??? [134] 96.2% ------------------------------------------------------------------------------ ??? [118] 100.0% [127] 20160(3.1%) 17702(2.7%) for-loop ...ing-logging/src/core/egraph.rkt:226:26 update-en-expr [135] 12.2% ------------------------------------------------------------------------------ hash-ref! [117] 100.0% [128] 18574(2.9%) 2668(0.4%) ??? ...bie/sampling-logging/src/programs.rkt:183:5 hash-ref! [117] 80.5% loop [144] 12.9% ------------------------------------------------------------------------------ ??? [114] 100.0% [129] 4628(0.7%) 0(0.0%) mk-egraph ...ing-logging/src/core/egraph.rkt:123:0 expr->enode [136] 93.3% mk-enode! [65] 6.7% ------------------------------------------------------------------------------ for-loop [21] 18.2% ??? [118] 19.3% update-leader! [70] 20.9% merge-egraph-nodes! [54] 41.6% [130] 1688(0.3%) 678(0.1%) make-sequence ...ects/racket/private/for.rkt:509:2 ??? [141] 59.8% ------------------------------------------------------------------------------ hash-ref! [117] 100.0% [131] 1350(0.2%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:165:0 bfcanonicalize [142] 53.6% sig+exp->bigfloat [143] 46.4% ------------------------------------------------------------------------------ ??? [121] 100.0% [132] 338(0.1%) 338(0.1%) ??? ...ollects/racket/private/qq-and-or.rkt:164:21 ------------------------------------------------------------------------------ ??? [124] 100.0% [133] 52018(8.1%) 24560(3.8%) for-loop ...acket/contract/private/list.rkt:743:12 ??? [146] 30.5% for-loop [145] 15.2% ??? [150] 5.8% ??? [171] 1.3% ------------------------------------------------------------------------------ ??? [126] 100.0% [134] 25326(3.9%) 1080(0.2%) ??? ...ects/racket/contract/private/list.rkt:169:2 ??? [147] 95.7% ------------------------------------------------------------------------------ update-leader! [70] 4.0% for-loop [13] 4.0% for-loop [73] 26.8% for-loop [127] 27.5% loop! [84] 37.7% [135] 8938(1.4%) 8938(1.4%) update-en-expr ...ogging/src/core/egraph.rkt:211:0 ------------------------------------------------------------------------------ mk-egraph [129] 35.8% expr->enode [136] 64.2% [136] 4316(0.7%) 0(0.0%) expr->enode ...g-logging/src/core/egraph.rkt:124:2 expr->enode [136] 64.2% mk-enode! [65] 35.8% ------------------------------------------------------------------------------ f176 [23] 9.7% ??? [125] 20.1% hash-ref! [117] 70.2% [137] 3418(0.5%) 1018(0.2%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 loop [144] 60.6% loop [152] 9.6% ------------------------------------------------------------------------------ ??? [125] 100.0% [138] 3186(0.5%) 3186(0.5%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ------------------------------------------------------------------------------ ??? [125] 100.0% [139] 2434(0.4%) 1046(0.2%) ??? ...mpling-logging/src/syntax/syntax.rkt:153:17 ??? [149] 44.6% return/no-unsupplied [148] 12.4% ------------------------------------------------------------------------------ ??? [125] 100.0% [140] 1800(0.3%) 0(0.0%) ...higher-order.rkt:346:33 (unknown source) ??? [153] 100.0% ------------------------------------------------------------------------------ make-sequence [130] 100.0% [141] 1010(0.2%) 702(0.1%) ??? ...acket/collects/racket/private/for.rkt:429:7 custom-in-set [151] 30.5% ------------------------------------------------------------------------------ bigfloat-hash [131] 100.0% [142] 724(0.1%) 724(0.1%) bfcanonicalize .../private/bigfloat/mpfr.rkt:155:0 ------------------------------------------------------------------------------ bigfloat-hash [131] 100.0% [143] 626(0.1%) 626(0.1%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:385:0 ------------------------------------------------------------------------------ map [109] 0.1% make-exacts* [98] 0.6% parse-loop12 [137] 0.7% map-enodes [15] 0.8% match-e [44] 1.0% for-loop [55] 2.7% ??? [128] 3.2% loop! [84] 12.3% loop [144] 78.5% [144] 74292(11.5%) 4800(0.7%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [144] 78.5% loop! [84] 11.6% hash-ref! [117] 3.2% for-loop [157] 0.7% ??? [116] 0.7% ??? [8] 0.7% foldl [160] 0.5% ??? [36] 0.0% ------------------------------------------------------------------------------ for-loop [133] 25.7% ??? [115] 74.3% [145] 30892(4.8%) 7438(1.2%) for-loop ...racket/contract/private/hash.rkt:239:6 ??? [153] 75.9% ------------------------------------------------------------------------------ ??? [124] 37.5% for-loop [133] 62.5% [146] 25354(3.9%) 10686(1.7%) ??? ...private/unconstrained-domain-arrow.rkt:74:4 make-keyword-procedure [155] 57.9% ------------------------------------------------------------------------------ ??? [134] 100.0% [147] 24246(3.8%) 2108(0.3%) ??? ...ects/racket/contract/private/list.rkt:678:5 for-loop [154] 91.3% ------------------------------------------------------------------------------ ??? [139] 2.1% ??? [72] 17.7% ??? [114] 25.5% flag-set? [34] 54.8% [148] 14644(2.3%) 7348(1.1%) return/no-unsupplied ...ct/private/arr-i.rkt:533:0 filter [158] 49.8% ------------------------------------------------------------------------------ ??? [139] 8.1% ??? [72] 23.9% flag-set? [34] 31.5% ??? [114] 36.5% [149] 13442(2.1%) 3330(0.5%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [156] 60.3% ??? [171] 14.9% ------------------------------------------------------------------------------ ??? [115] 19.3% ??? [71] 24.8% for-loop [133] 55.9% [150] 5356(0.8%) 1328(0.2%) ??? ...ects/racket/contract/private/hash.rkt:222:6 check-hash/c [159] 75.2% ------------------------------------------------------------------------------ ??? [141] 31.8% match-e [44] 68.2% [151] 968(0.2%) 968(0.2%) custom-in-set ...acket/private/set-types.rkt:577:0 ------------------------------------------------------------------------------ parse-loop12 [137] 4.3% loop [152] 95.7% [152] 328(0.1%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:36:19 loop [152] 95.7% ??? [36] 4.3% ------------------------------------------------------------------------------ ??? [114] 3.4% ...higher-order.rkt:346:33 [140] 3.8% ??? [124] 6.2% ??? [71] 37.1% for-loop [145] 49.5% [153] 47360(7.4%) 10890(1.7%) ??? ...cts/racket/contract/private/list.rkt:187:10 ??? [161] 48.1% for-loop [164] 16.7% ??? [71] 8.1% ??? [175] 4.1% ------------------------------------------------------------------------------ ??? [147] 100.0% [154] 22138(3.4%) 5210(0.8%) for-loop ...racket/contract/private/list.rkt:680:9 add-list-context [162] 55.3% get/build-late-neg-projection [163] 21.2% ------------------------------------------------------------------------------ ??? [146] 100.0% [155] 14668(2.3%) 14668(2.3%) make-keyword-procedure ...ket/private/kw.rkt:260:4 ------------------------------------------------------------------------------ ??? [149] 100.0% [156] 8104(1.3%) 7476(1.2%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ??? [168] 7.7% ------------------------------------------------------------------------------ map-enodes [15] 11.9% loop [144] 88.1% [157] 8044(1.2%) 728(0.1%) for-loop ...ng-logging/src/core/simplify.rkt:173:2 eval-const-expr [165] 53.0% setfindf [167] 33.9% ??? [36] 4.1% ------------------------------------------------------------------------------ for-loop [21] 4.7% return/no-unsupplied [148] 95.3% [158] 7652(1.2%) 7652(1.2%) filter ...t/collects/racket/private/list.rkt:256:2 ------------------------------------------------------------------------------ ??? [150] 100.0% [159] 4028(0.6%) 684(0.1%) check-hash/c ...ket/contract/private/hash.rkt:83:0 flat-contract? [166] 83.0% ------------------------------------------------------------------------------ for-loop [7] 24.6% loop [144] 25.0% for-loop [55] 50.4% [160] 1448(0.2%) 724(0.1%) foldl ...et/collects/racket/private/list.rkt:229:4 merge2 [169] 25.4% merge-2-bindings [170] 24.6% ------------------------------------------------------------------------------ ??? [153] 100.0% [161] 22794(3.5%) 996(0.2%) ??? ...ects/racket/contract/private/list.rkt:686:7 ??? [171] 88.6% ??? [175] 7.0% ------------------------------------------------------------------------------ for-loop [154] 100.0% [162] 12244(1.9%) 12244(1.9%) add-list-context ...ontract/private/list.rkt:752:0 ------------------------------------------------------------------------------ listof-late-neg-projection [177] 1.1% ??? [174] 20.9% ??? [115] 32.5% for-loop [154] 43.9% [163] 10670(1.7%) 3130(0.5%) get/build-late-neg-projection ...te/guts.rkt:691:0 ??? [173] 50.6% ??? [174] 24.3% listof-late-neg-projection [177] 2.8% ------------------------------------------------------------------------------ ??? [153] 100.0% [164] 7898(1.2%) 3804(0.6%) for-loop ...acket/contract/private/list.rkt:190:15 ??? [71] 51.8% ------------------------------------------------------------------------------ for-loop [157] 100.0% [165] 4262(0.7%) 656(0.1%) eval-const-expr ...-logging/src/programs.rkt:166:0 f176 [23] 46.4% bf* [172] 16.3% ??? [178] 14.8% ??? [179] 7.0% ------------------------------------------------------------------------------ check-hash/c [159] 100.0% [166] 3344(0.5%) 3344(0.5%) flat-contract? .../contract/private/guts.rkt:111:0 ------------------------------------------------------------------------------ for-loop [157] 100.0% [167] 2726(0.4%) 1706(0.3%) setfindf .../sampling-logging/src/common.rkt:184:0 for-loop [176] 37.4% ------------------------------------------------------------------------------ ??? [115] 35.0% ??? [156] 65.0% [168] 966(0.2%) 966(0.2%) ??? ...ects/racket/contract/private/prop.rkt:256:4 ------------------------------------------------------------------------------ foldl [160] 100.0% [169] 368(0.1%) 368(0.1%) merge2 ...ampling-logging/src/core/ematch.rkt:31:0 ------------------------------------------------------------------------------ foldl [160] 100.0% [170] 356(0.1%) 356(0.1%) merge-2-bindings ...ging/src/core/matcher.rkt:28:0 ------------------------------------------------------------------------------ ??? [43] 1.2% for-loop [133] 2.3% ??? [149] 6.7% ??? [36] 10.5% ??? [71] 11.7% ??? [161] 67.6% [171] 29864(4.6%) 23578(3.7%) ??? ...ects/racket/contract/private/guts.rkt:644:8 ??? [43] 10.5% contract? [181] 9.3% ------------------------------------------------------------------------------ eval-const-expr [165] 8.4% ??? [125] 91.6% [172] 8298(1.3%) 364(0.1%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [179] 95.6% ------------------------------------------------------------------------------ get/build-late-neg-projection [163] 100.0% [173] 6820(1.1%) 2048(0.3%) ??? ...cts/racket/contract/private/prop.rkt:314:12 build-compound-type-name [180] 70.0% ------------------------------------------------------------------------------ get/build-late-neg-projection [163] 100.0% [174] 4942(0.8%) 360(0.1%) ??? ...ects/racket/contract/private/hash.rkt:211:2 get/build-late-neg-projection [163] 92.7% ------------------------------------------------------------------------------ ??? [161] 45.3% ??? [153] 54.7% [175] 3540(0.5%) 1254(0.2%) ??? ...ects/racket/contract/private/prop.rkt:493:4 ??? [182] 64.6% ------------------------------------------------------------------------------ setfindf [167] 100.0% [176] 1020(0.2%) 1020(0.2%) for-loop .../sampling-logging/src/common.rkt:185:2 ------------------------------------------------------------------------------ get/build-late-neg-projection [163] 100.0% [177] 722(0.1%) 360(0.1%) listof-late-neg-projection ...ivate/list.rkt:162:0 get/build-late-neg-projection [163] 50.1% ------------------------------------------------------------------------------ eval-const-expr [165] 100.0% [178] 632(0.1%) 0(0.0%) ??? ...cket/collects/racket/private/kw.rkt:1633:36 unpack245 [183] 100.0% ------------------------------------------------------------------------------ eval-const-expr [165] 1.4% bf* [172] 37.5% ??? [125] 61.0% [179] 21138(3.3%) 4936(0.8%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfexpt [184] 71.3% bfneg [187] 5.4% ------------------------------------------------------------------------------ contract-struct-name [185] 13.7% ??? [173] 86.3% [180] 4772(0.7%) 2750(0.4%) build-compound-type-name ...private/guts.rkt:448:0 contract-struct-name [185] 52.7% ------------------------------------------------------------------------------ ??? [171] 100.0% [181] 2792(0.4%) 2792(0.4%) contract? ...acket/contract/private/guts.rkt:109:0 ------------------------------------------------------------------------------ ??? [175] 100.0% [182] 2286(0.4%) 682(0.1%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ??? [186] 70.2% ------------------------------------------------------------------------------ ??? [178] 100.0% [183] 632(0.1%) 0(0.0%) unpack245 ...private/arrow-higher-order.rkt:354:44 maybe-cons-kwd [188] 100.0% ------------------------------------------------------------------------------ ??? [179] 100.0% [184] 15068(2.3%) 10604(1.6%) bfexpt ...lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [189] 29.6% ------------------------------------------------------------------------------ build-compound-type-name [180] 100.0% [185] 3012(0.5%) 2022(0.3%) contract-struct-name ...ract/private/prop.rkt:89:0 build-compound-type-name [180] 38.2% ------------------------------------------------------------------------------ ??? [182] 100.0% [186] 1604(0.2%) 1604(0.2%) ??? ...ects/racket/contract/private/list.rkt:141:5 ------------------------------------------------------------------------------ ??? [179] 100.0% [187] 1134(0.2%) 342(0.1%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:616:4 ??? [189] 69.8% ------------------------------------------------------------------------------ unpack245 [183] 100.0% [188] 632(0.1%) 0(0.0%) maybe-cons-kwd ...ate/arrow-higher-order.rkt:498:0 arrow-higher-order:lnp [190] 52.5% unsafe-chaperone-procedure [191] 47.5% ------------------------------------------------------------------------------ bfneg [187] 15.1% bfexpt [184] 84.9% [189] 5256(0.8%) 5256(0.8%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ------------------------------------------------------------------------------ ??? [124] 48.0% maybe-cons-kwd [188] 52.0% [190] 638(0.1%) 332(0.1%) arrow-higher-order:lnp ...w-higher-order.rkt:597:7 ??? [192] 48.0% ------------------------------------------------------------------------------ maybe-cons-kwd [188] 100.0% [191] 300(0.0%) 300(0.0%) unsafe-chaperone-procedure ...ivate/kw.rkt:1588:11 ------------------------------------------------------------------------------ arrow-higher-order:lnp [190] 100.0% [192] 306(0.0%) 306(0.0%) ??? ...et/contract/private/arity-checking.rkt:19:2 ------------------------------------------------------------------------------