Profiling results ----------------- Total cpu time observed: 13120ms (out of 13420ms) Number of samples taken: 43 (once every 305ms) ========================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================= run [5] 50.0% [1] 13120(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [2] 50.0% loop [30] 27.1% get-final-combination [3] 13.0% run-improve39 [4] 9.9% ------------------------------------------------------------------------- ??? [1] 100.0% [2] 13120(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [3] 3406(26.0%) 0(0.0%) get-final-combination ...er/src/mainloop.rkt:310:0 infer-splitpoints [7] 57.5% f34 [8] 34.4% ??? [58] 8.1% ------------------------------------------------------------------------- ??? [1] 100.0% [4] 2606(19.9%) 0(0.0%) run-improve39 ...al-sampler/src/mainloop.rkt:287:0 for-loop [6] 88.2% ??? [18] 11.8% ------------------------------------------------------------------------- profile-thunk16 [2] 100.0% [5] 13120(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------- run-improve39 [4] 100.0% [6] 2298(17.5%) 0(0.0%) for-loop ...nterval-sampler/src/mainloop.rkt:304:8 run-iter! [9] 100.0% ------------------------------------------------------------------------- get-final-combination [3] 100.0% [7] 1958(14.9%) 0(0.0%) infer-splitpoints ...ler/src/core/regimes.rkt:32:0 for-loop [10] 100.0% ------------------------------------------------------------------------- get-final-combination [3] 100.0% [8] 1172(8.9%) 0(0.0%) f34 ...t/collects/racket/match/compiler.rkt:507:40 sindices->spoints [11] 100.0% ------------------------------------------------------------------------- for-loop [6] 100.0% [9] 2298(17.5%) 0(0.0%) run-iter! ...terval-sampler/src/mainloop.rkt:268:0 simplify! [13] 54.8% finalize-iter! [15] 33.2% gen-rewrites! [16] 12.0% ------------------------------------------------------------------------- infer-splitpoints [7] 100.0% [10] 1958(14.9%) 0(0.0%) for-loop ...rval-sampler/src/core/regimes.rkt:44:6 option-on-expr [12] 100.0% ------------------------------------------------------------------------- f34 [8] 100.0% [11] 1172(8.9%) 0(0.0%) sindices->spoints ...er/src/core/regimes.rkt:177:0 for-loop [14] 100.0% ------------------------------------------------------------------------- for-loop [10] 100.0% [12] 1958(14.9%) 0(0.0%) option-on-expr ...mpler/src/core/regimes.rkt:112:0 err-lsts->split-indices [19] 42.1% sort-context-on-expr [21] 29.3% for-loop [22] 28.6% ------------------------------------------------------------------------- run-iter! [9] 100.0% [13] 1260(9.6%) 0(0.0%) simplify! ...terval-sampler/src/mainloop.rkt:182:0 for-loop [17] 100.0% ------------------------------------------------------------------------- sindices->spoints [11] 100.0% [14] 1172(8.9%) 0(0.0%) for-loop ...val-sampler/src/core/regimes.rkt:209:9 binary-search-floats [20] 51.0% pred [25] 49.0% ------------------------------------------------------------------------- run-iter! [9] 100.0% [15] 762(5.8%) 0(0.0%) finalize-iter! ...l-sampler/src/mainloop.rkt:222:0 ??? [18] 100.0% ------------------------------------------------------------------------- run-iter! [9] 100.0% [16] 276(2.1%) 0(0.0%) gen-rewrites! ...al-sampler/src/mainloop.rkt:165:0 for-loop [23] 100.0% ------------------------------------------------------------------------- simplify! [13] 100.0% [17] 1260(9.6%) 0(0.0%) for-loop ...nterval-sampler/src/mainloop.rkt:186:6 for-loop [24] 100.0% ------------------------------------------------------------------------- run-improve39 [4] 28.8% finalize-iter! [15] 71.2% [18] 1070(8.2%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [26] 100.0% ------------------------------------------------------------------------- option-on-expr [12] 100.0% [19] 824(6.3%) 0(0.0%) err-lsts->split-indices .../core/regimes.rkt:238:0 loop [27] 100.0% ------------------------------------------------------------------------- for-loop [14] 100.0% [20] 598(4.6%) 0(0.0%) binary-search-floats ...src/core/regimes.rkt:158:0 pred [25] 100.0% ------------------------------------------------------------------------- option-on-expr [12] 100.0% [21] 574(4.4%) 0(0.0%) sort-context-on-expr ...ampler/src/points.rkt:90:0 ??? [28] 100.0% ------------------------------------------------------------------------- option-on-expr [12] 100.0% [22] 560(4.3%) 0(0.0%) for-loop ...val-sampler/src/core/regimes.rkt:120:4 errors [42] 100.0% ------------------------------------------------------------------------- gen-rewrites! [16] 100.0% [23] 276(2.1%) 0(0.0%) for-loop ...terval-sampler/src/mainloop.rkt:170:11 ??? [29] 100.0% ------------------------------------------------------------------------- for-loop [17] 100.0% [24] 1260(9.6%) 0(0.0%) for-loop ...nterval-sampler/src/mainloop.rkt:210:8 ??? [56] 100.0% ------------------------------------------------------------------------- for-loop [14] 49.0% binary-search-floats [20] 51.0% [25] 1172(8.9%) 272(2.1%) pred ...nterval-sampler/src/core/regimes.rkt:185:4 loop [30] 50.9% errors [42] 25.9% ------------------------------------------------------------------------- ??? [18] 100.0% [26] 1070(8.2%) 0(0.0%) for-loop ...al-sampler/src/core/alt-table.rkt:51:2 atab-add-altn [31] 100.0% ------------------------------------------------------------------------- err-lsts->split-indices [19] 100.0% [27] 824(6.3%) 0(0.0%) loop ...nterval-sampler/src/core/regimes.rkt:289:4 for-loop [32] 100.0% ------------------------------------------------------------------------- sort-context-on-expr [21] 100.0% [28] 574(4.4%) 0(0.0%) ??? ...cket/collects/racket/private/sort.rkt:369:3 loop [43] 51.6% generic-sort/key [33] 48.4% ------------------------------------------------------------------------- for-loop [23] 100.0% [29] 276(2.1%) 0(0.0%) ??? ...iginterval-sampler/src/alternative.rkt:60:0 rewriter [34] 100.0% ------------------------------------------------------------------------- pred [25] 7.7% ??? [1] 92.3% [30] 7704(58.7%) 0(0.0%) loop ...e/biginterval-sampler/src/points.rkt:241:2 make-exacts-intervals [35] 100.0% ------------------------------------------------------------------------- for-loop [26] 100.0% [31] 1070(8.2%) 0(0.0%) atab-add-altn ...pler/src/core/alt-table.rkt:210:0 best-and-tied-at-points [37] 52.7% override-at-pnts [38] 47.3% ------------------------------------------------------------------------- loop [27] 100.0% [32] 824(6.3%) 0(0.0%) for-loop ...val-sampler/src/core/regimes.rkt:254:4 for-loop [36] 100.0% ------------------------------------------------------------------------- ??? [28] 100.0% [33] 278(2.1%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:156:2 copying-mergesort [39] 100.0% ------------------------------------------------------------------------- ??? [29] 33.3% matcher [45] 66.7% [34] 276(2.1%) 0(0.0%) rewriter ...val-sampler/src/core/matcher.rkt:131:2 for-loop [40] 100.0% ------------------------------------------------------------------------- loop [30] 100.0% [35] 7704(58.7%) 0(0.0%) make-exacts-intervals ...pler/src/points.rkt:182:0 for-loop [41] 100.0% ------------------------------------------------------------------------- for-loop [32] 100.0% [36] 824(6.3%) 824(6.3%) for-loop ...val-sampler/src/core/regimes.rkt:258:8 ------------------------------------------------------------------------- atab-add-altn [31] 100.0% [37] 564(4.3%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:122:0 errors [42] 100.0% ------------------------------------------------------------------------- atab-add-altn [31] 100.0% [38] 506(3.9%) 0(0.0%) override-at-pnts ...r/src/core/alt-table.rkt:145:0 errors [42] 50.2% make-sequence [46] 49.8% ------------------------------------------------------------------------- generic-sort/key [33] 100.0% [39] 278(2.1%) 0(0.0%) copying-mergesort ...racket/private/sort.rkt:129:8 loop [43] 100.0% ------------------------------------------------------------------------- rewriter [34] 100.0% [40] 276(2.1%) 0(0.0%) for-loop ...al-sampler/src/core/matcher.rkt:134:10 matcher [45] 66.7% type-of [44] 33.3% ------------------------------------------------------------------------- make-exacts-intervals [35] 100.0% [41] 7704(58.7%) 0(0.0%) for-loop ...ginterval-sampler/src/points.rkt:185:2 loop [47] 96.1% ??? [56] 3.9% ------------------------------------------------------------------------- override-at-pnts [38] 15.1% pred [25] 18.1% for-loop [22] 33.3% best-and-tied-at-points [37] 33.5% [42] 1682(12.8%) 0(0.0%) errors ...biginterval-sampler/src/points.rkt:282:0 for-loop [48] 81.9% eval-prog [49] 18.1% ------------------------------------------------------------------------- copying-mergesort [39] 48.4% ??? [28] 51.6% [43] 574(4.4%) 0(0.0%) loop ...ket/collects/racket/private/sort.rkt:96:12 ??? [53] 100.0% ------------------------------------------------------------------------- for-loop [40] 100.0% [44] 276(2.1%) 0(0.0%) type-of ...nterval-sampler/src/type-check.rkt:34:0 for-loop [50] 100.0% ------------------------------------------------------------------------- for-loop [51] 50.0% for-loop [40] 50.0% [45] 276(2.1%) 0(0.0%) matcher ...rval-sampler/src/core/matcher.rkt:168:2 for-loop [51] 50.0% rewriter [34] 50.0% ------------------------------------------------------------------------- override-at-pnts [38] 100.0% [46] 252(1.9%) 0(0.0%) make-sequence ...ects/racket/private/for.rkt:528:2 ??? [52] 100.0% ------------------------------------------------------------------------- for-loop [41] 100.0% [47] 7406(56.4%) 0(0.0%) loop ...e/biginterval-sampler/src/points.rkt:167:2 ??? [53] 96.7% ??? [56] 3.3% ------------------------------------------------------------------------- errors [42] 100.0% [48] 1378(10.5%) 0(0.0%) for-loop ...ginterval-sampler/src/points.rkt:285:4 ??? [53] 79.8% ??? [56] 20.2% ------------------------------------------------------------------------- errors [42] 100.0% [49] 304(2.3%) 0(0.0%) eval-prog ...terval-sampler/src/programs.rkt:108:0 inductor [54] 100.0% ------------------------------------------------------------------------- type-of [44] 100.0% [50] 276(2.1%) 0(0.0%) for-loop ...racket/contract/private/hash.rkt:277:6 ??? [76] 100.0% ------------------------------------------------------------------------- matcher [45] 100.0% [51] 276(2.1%) 0(0.0%) for-loop ...al-sampler/src/core/matcher.rkt:184:21 matcher [45] 100.0% ------------------------------------------------------------------------- make-sequence [46] 100.0% [52] 252(1.9%) 252(1.9%) ??? ...cket/collects/racket/private/for.rkt:1203:9 ------------------------------------------------------------------------- loop [43] 6.5% for-loop [48] 12.5% loop [47] 81.0% [53] 8832(67.3%) 0(0.0%) ??? .../biginterval-sampler/src/programs.rkt:124:2 ??? [55] 84.9% ??? [57] 9.0% ??? [56] 6.0% ------------------------------------------------------------------------- eval-prog [49] 100.0% [54] 304(2.3%) 0(0.0%) inductor ...nterval-sampler/src/programs.rkt:113:4 table-ref [96] 100.0% ------------------------------------------------------------------------- ??? [53] 100.0% [55] 7502(57.2%) 1142(8.7%) ??? ...acket/collects/racket/private/kw.rkt:592:14 ??? [57] 84.8% ------------------------------------------------------------------------- loop [47] 9.5% for-loop [48] 10.6% for-loop [41] 11.4% ??? [53] 20.3% location-do [60] 24.1% for-loop [24] 24.1% [56] 2616(19.9%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [59] 51.8% location-do [60] 24.1% ??? [58] 24.1% ------------------------------------------------------------------------- ??? [53] 11.1% ??? [55] 88.9% [57] 7158(54.6%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-mult [61] 67.5% ival-sqrt [62] 21.4% mk-ival [64] 11.1% ------------------------------------------------------------------------- get-final-combination [3] 18.0% ??? [56] 82.0% [58] 1536(11.7%) 0(0.0%) ??? ...interval-sampler/src/core/simplify.rkt:31:0 iterate-egraph!7 [63] 82.0% loop [66] 18.0% ------------------------------------------------------------------------- ??? [56] 100.0% [59] 1356(10.3%) 1058(8.1%) ->flonum ...interval-sampler/src/programs.rkt:36:0 ??? [65] 22.0% ------------------------------------------------------------------------- location-do [60] 50.0% ??? [56] 50.0% [60] 1260(9.6%) 0(0.0%) location-do ...erval-sampler/src/programs.rkt:89:0 location-do [60] 50.0% ??? [56] 50.0% ------------------------------------------------------------------------- ??? [57] 100.0% [61] 4830(36.8%) 224(1.7%) ival-mult ...rval-sampler/src/biginterval.rkt:90:0 bf* [67] 54.4% foldl [74] 18.8% bfmax* [70] 11.7% bfmin* [72] 5.3% ...higher-order.rkt:361:33 [73] 5.2% ------------------------------------------------------------------------- ??? [57] 100.0% [62] 1530(11.7%) 294(2.2%) ival-sqrt ...val-sampler/src/biginterval.rkt:130:0 ??? [79] 80.8% ------------------------------------------------------------------------- ??? [58] 100.0% [63] 1260(9.6%) 0(0.0%) iterate-egraph!7 ...ler/src/core/simplify.rkt:55:0 one-iter [68] 100.0% ------------------------------------------------------------------------- ??? [57] 100.0% [64] 798(6.1%) 0(0.0%) mk-ival ...terval-sampler/src/biginterval.rkt:48:0 bf [69] 100.0% ------------------------------------------------------------------------- ->flonum [59] 100.0% [65] 298(2.3%) 298(2.3%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ------------------------------------------------------------------------- ??? [58] 100.0% [66] 276(2.1%) 0(0.0%) loop ...terval-sampler/src/core/simplify.rkt:184:2 for-loop [71] 100.0% ------------------------------------------------------------------------- ival-mult [61] 100.0% [67] 2628(20.0%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [79] 100.0% ------------------------------------------------------------------------- iterate-egraph!7 [63] 100.0% [68] 1260(9.6%) 252(1.9%) one-iter ...val-sampler/src/core/simplify.rkt:66:0 for-loop [75] 59.8% for-loop [78] 20.2% ------------------------------------------------------------------------- mk-ival [64] 100.0% [69] 798(6.1%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [90] 66.4% ??? [91] 33.6% ------------------------------------------------------------------------- ival-mult [61] 100.0% [70] 566(4.3%) 0(0.0%) bfmax* ...nterval-sampler/src/biginterval.rkt:87:0 foldl [74] 100.0% ------------------------------------------------------------------------- loop [66] 100.0% [71] 276(2.1%) 0(0.0%) for-loop ...l-sampler/src/core/simplify.rkt:177:29 argmin [77] 100.0% ------------------------------------------------------------------------- ival-mult [61] 100.0% [72] 254(1.9%) 0(0.0%) bfmin* ...nterval-sampler/src/biginterval.rkt:84:0 foldl [74] 100.0% ------------------------------------------------------------------------- ival-mult [61] 100.0% [73] 250(1.9%) 0(0.0%) ...higher-order.rkt:361:33 (unknown source) ??? [76] 100.0% ------------------------------------------------------------------------- bfmin* [72] 14.7% bfmax* [70] 32.8% ival-mult [61] 52.5% [74] 1728(13.2%) 0(0.0%) foldl ...et/collects/racket/private/list.rkt:229:4 ??? [79] 100.0% ------------------------------------------------------------------------- one-iter [68] 100.0% [75] 754(5.7%) 0(0.0%) for-loop ...al-sampler/src/core/simplify.rkt:113:2 for-loop [80] 100.0% ------------------------------------------------------------------------- ...higher-order.rkt:361:33 [73] 47.5% for-loop [50] 52.5% [76] 526(4.0%) 250(1.9%) ??? ...cts/racket/contract/private/list.rkt:209:10 ??? [81] 52.5% ------------------------------------------------------------------------- for-loop [71] 100.0% [77] 276(2.1%) 0(0.0%) argmin ...92/racket/collects/racket/list.rkt:765:0 for-loop [82] 100.0% ------------------------------------------------------------------------- for-loop [78] 50.0% one-iter [68] 50.0% [78] 254(1.9%) 0(0.0%) for-loop ...al-sampler/src/core/simplify.rkt:76:12 for-loop [78] 50.0% match-e [83] 50.0% ------------------------------------------------------------------------- ival-sqrt [62] 22.1% foldl [74] 30.9% bf* [67] 47.0% [79] 5592(42.6%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [84] 77.9% bfsqrt [85] 22.1% ------------------------------------------------------------------------- for-loop [75] 100.0% [80] 754(5.7%) 0(0.0%) for-loop ...val-sampler/src/core/simplify.rkt:98:4 mk-enode! [86] 66.0% merge-egraph-nodes! [88] 34.0% ------------------------------------------------------------------------- ??? [76] 100.0% [81] 276(2.1%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:747:7 ??? [87] 100.0% ------------------------------------------------------------------------- argmin [77] 100.0% [82] 276(2.1%) 0(0.0%) for-loop ...nterval-sampler/src/programs.rkt:183:2 table-ref [96] 100.0% ------------------------------------------------------------------------- for-loop [78] 100.0% [83] 254(1.9%) 0(0.0%) match-e ...terval-sampler/src/core/ematch.rkt:46:0 for-loop [89] 100.0% ------------------------------------------------------------------------- ??? [79] 100.0% [84] 4356(33.2%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [90] 75.6% ??? [91] 24.4% ------------------------------------------------------------------------- ??? [79] 100.0% [85] 1236(9.4%) 0(0.0%) bfsqrt ...lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [90] 100.0% ------------------------------------------------------------------------- for-loop [80] 100.0% [86] 498(3.8%) 0(0.0%) mk-enode! ...val-sampler/src/core/egraph.rkt:102:0 new-enode [92] 100.0% ------------------------------------------------------------------------- ??? [81] 100.0% [87] 276(2.1%) 276(2.1%) ??? ...ects/racket/contract/private/guts.rkt:746:8 ------------------------------------------------------------------------- for-loop [93] 50.0% for-loop [80] 50.0% [88] 256(2.0%) 0(0.0%) merge-egraph-nodes! ...r/src/core/egraph.rkt:153:0 for-loop [93] 100.0% ------------------------------------------------------------------------- match-e [83] 100.0% [89] 254(1.9%) 254(1.9%) for-loop ...rval-sampler/src/core/ematch.rkt:59:11 ------------------------------------------------------------------------- bf [69] 10.5% bfsqrt [85] 24.4% bfmul [84] 65.1% [90] 5058(38.6%) 5058(38.6%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------- bf [69] 20.1% bfmul [84] 79.9% [91] 1332(10.2%) 1332(10.2%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------- mk-enode! [86] 100.0% [92] 498(3.8%) 0(0.0%) new-enode ...erval-sampler/src/core/enode.rkt:95:0 type-of-enode-expr [94] 100.0% ------------------------------------------------------------------------- merge-egraph-nodes! [88] 100.0% [93] 256(2.0%) 0(0.0%) for-loop ...val-sampler/src/core/egraph.rkt:201:10 merge-egraph-nodes! [88] 50.0% loop! [95] 50.0% ------------------------------------------------------------------------- new-enode [92] 100.0% [94] 498(3.8%) 0(0.0%) type-of-enode-expr ...pler/src/core/enode.rkt:68:0 ...mpler/src/common.rkt:48:2 [98] 50.6% table-ref [96] 49.4% ------------------------------------------------------------------------- for-loop [93] 100.0% [95] 256(2.0%) 0(0.0%) loop! ...interval-sampler/src/core/enode.rkt:190:2 custom-set-union [97] 100.0% ------------------------------------------------------------------------- type-of-enode-expr [94] 29.8% for-loop [82] 33.4% inductor [54] 36.8% [96] 826(6.3%) 0(0.0%) table-ref ...ginterval-sampler/src/common.rkt:47:0 ??? [99] 100.0% ------------------------------------------------------------------------- loop! [95] 100.0% [97] 256(2.0%) 0(0.0%) custom-set-union ...et/private/set-types.rkt:168:0 for-loop [100] 100.0% ------------------------------------------------------------------------- type-of-enode-expr [94] 100.0% [98] 252(1.9%) 0(0.0%) ...mpler/src/common.rkt:48:2 ...e/arr-i.rkt:918:19 ??? [101] 100.0% ------------------------------------------------------------------------- table-ref [96] 100.0% [99] 826(6.3%) 304(2.3%) ??? ...ects/racket/contract/private/list.rkt:798:4 for-loop [102] 63.2% ------------------------------------------------------------------------- custom-set-union [97] 100.0% [100] 256(2.0%) 256(2.0%) for-loop ...cts/racket/private/set-types.rkt:152:2 ------------------------------------------------------------------------- ...mpler/src/common.rkt:48:2 [98]100.0% [101] 252(1.9%) 252(1.9%) ??? ...s/racket/contract/private/arr-i.rkt:1286:39 ------------------------------------------------------------------------- ??? [99] 100.0% [102] 522(4.0%) 246(1.9%) for-loop ...acket/contract/private/list.rkt:804:12 ??? [103] 52.9% ------------------------------------------------------------------------- for-loop [102] 100.0% [103] 276(2.1%) 276(2.1%) ??? ...private/unconstrained-domain-arrow.rkt:74:4 -------------------------------------------------------------------------