Profiling results ----------------- Total cpu time observed: 176652ms (out of 177912ms) Number of samples taken: 507 (once every 348ms) (Hiding functions with self<1.0% and local<2.0%: 6 of 197 hidden) ============================================================================ Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================================ ??? [39] 100.0% [1] 156914(88.8%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [12] 100.0% ---------------------------------------------------------------------------- ??? [39] 100.0% [2] 112784(63.8%) 0(0.0%) run-improve50 ...ng-logging/src/mainloop.rkt:234:0 for-loop [13] 88.2% get-final-combination [14] 10.4% loop [46] 1.5% ---------------------------------------------------------------------------- location-do [93] 100.0% [3] 7432(4.2%) 0(0.0%) loop ...mpling-logging/src/core/simplify.rkt:215:2 pass [15] 100.0% ---------------------------------------------------------------------------- substitute-e [136] 20.3% match-e [133] 79.7% [4] 3408(1.9%) 0(0.0%) variable? ...g-logging/src/syntax/syntax.rkt:660:0 ??? [34] 100.0% ---------------------------------------------------------------------------- ??? [92] 100.0% [5] 1024(0.6%) 0(0.0%) approximate9 ...g-logging/src/core/taylor.rkt:12:0 loop [16] 100.0% ---------------------------------------------------------------------------- location-do [93] 100.0% [6] 946(0.5%) 0(0.0%) mk-egraph ...ing-logging/src/core/egraph.rkt:123:0 expr->enode [17] 100.0% ---------------------------------------------------------------------------- loop [71] 100.0% [7] 896(0.5%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [95] 100.0% ---------------------------------------------------------------------------- copying-mergesort [86] 100.0% [8] 678(0.4%) 0(0.0%) jloop ...t/collects/racket/private/sort.rkt:121:23 ??? [90] 100.0% ---------------------------------------------------------------------------- hash-ref! [95] 100.0% [9] 364(0.2%) 0(0.0%) ??? ...sampling-logging/src/core/taylor.rkt:285:26 for-loop [18] 100.0% ---------------------------------------------------------------------------- hash-ref! [95] 100.0% [10] 332(0.2%) 0(0.0%) ??? ...sampling-logging/src/core/taylor.rkt:338:33 for-loop [20] 100.0% ---------------------------------------------------------------------------- hash-ref! [95] 100.0% [11] 332(0.2%) 0(0.0%) ??? ...sampling-logging/src/core/taylor.rkt:483:23 for-loop [19] 100.0% ---------------------------------------------------------------------------- profile-thunk16 [1] 100.0% [12] 156914(88.8%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [39] 100.0% ---------------------------------------------------------------------------- run-improve50 [2] 100.0% [13] 99438(56.3%) 0(0.0%) for-loop ...mpling-logging/src/mainloop.rkt:249:10 run-iter! [21] 100.0% ---------------------------------------------------------------------------- run-improve50 [2] 100.0% [14] 11676(6.6%) 0(0.0%) get-final-combination ...ng/src/mainloop.rkt:264:0 split-table [22] 100.0% ---------------------------------------------------------------------------- loop [3] 100.0% [15] 7432(4.2%) 0(0.0%) pass ...mpling-logging/src/core/simplify.rkt:205:2 for-loop [23] 100.0% ---------------------------------------------------------------------------- approximate9 [5] 100.0% [16] 1024(0.6%) 0(0.0%) loop .../sampling-logging/src/core/taylor.rkt:86:4 ??? [92] 100.0% ---------------------------------------------------------------------------- expr->enode [17] 15.6% mk-egraph [6] 84.4% [17] 946(0.5%) 0(0.0%) expr->enode ...g-logging/src/core/egraph.rkt:124:2 mk-enode! [138] 84.4% expr->enode [17] 15.6% ---------------------------------------------------------------------------- ??? [9] 100.0% [18] 364(0.2%) 0(0.0%) for-loop ...ing-logging/src/core/taylor.rkt:285:52 hash-ref! [95] 100.0% ---------------------------------------------------------------------------- ??? [11] 100.0% [19] 332(0.2%) 0(0.0%) for-loop ...ing-logging/src/core/taylor.rkt:487:35 parse-loop12 [115] 100.0% ---------------------------------------------------------------------------- ??? [10] 100.0% [20] 332(0.2%) 0(0.0%) for-loop ...ing-logging/src/core/taylor.rkt:341:46 hash-ref! [95] 100.0% ---------------------------------------------------------------------------- for-loop [13] 100.0% [21] 99438(56.3%) 0(0.0%) run-iter! ...mpling-logging/src/mainloop.rkt:215:0 simplify! [24] 88.3% finalize-iter! [26] 8.5% gen-rewrites! [29] 1.2% gen-series! [30] 1.0% localize-error [31] 0.9% ---------------------------------------------------------------------------- get-final-combination [14] 100.0% [22] 11676(6.6%) 0(0.0%) split-table ...sampling-logging/src/glue.rkt:162:0 f137 [25] 100.0% ---------------------------------------------------------------------------- pass [15] 100.0% [23] 7432(4.2%) 0(0.0%) for-loop ...g-logging/src/core/simplify.rkt:208:29 argmin [27] 69.1% loop [28] 22.0% for-loop [32] 8.9% ---------------------------------------------------------------------------- run-iter! [21] 100.0% [24] 87820(49.7%) 0(0.0%) simplify! ...mpling-logging/src/mainloop.rkt:155:0 for-loop [33] 100.0% ---------------------------------------------------------------------------- simplify [108] 2.2% eval-const-expr [131] 2.2% f137 [25] 3.7% hash-ref! [95] 6.0% eval-prog [67] 7.6% split-table [22] 78.3% [25] 14916(8.4%) 664(0.4%) f137 .../collects/racket/match/compiler.rkt:507:40 option-on-expr [73] 39.3% loop [71] 39.0% ??? [92] 7.6% map [65] 6.0% f137 [25] 3.7% ---------------------------------------------------------------------------- run-iter! [21] 100.0% [26] 8472(4.8%) 0(0.0%) finalize-iter! ...g-logging/src/mainloop.rkt:169:0 ??? [34] 100.0% ---------------------------------------------------------------------------- for-loop [23] 100.0% [27] 5138(2.9%) 0(0.0%) argmin ...re/racket/collects/racket/list.rkt:743:0 for-loop [35] 86.3% expression-cost [37] 13.7% ---------------------------------------------------------------------------- for-loop [23] 100.0% [28] 1632(0.9%) 0(0.0%) loop ...hare/racket/collects/racket/list.rkt:729:4 for-loop [35] 78.6% expression-cost [37] 21.4% ---------------------------------------------------------------------------- run-iter! [21] 100.0% [29] 1226(0.7%) 0(0.0%) gen-rewrites! ...ng-logging/src/mainloop.rkt:142:0 for-loop [36] 100.0% ---------------------------------------------------------------------------- run-iter! [21] 100.0% [30] 1024(0.6%) 0(0.0%) gen-series! ...ling-logging/src/mainloop.rkt:129:0 for-loop [38] 100.0% ---------------------------------------------------------------------------- run-iter! [21] 100.0% [31] 896(0.5%) 0(0.0%) localize-error ...gging/src/core/localize.rkt:47:0 hash-ref! [95] 100.0% ---------------------------------------------------------------------------- for-loop [23] 100.0% [32] 662(0.4%) 662(0.4%) for-loop ...g-logging/src/core/simplify.rkt:195:13 ---------------------------------------------------------------------------- simplify! [24] 100.0% [33] 87820(49.7%) 0(0.0%) for-loop ...ampling-logging/src/mainloop.rkt:159:6 ??? [39] 100.0% ---------------------------------------------------------------------------- ??? [181] 0.9% substitute-e [136] 1.6% ->bf [98] 1.9% get-sigs [157] 14.0% variable? [4] 17.9% match-e [133] 20.2% finalize-iter! [26] 43.5% [34] 19074(10.8%) 5118(2.9%) ??? ...contract/private/arrow-val-first.rkt:357:18 for-loop [40] 41.7% hash-has-key? [41] 29.7% atab-add-altns [45] 1.8% ---------------------------------------------------------------------------- loop [28] 22.4% argmin [27] 77.6% [35] 5718(3.2%) 0(0.0%) for-loop ...ampling-logging/src/programs.rkt:199:2 location-do [93] 89.0% ...gging/src/common.rkt:47:2 [163] 11.0% ---------------------------------------------------------------------------- gen-rewrites! [29] 100.0% [36] 1226(0.7%) 0(0.0%) for-loop ...mpling-logging/src/mainloop.rkt:147:11 ??? [42] 100.0% ---------------------------------------------------------------------------- loop [28] 33.3% argmin [27] 66.7% [37] 1052(0.6%) 0(0.0%) expression-cost ...-logging/src/programs.rkt:198:0 compile [43] 100.0% ---------------------------------------------------------------------------- gen-series! [30] 100.0% [38] 1024(0.6%) 0(0.0%) for-loop ...ampling-logging/src/mainloop.rkt:135:7 taylor-alt [44] 100.0% ---------------------------------------------------------------------------- for-loop [33] 16.7% run [12] 36.4% [39] 175092(99.1%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 36.4% location-do [93] 26.9% run-improve50 [2] 23.9% loop [46] 12.7% ---------------------------------------------------------------------------- ??? [34] 100.0% [40] 8136(4.6%) 0(0.0%) for-loop ...ng-logging/src/core/alt-table.rkt:51:2 atab-add-altn [47] 100.0% ---------------------------------------------------------------------------- mk-enode! [138] 10.3% ??? [34] 89.7% [41] 6514(3.7%) 2810(1.6%) hash-has-key? ...et/private/more-scheme.rkt:368:13 ??? [102] 51.8% ??? [50] 5.1% ---------------------------------------------------------------------------- for-loop [36] 100.0% [42] 1226(0.7%) 0(0.0%) ??? ...e/sampling-logging/src/alternative.rkt:88:0 rewriter [48] 100.0% ---------------------------------------------------------------------------- expression-cost [37] 100.0% [43] 1052(0.6%) 0(0.0%) compile ...sampling-logging/src/programs.rkt:175:0 hash-ref! [95] 100.0% ---------------------------------------------------------------------------- for-loop [38] 100.0% [44] 1024(0.6%) 0(0.0%) taylor-alt .../sampling-logging/src/glue.rkt:134:0 for-loop [49] 100.0% ---------------------------------------------------------------------------- ??? [34] 100.0% [45] 336(0.2%) 0(0.0%) atab-add-altns ...ging/src/core/alt-table.rkt:50:0 atab-add-altn [47] 100.0% ---------------------------------------------------------------------------- run-improve50 [2] 3.0% pred [88] 15.8% ??? [39] 81.2% [46] 54760(31.0%) 0(0.0%) loop ...rbie/sampling-logging/src/points.rkt:193:2 make-exacts* [58] 64.0% loop [51] 35.4% for-loop [56] 0.6% ---------------------------------------------------------------------------- atab-add-altns [45] 4.0% for-loop [40] 96.0% [47] 8472(4.8%) 0(0.0%) atab-add-altn ...ging/src/core/alt-table.rkt:208:0 best-and-tied-at-points [52] 87.6% override-at-pnts [54] 8.2% hash-set-lsts [55] 4.2% ---------------------------------------------------------------------------- matcher [60] 12.2% ??? [42] 87.8% [48] 1226(0.7%) 0(0.0%) rewriter ...ing-logging/src/core/matcher.rkt:131:2 for-loop [53] 87.8% *rules* [57] 12.2% ---------------------------------------------------------------------------- taylor-alt [44] 100.0% [49] 1024(0.6%) 0(0.0%) for-loop ...ie/sampling-logging/src/glue.rkt:139:6 ??? [92] 100.0% ---------------------------------------------------------------------------- hash-has-key? [41] 100.0% [50] 332(0.2%) 332(0.2%) ??? ...ects/racket/contract/private/hash.rkt:245:7 ---------------------------------------------------------------------------- loop [46] 100.0% [51] 19362(11.0%) 0(0.0%) loop ...rbie/sampling-logging/src/points.rkt:152:2 make-exacts* [58] 100.0% ---------------------------------------------------------------------------- atab-add-altn [47] 100.0% [52] 7418(4.2%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:122:0 errors [59] 95.5% for-loop [62] 4.5% ---------------------------------------------------------------------------- rewriter [48] 100.0% [53] 1226(0.7%) 0(0.0%) for-loop ...ng-logging/src/core/matcher.rkt:134:10 matcher [60] 100.0% ---------------------------------------------------------------------------- atab-add-altn [47] 100.0% [54] 696(0.4%) 0(0.0%) override-at-pnts ...g/src/core/alt-table.rkt:145:0 errors [59] 100.0% ---------------------------------------------------------------------------- atab-add-altn [47] 100.0% [55] 358(0.2%) 0(0.0%) hash-set-lsts ...ging/src/core/alt-table.rkt:111:0 loop [61] 100.0% ---------------------------------------------------------------------------- loop [46] 100.0% [56] 328(0.2%) 0(0.0%) for-loop ...sampling-logging/src/points.rkt:205:24 for-loop [63] 100.0% ---------------------------------------------------------------------------- rewriter [48] 100.0% [57] 298(0.2%) 0(0.0%) *rules* ...ling-logging/src/syntax/rules.rkt:512:0 for-loop [64] 100.0% ---------------------------------------------------------------------------- loop [51] 35.6% loop [46] 64.4% [58] 54432(30.8%) 358(0.2%) make-exacts* ...pling-logging/src/points.rkt:138:0 loop [71] 47.1% map [65] 44.1% eval-prog [67] 7.6% debug-print [119] 0.6% ---------------------------------------------------------------------------- composed [120] 3.4% pred [88] 7.6% override-at-pnts [54] 8.0% best-and-tied-at-points [52] 81.1% [59] 8736(4.9%) 0(0.0%) errors ...ie/sampling-logging/src/points.rkt:228:0 for-loop [66] 77.3% eval-prog [67] 22.7% ---------------------------------------------------------------------------- for-loop [70] 12.2% for-loop [53] 87.8% [60] 1226(0.7%) 0(0.0%) matcher ...ling-logging/src/core/matcher.rkt:167:2 for-loop [68] 75.7% for-loop [70] 12.2% rewriter [48] 12.2% ---------------------------------------------------------------------------- hash-set-lsts [55] 100.0% [61] 358(0.2%) 358(0.2%) loop ...pling-logging/src/core/alt-table.rkt:106:2 ---------------------------------------------------------------------------- best-and-tied-at-points [52] 100.0% [62] 334(0.2%) 334(0.2%) for-loop ...-logging/src/core/alt-table.rkt:124:16 ---------------------------------------------------------------------------- for-loop [56] 100.0% [63] 328(0.2%) 0(0.0%) for-loop ...sampling-logging/src/points.rkt:206:26 ??? [92] 100.0% ---------------------------------------------------------------------------- *rules* [57] 100.0% [64] 298(0.2%) 0(0.0%) for-loop ...e/sampling-logging/src/common.rkt:99:9 ormap [69] 100.0% ---------------------------------------------------------------------------- f137 [25] 3.6% make-exacts* [58] 96.4% [65] 24898(14.1%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [71] 94.4% ??? [90] 5.6% ---------------------------------------------------------------------------- errors [59] 100.0% [66] 6754(3.8%) 0(0.0%) for-loop .../sampling-logging/src/points.rkt:231:4 ??? [90] 100.0% ---------------------------------------------------------------------------- errors [59] 32.4% make-exacts* [58] 67.6% [67] 6116(3.5%) 970(0.5%) eval-prog ...mpling-logging/src/programs.rkt:148:0 hash-ref! [95] 45.4% f137 [25] 27.5% ??? [92] 11.3% ---------------------------------------------------------------------------- matcher [60] 100.0% [68] 928(0.5%) 928(0.5%) for-loop ...ing-logging/src/core/matcher.rkt:151:6 ---------------------------------------------------------------------------- for-loop [64] 100.0% [69] 298(0.2%) 0(0.0%) ormap ...et/collects/racket/private/map.rkt:105:13 flag-set? [72] 100.0% ---------------------------------------------------------------------------- matcher [60] 100.0% [70] 298(0.2%) 0(0.0%) for-loop ...ng-logging/src/core/matcher.rkt:183:21 matcher [60] 100.0% ---------------------------------------------------------------------------- map-enodes [118] 0.1% match-e [133] 0.5% parse-loop12 [115] 0.7% for-loop [134] 0.9% make-exacts* [58] 1.8% ??? [106] 1.9% map [65] 2.0% loop! [147] 3.1% f137 [25] 6.3% loop [71] 82.6% [71] 69010(39.1%) 2382(1.3%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [71] 82.6% option-on-expr [73] 6.3% ??? [90] 3.6% loop! [147] 2.6% hash-ref! [95] 1.9% parse-loop12 [115] 0.5% ??? [7] 0.2% ??? [94] 0.2% ??? [92] 0.1% for-loop [125] 0.1% ---------------------------------------------------------------------------- ormap [69] 100.0% [72] 298(0.2%) 0(0.0%) flag-set? .../sampling-logging/src/config.rkt:34:0 return/no-unsupplied [172] 100.0% ---------------------------------------------------------------------------- loop [71] 49.8% f137 [25] 50.2% [73] 11676(6.6%) 0(0.0%) option-on-expr ...gging/src/core/regimes.rkt:103:0 sindices->spoints [74] 79.6% sort-context-on-expr [75] 11.6% err-lsts->split-indices [76] 8.8% ---------------------------------------------------------------------------- option-on-expr [73] 100.0% [74] 9292(5.3%) 0(0.0%) sindices->spoints ...ng/src/core/regimes.rkt:116:0 loop [77] 100.0% ---------------------------------------------------------------------------- option-on-expr [73] 100.0% [75] 1360(0.8%) 0(0.0%) sort-context-on-expr ...gging/src/points.rkt:115:0 ??? [79] 73.5% for-loop [80] 26.5% ---------------------------------------------------------------------------- option-on-expr [73] 100.0% [76] 1024(0.6%) 0(0.0%) err-lsts->split-indices .../core/regimes.rkt:222:0 add-splitpoint [78] 100.0% ---------------------------------------------------------------------------- sindices->spoints [74] 100.0% [77] 9292(5.3%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:36:19 sidx->spoint [81] 100.0% ---------------------------------------------------------------------------- err-lsts->split-indices [76] 100.0% [78] 1024(0.6%) 0(0.0%) add-splitpoint ...gging/src/core/regimes.rkt:235:2 for-loop [82] 100.0% ---------------------------------------------------------------------------- sort-context-on-expr [75] 100.0% [79] 1000(0.6%) 0(0.0%) ??? ...cket/collects/racket/private/sort.rkt:403:3 generic-sort/key [83] 100.0% ---------------------------------------------------------------------------- sort-context-on-expr [75] 100.0% [80] 360(0.2%) 360(0.2%) for-loop ...sampling-logging/src/points.rkt:116:19 ---------------------------------------------------------------------------- loop [77] 100.0% [81] 9292(5.3%) 0(0.0%) sidx->spoint ...logging/src/core/regimes.rkt:126:2 binary-search [84] 70.9% binary-search-floats [85] 29.1% ---------------------------------------------------------------------------- add-splitpoint [78] 100.0% [82] 1024(0.6%) 334(0.2%) for-loop ...ing-logging/src/core/regimes.rkt:237:4 for-loop [87] 67.4% ---------------------------------------------------------------------------- ??? [79] 100.0% [83] 1000(0.6%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:185:2 copying-mergesort [86] 100.0% ---------------------------------------------------------------------------- sidx->spoint [81] 100.0% [84] 6592(3.7%) 0(0.0%) binary-search ...ling-logging/src/common.rkt:226:0 pred [88] 100.0% ---------------------------------------------------------------------------- sidx->spoint [81] 100.0% [85] 2700(1.5%) 0(0.0%) binary-search-floats ...gging/src/common.rkt:241:0 pred [88] 100.0% ---------------------------------------------------------------------------- generic-sort/key [83] 33.0% copying-mergesort [86] 67.0% [86] 1000(0.6%) 0(0.0%) copying-mergesort ...racket/private/sort.rkt:130:8 copying-mergesort [86] 67.0% jloop [8] 17.0% loop [89] 16.1% ---------------------------------------------------------------------------- for-loop [82] 100.0% [87] 690(0.4%) 690(0.4%) for-loop ...ing-logging/src/core/regimes.rkt:241:8 ---------------------------------------------------------------------------- binary-search-floats [85] 29.1% binary-search [84] 70.9% [88] 9292(5.3%) 0(0.0%) pred ...mpling-logging/src/core/regimes.rkt:132:17 loop [46] 92.9% errors [59] 7.1% ---------------------------------------------------------------------------- copying-mergesort [86] 100.0% [89] 322(0.2%) 0(0.0%) loop ...ket/collects/racket/private/sort.rkt:97:12 ??? [90] 100.0% ---------------------------------------------------------------------------- loop [89] 0.6% jloop [8] 1.2% map [65] 2.5% for-loop [66] 12.0% loop [71] 83.8% [90] 56346(31.9%) 360(0.2%) ??? ...bie/sampling-logging/src/programs.rkt:154:4 ??? [91] 90.9% ??? [96] 7.9% ??? [92] 0.6% ---------------------------------------------------------------------------- ??? [90] 100.0% [91] 51192(29.0%) 7660(4.3%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [94] 77.3% ??? [97] 6.4% ??? [183] 0.6% ---------------------------------------------------------------------------- for-loop [63] 6.1% ??? [90] 6.2% loop [16] 6.3% location-do [93] 6.3% for-loop [49] 6.3% eval-prog [67] 12.9% loop [71] 19.1% f137 [25] 31.2% [92] 5384(3.0%) 986(0.6%) ??? ...tract/private/arrow-higher-order.rkt:342:33 location-do [93] 31.5% ??? [96] 12.3% ->bf [98] 6.8% ??? [181] 6.7% approximate9 [5] 6.3% hash-ref! [95] 6.3% ...gging/src/common.rkt:47:2 [163] 6.2% best-alt [99] 5.5% ---------------------------------------------------------------------------- for-loop [35] 1.6% ??? [92] 2.0% get-sigs [157] 2.6% for-loop [101] 20.0% location-do [93] 26.9% ??? [39] 46.2% [93] 108982(61.7%) 3490(2.0%) location-do ...acket/private/norm-define.rkt:53:83 iterate-egraph!13 [100] 43.8% location-do [93] 26.9% for-loop [101] 20.0% ??? [102] 3.4% loop [3] 2.6% ??? [92] 0.8% return/no-unsupplied [172] 0.5% mk-egraph [6] 0.3% ??? [174] 0.1% ---------------------------------------------------------------------------- loop [71] 2.2% ??? [91] 97.8% [94] 40480(22.9%) 36408(20.6%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bflog [104] 7.1% bfadd [107] 2.9% ---------------------------------------------------------------------------- for-loop [20] 1.2% for-loop [126] 1.2% for-loop [18] 2.1% ??? [109] 3.3% ??? [7] 7.8% localize-error [31] 7.8% ??? [92] 9.0% loop [71] 14.4% compile [43] 18.3% eval-prog [67] 33.9% [95] 5746(3.3%) 708(0.4%) hash-ref! ...racket/private/more-scheme.rkt:373:13 bigfloat-hash [105] 33.9% ??? [106] 20.4% simplify [108] 9.0% parse-loop12 [115] 7.8% f137 [25] 7.8% ??? [109] 3.3% ??? [9] 2.1% ??? [11] 1.2% ??? [10] 1.2% ---------------------------------------------------------------------------- ??? [92] 12.9% ??? [90] 87.1% [96] 5120(2.9%) 0(0.0%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [103] 93.4% integer->bigfloat [110] 6.6% ---------------------------------------------------------------------------- ??? [91] 100.0% [97] 3266(1.8%) 1938(1.1%) ??? ...mpling-logging/src/syntax/syntax.rkt:153:17 return/no-unsupplied [172] 29.6% ??? [174] 11.1% ---------------------------------------------------------------------------- ??? [92] 100.0% [98] 368(0.2%) 0(0.0%) ->bf ...bie/sampling-logging/src/programs.rkt:51:0 ??? [34] 100.0% ---------------------------------------------------------------------------- ??? [92] 100.0% [99] 296(0.2%) 0(0.0%) best-alt ...bie/sampling-logging/src/glue.rkt:71:0 argmins [111] 100.0% ---------------------------------------------------------------------------- location-do [93] 100.0% [100] 97902(55.4%) 298(0.2%) iterate-egraph!13 ...g/src/core/simplify.rkt:102:0 one-iter [112] 99.0% map-enodes [118] 0.7% ---------------------------------------------------------------------------- location-do [93] 100.0% [101] 45926(26.0%) 0(0.0%) for-loop ...ng-logging/src/core/simplify.rkt:63:12 location-do [93] 100.0% ---------------------------------------------------------------------------- hash-has-key? [41] 24.3% location-do [93] 75.7% [102] 13862(7.8%) 4628(2.6%) ??? ...ects/racket/contract/private/list.rkt:737:4 for-loop [113] 57.1% arrow-higher-order:lnp [124] 5.0% ??? [123] 4.6% ---------------------------------------------------------------------------- ??? [96] 100.0% [103] 4784(2.7%) 3736(2.1%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [116] 21.9% ---------------------------------------------------------------------------- ??? [94] 100.0% [104] 2888(1.6%) 2536(1.4%) bflog ...-lib/math/private/bigfloat/mpfr.rkt:616:4 ??? [116] 12.2% ---------------------------------------------------------------------------- hash-ref! [95] 100.0% [105] 2774(1.6%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:165:0 bfcanonicalize [114] 63.4% sig+exp->bigfloat [117] 36.6% ---------------------------------------------------------------------------- hash-ref! [95] 100.0% [106] 1760(1.0%) 344(0.2%) ??? ...bie/sampling-logging/src/programs.rkt:183:5 loop [71] 80.5% ---------------------------------------------------------------------------- ??? [94] 100.0% [107] 1184(0.7%) 1184(0.7%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ---------------------------------------------------------------------------- hash-ref! [95] 100.0% [108] 1024(0.6%) 0(0.0%) simplify ...pling-logging/src/core/reduce.rkt:16:0 parse-loop12 [115] 35.5% f137 [25] 32.4% debug-print [119] 32.0% ---------------------------------------------------------------------------- hash-ref! [95] 100.0% [109] 696(0.4%) 0(0.0%) ??? .../sampling-logging/src/core/taylor.rkt:44:15 hash-ref! [95] 100.0% ---------------------------------------------------------------------------- ??? [96] 100.0% [110] 336(0.2%) 336(0.2%) integer->bigfloat ...ivate/bigfloat/mpfr.rkt:399:0 ---------------------------------------------------------------------------- best-alt [99] 100.0% [111] 296(0.2%) 0(0.0%) argmins ...e/sampling-logging/src/common.rkt:150:0 composed [120] 100.0% ---------------------------------------------------------------------------- iterate-egraph!13 [100] 100.0% [112] 96914(54.9%) 0(0.0%) one-iter ...ng-logging/src/core/simplify.rkt:113:0 loop [121] 69.4% for-loop [122] 26.1% apply-match [127] 4.5% ---------------------------------------------------------------------------- ??? [102] 100.0% [113] 7910(4.5%) 3630(2.1%) for-loop ...acket/contract/private/list.rkt:743:12 ??? [123] 32.5% for-loop [166] 16.9% arrow-higher-order:lnp [124] 4.7% ---------------------------------------------------------------------------- bigfloat-hash [105] 100.0% [114] 1758(1.0%) 1758(1.0%) bfcanonicalize .../private/bigfloat/mpfr.rkt:155:0 ---------------------------------------------------------------------------- loop [71] 7.6% parse-loop12 [115] 7.6% simplify [108] 7.6% for-loop [19] 20.9% hash-ref! [95] 56.3% [115] 1592(0.9%) 364(0.2%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 loop [71] 63.9% for-loop [126] 20.9% parse-loop12 [115] 7.6% ---------------------------------------------------------------------------- bflog [104] 25.1% real->bigfloat [103] 74.9% [116] 1400(0.8%) 1400(0.8%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ---------------------------------------------------------------------------- bigfloat-hash [105] 100.0% [117] 1016(0.6%) 1016(0.6%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:385:0 ---------------------------------------------------------------------------- iterate-egraph!13 [100] 100.0% [118] 690(0.4%) 0(0.0%) map-enodes ...ng-logging/src/core/egraph.rkt:139:0 loop [71] 51.9% for-loop [125] 48.1% ---------------------------------------------------------------------------- make-exacts* [58] 49.2% simplify [108] 50.8% [119] 646(0.4%) 646(0.4%) debug-print ...ampling-logging/src/debug.rkt:107:0 ---------------------------------------------------------------------------- argmins [111] 100.0% [120] 296(0.2%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 errors [59] 100.0% ---------------------------------------------------------------------------- one-iter [112] 100.0% [121] 67268(38.1%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [127] 100.0% ---------------------------------------------------------------------------- for-loop [122] 48.7% one-iter [112] 51.3% [122] 25288(14.3%) 4086(2.3%) for-loop ...g-logging/src/core/simplify.rkt:123:12 for-loop [122] 48.7% match-e [133] 41.9% ---------------------------------------------------------------------------- ??? [102] 19.7% for-loop [113] 80.3% [123] 3206(1.8%) 1290(0.7%) ??? ...private/unconstrained-domain-arrow.rkt:74:4 make-keyword-procedure [128] 59.8% ---------------------------------------------------------------------------- for-loop [113] 34.7% ??? [102] 65.3% [124] 1060(0.6%) 0(0.0%) arrow-higher-order:lnp ...w-higher-order.rkt:597:7 ??? [129] 100.0% ---------------------------------------------------------------------------- map-enodes [118] 48.1% loop [71] 51.9% [125] 690(0.4%) 0(0.0%) for-loop ...ng-logging/src/core/simplify.rkt:173:2 compose [130] 51.9% eval-const-expr [131] 48.1% ---------------------------------------------------------------------------- parse-loop12 [115] 100.0% [126] 332(0.2%) 0(0.0%) for-loop ...ing-logging/src/core/taylor.rkt:490:59 hash-ref! [95] 100.0% ---------------------------------------------------------------------------- one-iter [112] 6.1% loop [121] 93.9% [127] 71626(40.5%) 0(0.0%) apply-match ...logging/src/core/simplify.rkt:130:2 for-loop [132] 89.5% match-e [133] 9.0% update-leader! [140] 1.5% ---------------------------------------------------------------------------- ??? [123] 100.0% [128] 1916(1.1%) 1916(1.1%) make-keyword-procedure ...ket/private/kw.rkt:260:4 ---------------------------------------------------------------------------- arrow-higher-order:lnp [124] 100.0% [129] 1060(0.6%) 1060(0.6%) ??? ...et/contract/private/arity-checking.rkt:19:2 ---------------------------------------------------------------------------- for-loop [125] 100.0% [130] 358(0.2%) 358(0.2%) compose ...collects/racket/private/list.rkt:385:12 ---------------------------------------------------------------------------- for-loop [125] 100.0% [131] 332(0.2%) 0(0.0%) eval-const-expr ...-logging/src/programs.rkt:166:0 f137 [25] 100.0% ---------------------------------------------------------------------------- apply-match [127] 100.0% [132] 64108(36.3%) 720(0.4%) for-loop ...g-logging/src/core/simplify.rkt:145:10 merge-egraph-nodes! [135] 30.2% mk-enode! [138] 27.0% loop! [147] 26.8% substitute-e [136] 12.9% list-member? [137] 2.1% ---------------------------------------------------------------------------- apply-match [127] 15.7% for-loop [139] 25.6% for-loop [122] 58.7% [133] 27650(15.7%) 5808(3.3%) match-e ...mpling-logging/src/core/ematch.rkt:46:0 for-loop [134] 59.2% ??? [34] 6.9% for-loop [139] 6.0% variable? [4] 3.9% list-cartesian-product [141] 3.2% loop [71] 0.7% ---------------------------------------------------------------------------- match-e [133] 100.0% [134] 20836(11.8%) 8184(4.6%) for-loop ...ling-logging/src/core/ematch.rkt:59:11 for-loop [139] 56.3% list-cartesian-product [141] 7.9% loop [71] 3.8% ---------------------------------------------------------------------------- for-loop [142] 1.6% merge-egraph-nodes! [135] 5.1% for-loop [132] 93.3% [135] 19390(11.0%) 350(0.2%) merge-egraph-nodes! ...g/src/core/egraph.rkt:152:0 update-leader! [140] 54.8% loop! [147] 17.2% for-loop [142] 8.7% for-loop [143] 7.0% enode-merge! [145] 5.3% merge-egraph-nodes! [135] 5.1% ---------------------------------------------------------------------------- substitute-e [136] 9.5% for-loop [132] 90.5% [136] 8242(4.7%) 362(0.2%) substitute-e ...g-logging/src/core/ematch.rkt:71:0 mk-enode! [138] 83.6% substitute-e [136] 9.5% variable? [4] 3.5% ??? [34] 1.2% ---------------------------------------------------------------------------- for-loop [132] 100.0% [137] 1322(0.7%) 0(0.0%) list-member? ...llects/racket/private/set.rkt:24:0 loop [144] 100.0% ---------------------------------------------------------------------------- expr->enode [17] 3.8% substitute-e [136] 27.4% for-loop [132] 68.8% [138] 25120(14.2%) 1412(0.8%) mk-enode! ...ing-logging/src/core/egraph.rkt:101:0 new-enode [146] 89.2% hash-has-key? [41] 2.7% mutable-set [152] 2.5% ---------------------------------------------------------------------------- match-e [133] 17.4% for-loop [134] 82.6% [139] 14810(8.4%) 1704(1.0%) for-loop ...ling-logging/src/core/ematch.rkt:65:37 match-e [133] 84.8% ??? [150] 4.8% ---------------------------------------------------------------------------- apply-match [127] 8.5% merge-egraph-nodes! [135] 91.5% [140] 12620(7.1%) 1704(1.0%) update-leader! ...ogging/src/core/egraph.rkt:217:0 for-loop [148] 86.5% ---------------------------------------------------------------------------- match-e [133] 26.2% list-cartesian-product [141] 26.3% for-loop [134] 47.5% [141] 2718(1.5%) 2046(1.2%) list-cartesian-product ...src/core/ematch.rkt:20:0 list-cartesian-product [141] 26.3% for-loop [151] 18.1% ---------------------------------------------------------------------------- merge-egraph-nodes! [135] 100.0% [142] 2004(1.1%) 0(0.0%) for-loop ...ing-logging/src/core/egraph.rkt:200:10 loop! [147] 68.5% merge-egraph-nodes! [135] 31.5% ---------------------------------------------------------------------------- merge-egraph-nodes! [135] 100.0% [143] 1360(0.8%) 994(0.6%) for-loop ...ling-logging/src/core/egraph.rkt:232:6 update-en-expr [171] 26.9% ---------------------------------------------------------------------------- list-member? [137] 100.0% [144] 1322(0.7%) 1322(0.7%) loop (unknown source) ---------------------------------------------------------------------------- merge-egraph-nodes! [135] 100.0% [145] 1036(0.6%) 322(0.2%) enode-merge! ...g-logging/src/core/enode.rkt:129:0 adopt-enode! [149] 68.9% ---------------------------------------------------------------------------- mk-enode! [138] 100.0% [146] 22400(12.7%) 316(0.2%) new-enode ...pling-logging/src/core/enode.rkt:97:0 type-of-enode-expr [153] 95.7% set [156] 1.4% ---------------------------------------------------------------------------- for-loop [142] 3.9% merge-egraph-nodes! [135] 12.2% loop [71] 27.7% for-loop [132] 56.2% [147] 22244(12.6%) 3634(2.1%) loop! ...sampling-logging/src/core/enode.rkt:192:2 custom-set-union [155] 39.1% loop [71] 33.1% set [156] 12.4% update-en-expr [171] 5.2% ---------------------------------------------------------------------------- update-leader! [140] 100.0% [148] 10916(6.2%) 720(0.4%) for-loop ...ling-logging/src/core/egraph.rkt:222:6 for-loop [154] 93.4% ---------------------------------------------------------------------------- enode-merge! [145] 100.0% [149] 714(0.4%) 714(0.4%) adopt-enode! ...g-logging/src/core/enode.rkt:105:0 ---------------------------------------------------------------------------- for-loop [139] 100.0% [150] 708(0.4%) 708(0.4%) ??? ...e/sampling-logging/src/core/ematch.rkt:50:5 ---------------------------------------------------------------------------- list-cartesian-product [141] 100.0% [151] 672(0.4%) 672(0.4%) for-loop ...pling-logging/src/core/ematch.rkt:24:8 ---------------------------------------------------------------------------- mk-enode! [138] 100.0% [152] 638(0.4%) 638(0.4%) mutable-set .../racket/private/set-types.rkt:999:0 ---------------------------------------------------------------------------- new-enode [146] 100.0% [153] 21444(12.1%) 316(0.2%) type-of-enode-expr ...ging/src/core/enode.rkt:68:0 get-sigs [157] 98.5% ---------------------------------------------------------------------------- for-loop [148] 100.0% [154] 10196(5.8%) 0(0.0%) for-loop ...ling-logging/src/core/egraph.rkt:223:8 hash-update! [158] 100.0% ---------------------------------------------------------------------------- loop! [147] 100.0% [155] 9212(5.2%) 3406(1.9%) custom-set-union ...et/private/set-types.rkt:168:0 for-loop [159] 59.1% for-loop [160] 3.9% ---------------------------------------------------------------------------- new-enode [146] 5.3% loop! [147] 94.7% [156] 5938(3.4%) 5938(3.4%) set ...collects/racket/private/set-types.rkt:981:0 ---------------------------------------------------------------------------- type-of-enode-expr [153] 100.0% [157] 21128(12.0%) 662(0.4%) get-sigs ...ampling-logging/src/type-check.rkt:5:0 location-do [93] 40.4% ??? [162] 29.1% ...gging/src/common.rkt:47:2 [163] 14.7% ??? [34] 12.7% ---------------------------------------------------------------------------- for-loop [154] 100.0% [158] 10196(5.8%) 0(0.0%) hash-update! ...ket/private/more-scheme.rkt:362:13 ??? [161] 100.0% ---------------------------------------------------------------------------- custom-set-union [155] 100.0% [159] 5448(3.1%) 2358(1.3%) for-loop ...cts/racket/private/set-types.rkt:174:3 for-loop [164] 56.7% ---------------------------------------------------------------------------- custom-set-union [155] 100.0% [160] 358(0.2%) 358(0.2%) for-loop ...cts/racket/private/set-types.rkt:152:2 ---------------------------------------------------------------------------- hash-update! [158] 100.0% [161] 10196(5.8%) 0(0.0%) ??? ...sampling-logging/src/core/egraph.rkt:225:24 for-loop [165] 100.0% ---------------------------------------------------------------------------- get-sigs [157] 100.0% [162] 6140(3.5%) 0(0.0%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 for-loop [166] 62.0% ??? [168] 32.2% get/build-late-neg-projection [186] 5.8% ---------------------------------------------------------------------------- ??? [92] 8.3% for-loop [35] 15.5% get-sigs [157] 76.3% [163] 4068(2.3%) 668(0.4%) ...gging/src/common.rkt:47:2 ...e/arr-i.rkt:906:19 ??? [167] 51.8% ??? [169] 31.8% ---------------------------------------------------------------------------- for-loop [159] 100.0% [164] 3090(1.7%) 3090(1.7%) for-loop ...cts/racket/private/set-types.rkt:178:5 ---------------------------------------------------------------------------- ??? [161] 100.0% [165] 10196(5.8%) 7476(4.2%) for-loop ...ing-logging/src/core/egraph.rkt:226:26 update-en-expr [171] 26.7% ---------------------------------------------------------------------------- for-loop [113] 26.0% ??? [162] 74.0% [166] 5146(2.9%) 1374(0.8%) for-loop ...racket/contract/private/hash.rkt:239:6 ??? [170] 66.8% ??? [183] 6.5% ---------------------------------------------------------------------------- for-loop [179] 8.5% ??? [170] 17.2% ...gging/src/common.rkt:47:2 [163] 74.3% [167] 2106(1.2%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:342:4 ??? [170] 74.3% ??? [181] 25.7% ---------------------------------------------------------------------------- ??? [162] 100.0% [168] 1976(1.1%) 0(0.0%) ??? ...ects/racket/contract/private/hash.rkt:217:4 ??? [173] 100.0% ---------------------------------------------------------------------------- ...gging/src/common.rkt:47:2 [163] 100.0% [169] 1294(0.7%) 0(0.0%) ??? ...s/racket/contract/private/arr-i.rkt:1268:39 return/no-unsupplied [172] 53.3% ??? [174] 23.5% assoc-ref [175] 23.2% ---------------------------------------------------------------------------- ??? [167] 38.0% for-loop [166] 62.0% [170] 5544(3.1%) 684(0.4%) ??? ...cts/racket/contract/private/list.rkt:187:10 ??? [176] 56.2% for-loop [179] 18.4% ??? [167] 13.1% ---------------------------------------------------------------------------- for-loop [143] 6.7% loop! [147] 43.9% for-loop [165] 49.5% [171] 5500(3.1%) 5500(3.1%) update-en-expr ...ogging/src/core/egraph.rkt:211:0 ---------------------------------------------------------------------------- flag-set? [72] 10.1% ??? [169] 23.4% ??? [97] 32.7% location-do [93] 33.9% [172] 2954(1.7%) 1656(0.9%) return/no-unsupplied ...ct/private/arr-i.rkt:533:0 filter [178] 43.9% ---------------------------------------------------------------------------- ??? [168] 100.0% [173] 1976(1.1%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:169:2 ??? [177] 100.0% ---------------------------------------------------------------------------- ??? [169] 30.5% location-do [93] 33.3% ??? [97] 36.3% [174] 998(0.6%) 304(0.2%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [180] 69.5% ---------------------------------------------------------------------------- ??? [169] 100.0% [175] 300(0.2%) 300(0.2%) assoc-ref ...collects/racket/private/dict.rkt:56:0 ---------------------------------------------------------------------------- ??? [170] 100.0% [176] 3114(1.8%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:686:7 ??? [181] 88.8% ??? [183] 11.2% ---------------------------------------------------------------------------- ??? [173] 100.0% [177] 1976(1.1%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:678:5 for-loop [182] 100.0% ---------------------------------------------------------------------------- return/no-unsupplied [172] 100.0% [178] 1298(0.7%) 1298(0.7%) filter ...t/collects/racket/private/list.rkt:256:2 ---------------------------------------------------------------------------- ??? [170] 100.0% [179] 1022(0.6%) 662(0.4%) for-loop ...acket/contract/private/list.rkt:190:15 ??? [167] 35.2% ---------------------------------------------------------------------------- ??? [174] 100.0% [180] 694(0.4%) 694(0.4%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ---------------------------------------------------------------------------- ??? [92] 8.6% ??? [167] 25.8% ??? [176] 65.7% [181] 4208(2.4%) 3120(1.8%) ??? ...ects/racket/contract/private/guts.rkt:644:8 contract? [185] 17.3% ??? [34] 8.6% ---------------------------------------------------------------------------- ??? [177] 100.0% [182] 1976(1.1%) 654(0.4%) for-loop ...racket/contract/private/list.rkt:680:9 add-list-context [184] 48.7% get/build-late-neg-projection [186] 18.2% ---------------------------------------------------------------------------- ??? [91] 32.3% for-loop [166] 33.1% ??? [176] 34.7% [183] 1010(0.6%) 326(0.2%) ??? ...ects/racket/contract/private/prop.rkt:493:4 ??? [187] 67.7% ---------------------------------------------------------------------------- for-loop [182] 100.0% [184] 962(0.5%) 962(0.5%) add-list-context ...ontract/private/list.rkt:752:0 ---------------------------------------------------------------------------- ??? [181] 100.0% [185] 728(0.4%) 728(0.4%) contract? ...acket/contract/private/guts.rkt:109:0 ---------------------------------------------------------------------------- ??? [189] 24.9% ??? [162] 24.9% for-loop [182] 50.3% [186] 716(0.4%) 356(0.2%) get/build-late-neg-projection ...te/guts.rkt:691:0 ??? [188] 50.3% ??? [189] 24.9% ---------------------------------------------------------------------------- ??? [183] 100.0% [187] 684(0.4%) 684(0.4%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ---------------------------------------------------------------------------- get/build-late-neg-projection [186]100.0% [188] 360(0.2%) 0(0.0%) ??? ...cts/racket/contract/private/prop.rkt:314:12 build-compound-type-name [190] 100.0% ---------------------------------------------------------------------------- get/build-late-neg-projection [186]100.0% [189] 356(0.2%) 0(0.0%) ??? ...ects/racket/contract/private/hash.rkt:211:2 get/build-late-neg-projection [186]100.0% ---------------------------------------------------------------------------- ??? [188] 100.0% [190] 360(0.2%) 0(0.0%) build-compound-type-name ...private/guts.rkt:448:0 contract-struct-name [191] 100.0% ---------------------------------------------------------------------------- build-compound-type-name [190] 100.0% [191] 360(0.2%) 360(0.2%) contract-struct-name ...ract/private/prop.rkt:89:0 ----------------------------------------------------------------------------