Profiling results ----------------- Total cpu time observed: 85588ms (out of 87540ms) Number of samples taken: 212 (once every 404ms) ========================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================= run [17] 50.0% [1] 85588(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [9] 50.0% loop [25] 24.0% prepare-points [26] 22.9% run-improve39 [12] 3.1% ------------------------------------------------------------------------- loop [38] 0.4% for-loop [72] 0.4% loop [45] 99.2% [2] 78388(91.6%) 978(1.1%) ??? ...stant-simplification/src/programs.rkt:129:2 ??? [10] 89.1% bf [11] 8.8% ??? [85] 0.4% ??? [54] 0.4% ------------------------------------------------------------------------- ??? [54] 100.0% [3] 318(0.4%) 0(0.0%) ??? ...t-simplification/src/core/simplify.rkt:31:0 iterate-egraph!7 [13] 100.0% ------------------------------------------------------------------------- loop [45] 100.0% [4] 318(0.4%) 0(0.0%) set-precompute! ...ion/src/core/simplify.rkt:140:0 for-loop [14] 100.0% ------------------------------------------------------------------------- for-loop [94] 100.0% [5] 318(0.4%) 0(0.0%) expand-implicit (unknown source) resolve+shift28 [34] 100.0% ------------------------------------------------------------------------- parse-loop14 [84] 1.7% loop [6] 98.3% [6] 308(0.4%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:54:19 loop [6] 98.3% ??? [54] 1.7% ------------------------------------------------------------------------- hash-ref! [78] 100.0% [7] 308(0.4%) 0(0.0%) f8 ...et/collects/racket/match/compiler.rkt:507:40 map [15] 100.0% ------------------------------------------------------------------------- for-loop [94] 100.0% [8] 164(0.2%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [16] 100.0% ------------------------------------------------------------------------- ??? [1] 100.0% [9] 85588(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [17] 100.0% ------------------------------------------------------------------------- ??? [2] 100.0% [10] 69880(81.6%) 3544(4.1%) ??? ...acket/collects/racket/private/kw.rkt:592:14 ??? [46] 92.4% ??? [20] 1.7% ??? [22] 0.5% ??? [54] 0.4% ------------------------------------------------------------------------- ??? [2] 100.0% [11] 6870(8.0%) 348(0.4%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [89] 68.7% ??? [76] 26.3% ------------------------------------------------------------------------- ??? [1] 100.0% [12] 5272(6.2%) 0(0.0%) run-improve39 ...lification/src/mainloop.rkt:286:0 setup-prog!32 [18] 63.1% for-loop [19] 36.9% ------------------------------------------------------------------------- ??? [3] 100.0% [13] 318(0.4%) 0(0.0%) iterate-egraph!7 ...ion/src/core/simplify.rkt:55:0 map-enodes [23] 100.0% ------------------------------------------------------------------------- set-precompute! [4] 100.0% [14] 318(0.4%) 0(0.0%) for-loop ...lification/src/core/simplify.rkt:142:2 eval-const-expr [24] 100.0% ------------------------------------------------------------------------- f8 [7] 100.0% [15] 308(0.4%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:35:13 hash-ref! [78] 100.0% ------------------------------------------------------------------------- syntax-e [8] 100.0% [16] 164(0.2%) 0(0.0%) syntax-e/no-taint (unknown source) loop [21] 100.0% ------------------------------------------------------------------------- profile-thunk16 [9] 100.0% [17] 85588(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------- run-improve39 [12] 100.0% [18] 3324(3.9%) 0(0.0%) setup-prog!32 ...plification/src/mainloop.rkt:63:0 prepare-points [26] 48.9% loop [25] 39.0% ??? [41] 12.1% ------------------------------------------------------------------------- run-improve39 [12] 100.0% [19] 1948(2.3%) 368(0.4%) for-loop ...-simplification/src/mainloop.rkt:303:8 run-iter! [27] 81.1% ------------------------------------------------------------------------- ??? [10] 100.0% [20] 1166(1.4%) 1166(1.4%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ------------------------------------------------------------------------- syntax-e/no-taint [16] 35.3% for-loop [94] 64.7% [21] 464(0.5%) 0(0.0%) loop (unknown source) expand-id-application-form17 [29] 64.7% gf [30] 35.3% ------------------------------------------------------------------------- ??? [10] 100.0% [22] 322(0.4%) 0(0.0%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ??? [28] 100.0% ------------------------------------------------------------------------- iterate-egraph!7 [13] 100.0% [23] 318(0.4%) 0(0.0%) map-enodes ...lification/src/core/egraph.rkt:140:0 loop [45] 100.0% ------------------------------------------------------------------------- for-loop [14] 100.0% [24] 318(0.4%) 0(0.0%) eval-const-expr ...fication/src/programs.rkt:132:0 eval-prog [71] 100.0% ------------------------------------------------------------------------- setup-prog!32 [18] 3.1% ??? [1] 96.9% [25] 42462(49.6%) 0(0.0%) loop ...nstant-simplification/src/points.rkt:180:2 loop [38] 35.4% loop [31] 29.4% make-exacts* [39] 28.8% for-loop [32] 6.3% ------------------------------------------------------------------------- setup-prog!32 [18] 4.0% ??? [1] 96.0% [26] 40776(47.6%) 0(0.0%) prepare-points ...plification/src/points.rkt:156:0 loop [31] 36.4% make-exacts* [39] 32.6% loop [38] 30.1% for-loop [32] 0.8% ------------------------------------------------------------------------- for-loop [19] 100.0% [27] 1580(1.8%) 0(0.0%) run-iter! ...simplification/src/mainloop.rkt:267:0 finalize-iter! [33] 39.6% gen-rewrites! [35] 20.8% simplify! [36] 20.1% localize-error [37] 19.5% ------------------------------------------------------------------------- ??? [22] 100.0% [28] 322(0.4%) 322(0.4%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ------------------------------------------------------------------------- loop [21] 100.0% [29] 300(0.4%) 0(0.0%) expand-id-application-form17 (unknown source) resolve+shift28 [34] 100.0% ------------------------------------------------------------------------- loop [21] 100.0% [30] 164(0.2%) 164(0.2%) gf (unknown source) ------------------------------------------------------------------------- loop [25] 45.7% prepare-points [26] 54.3% [31] 27360(32.0%) 0(0.0%) loop ...nstant-simplification/src/points.rkt:124:2 loop [38] 59.4% make-exacts* [39] 40.6% ------------------------------------------------------------------------- prepare-points [26] 10.8% loop [25] 89.2% [32] 3024(3.5%) 0(0.0%) for-loop ...t-simplification/src/points.rkt:195:19 ??? [40] 100.0% ------------------------------------------------------------------------- run-iter! [27] 100.0% [33] 626(0.7%) 0(0.0%) finalize-iter! ...ification/src/mainloop.rkt:221:0 ??? [41] 100.0% ------------------------------------------------------------------------- expand-id-application-form17 [29] 48.5% expand-implicit [5] 51.5% [34] 618(0.7%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [42] 100.0% ------------------------------------------------------------------------- run-iter! [27] 100.0% [35] 328(0.4%) 0(0.0%) gen-rewrites! ...lification/src/mainloop.rkt:164:0 for-loop [43] 100.0% ------------------------------------------------------------------------- run-iter! [27] 100.0% [36] 318(0.4%) 0(0.0%) simplify! ...simplification/src/mainloop.rkt:181:0 for-loop [44] 100.0% ------------------------------------------------------------------------- run-iter! [27] 100.0% [37] 308(0.4%) 0(0.0%) localize-error ...ation/src/core/localize.rkt:47:0 hash-ref! [78] 100.0% ------------------------------------------------------------------------- prepare-points [26] 28.2% loop [25] 34.5% loop [31] 37.3% [38] 43592(50.9%) 0(0.0%) loop ...nstant-simplification/src/points.rkt:107:4 loop [45] 99.3% ??? [2] 0.7% ------------------------------------------------------------------------- loop [31] 30.3% loop [25] 33.3% prepare-points [26] 36.3% [39] 36622(42.8%) 0(0.0%) make-exacts* ...implification/src/points.rkt:104:0 loop [45] 97.8% eval-prog [71] 2.2% ------------------------------------------------------------------------- for-loop [32] 100.0% [40] 3024(3.5%) 1678(2.0%) ??? ...onstant-simplification/src/points.rkt:172:7 ??? [46] 44.5% ------------------------------------------------------------------------- setup-prog!32 [18] 39.1% finalize-iter! [33] 60.9% [41] 1028(1.2%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [47] 60.9% make-alt-table [48] 39.1% ------------------------------------------------------------------------- resolve+shift28 [34] 100.0% [42] 618(0.7%) 0(0.0%) fallback-loop (unknown source) for-loop [94] 100.0% ------------------------------------------------------------------------- gen-rewrites! [35] 100.0% [43] 328(0.4%) 0(0.0%) for-loop ...simplification/src/mainloop.rkt:169:11 ??? [49] 100.0% ------------------------------------------------------------------------- simplify! [36] 100.0% [44] 318(0.4%) 0(0.0%) for-loop ...-simplification/src/mainloop.rkt:185:6 for-loop [50] 100.0% ------------------------------------------------------------------------- map-enodes [23] 0.1% parse-loop14 [84] 0.4% ??? [82] 0.8% loop [38] 1.2% make-exacts* [39] 1.8% loop [45] 95.7% [45] 80354(93.9%) 332(0.4%) loop ...cket/collects/racket/private/map.rkt:40:19 loop [45] 95.7% ??? [2] 2.9% hash-ref! [78] 1.2% set-precompute! [4] 0.1% ??? [54] 0.1% ------------------------------------------------------------------------- ??? [40] 2.0% ??? [10] 98.0% [46] 65898(77.0%) 2024(2.4%) ??? ...tract/private/arrow-higher-order.rkt:361:33 bf-complex-exp [51] 51.2% bf-complex-div [52] 36.4% bf-complex-add [53] 6.4% bf-complex-neg [55] 2.9% ------------------------------------------------------------------------- ??? [41] 100.0% [47] 626(0.7%) 0(0.0%) for-loop ...lification/src/core/alt-table.rkt:51:2 atab-add-altn [56] 100.0% ------------------------------------------------------------------------- ??? [41] 100.0% [48] 402(0.5%) 0(0.0%) make-alt-table ...tion/src/core/alt-table.rkt:32:0 errors [65] 100.0% ------------------------------------------------------------------------- for-loop [43] 100.0% [49] 328(0.4%) 0(0.0%) ??? ...ant-simplification/src/alternative.rkt:60:0 rewriter [57] 100.0% ------------------------------------------------------------------------- for-loop [44] 100.0% [50] 318(0.4%) 0(0.0%) for-loop ...-simplification/src/mainloop.rkt:209:8 ??? [54] 100.0% ------------------------------------------------------------------------- ??? [46] 100.0% [51] 33730(39.4%) 476(0.6%) bf-complex-exp ...fication/src/bigcomplex.rkt:41:0 ??? [64] 83.4% bf* [58] 15.2% ------------------------------------------------------------------------- ??? [46] 100.0% [52] 24014(28.1%) 796(0.9%) bf-complex-div ...fication/src/bigcomplex.rkt:58:0 ??? [64] 53.1% bf* [58] 39.2% ...higher-order.rkt:361:33 [60] 4.4% ------------------------------------------------------------------------- ??? [46] 100.0% [53] 4222(4.9%) 626(0.7%) bf-complex-add ...fication/src/bigcomplex.rkt:24:0 ??? [64] 77.5% ...higher-order.rkt:361:33 [60] 7.7% ------------------------------------------------------------------------- location-do [63] 7.0% for-loop [50] 7.0% ??? [10] 13.0% loop [6] 13.5% ??? [2] 14.3% loop [45] 45.1% [54] 2274(2.7%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [59] 73.0% ??? [85] 13.0% location-do [63] 7.0% ??? [3] 7.0% ------------------------------------------------------------------------- ??? [46] 100.0% [55] 1908(2.2%) 0(0.0%) bf-complex-neg ...fication/src/bigcomplex.rkt:21:0 ??? [64] 100.0% ------------------------------------------------------------------------- for-loop [47] 100.0% [56] 626(0.7%) 0(0.0%) atab-add-altn ...tion/src/core/alt-table.rkt:210:0 best-and-tied-at-points [61] 100.0% ------------------------------------------------------------------------- ??? [49] 33.3% matcher [68] 66.7% [57] 328(0.4%) 0(0.0%) rewriter ...plification/src/core/matcher.rkt:131:2 for-loop [62] 100.0% ------------------------------------------------------------------------- bf-complex-exp [51] 35.3% bf-complex-div [52] 64.7% [58] 14544(17.0%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [64] 100.0% ------------------------------------------------------------------------- ??? [54] 100.0% [59] 1660(1.9%) 982(1.1%) ->flonum ...t-simplification/src/programs.rkt:36:0 ??? [66] 40.8% ------------------------------------------------------------------------- bf-complex-add [53] 23.4% bf-complex-div [52] 76.6% [60] 1386(1.6%) 0(0.0%) ...higher-order.rkt:361:33 (unknown source) ??? [77] 100.0% ------------------------------------------------------------------------- atab-add-altn [56] 100.0% [61] 626(0.7%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:122:0 errors [65] 100.0% ------------------------------------------------------------------------- rewriter [57] 100.0% [62] 328(0.4%) 0(0.0%) for-loop ...lification/src/core/matcher.rkt:134:10 matcher [68] 66.7% type-of [67] 33.3% ------------------------------------------------------------------------- ??? [54] 100.0% [63] 318(0.4%) 0(0.0%) location-do ...implification/src/programs.rkt:90:0 ??? [54] 100.0% ------------------------------------------------------------------------- bf-complex-neg [55] 3.1% bf-complex-add [53] 5.4% bf-complex-div [52] 21.0% bf* [58] 24.0% bf-complex-exp [51] 46.4% [64] 60590(70.8%) 22524(26.3%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [69] 43.3% bfneg [70] 19.5% ------------------------------------------------------------------------- make-alt-table [48] 39.1% best-and-tied-at-points [61] 60.9% [65] 1028(1.2%) 0(0.0%) errors ...tant-simplification/src/points.rkt:203:0 for-loop [72] 70.8% eval-prog [71] 29.2% ------------------------------------------------------------------------- ->flonum [59] 100.0% [66] 678(0.8%) 358(0.4%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ??? [75] 47.2% ------------------------------------------------------------------------- for-loop [62] 100.0% [67] 328(0.4%) 0(0.0%) type-of ...-simplification/src/type-check.rkt:34:0 for-loop [73] 100.0% ------------------------------------------------------------------------- for-loop [74] 50.0% for-loop [62] 50.0% [68] 328(0.4%) 0(0.0%) matcher ...mplification/src/core/matcher.rkt:168:2 for-loop [74] 50.0% rewriter [57] 50.0% ------------------------------------------------------------------------- ??? [64] 100.0% [69] 26262(30.7%) 1350(1.6%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [89] 56.5% ??? [76] 38.3% ------------------------------------------------------------------------- ??? [64] 100.0% [70] 11804(13.8%) 994(1.2%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [89] 64.7% ??? [76] 26.8% ------------------------------------------------------------------------- errors [65] 21.2% eval-const-expr [24] 22.5% make-exacts* [39] 56.2% [71] 1412(1.6%) 0(0.0%) eval-prog ...simplification/src/programs.rkt:109:0 temp68_2 [79] 55.4% hash-ref! [78] 44.6% ------------------------------------------------------------------------- errors [65] 100.0% [72] 728(0.9%) 402(0.5%) for-loop ...nt-simplification/src/points.rkt:206:4 ??? [2] 44.8% ------------------------------------------------------------------------- type-of [67] 100.0% [73] 328(0.4%) 0(0.0%) for-loop ...racket/contract/private/hash.rkt:277:6 ??? [77] 100.0% ------------------------------------------------------------------------- matcher [68] 100.0% [74] 328(0.4%) 0(0.0%) for-loop ...lification/src/core/matcher.rkt:184:21 matcher [68] 100.0% ------------------------------------------------------------------------- ??? [66] 100.0% [75] 320(0.4%) 320(0.4%) ??? ...ects/racket/contract/private/prop.rkt:274:4 ------------------------------------------------------------------------- bf [11] 12.0% bfneg [70] 21.1% bfmul [69] 66.9% [76] 15034(17.6%) 15034(17.6%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------- for-loop [73] 19.1% ...higher-order.rkt:361:33 [60] 80.9% [77] 1714(2.0%) 1010(1.2%) ??? ...cts/racket/contract/private/list.rkt:209:10 ??? [85] 21.9% ??? [83] 19.1% ------------------------------------------------------------------------- map [15] 10.9% localize-error [37] 10.9% eval-prog [71] 19.7% loop [45] 58.4% [78] 938(1.1%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [82] 47.5% parse-loop14 [84] 21.9% bigfloat-hash [81] 19.7% f8 [7] 10.9% ------------------------------------------------------------------------- eval-prog [71] 100.0% [79] 782(0.9%) 0(0.0%) temp68_2 (unknown source) compile16 [80] 100.0% ------------------------------------------------------------------------- temp68_2 [79] 100.0% [80] 782(0.9%) 0(0.0%) compile16 (unknown source) temp74_0 [86] 100.0% ------------------------------------------------------------------------- hash-ref! [78] 100.0% [81] 630(0.7%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bfcanonicalize [87] 52.1% sig+exp->bigfloat [88] 47.9% ------------------------------------------------------------------------- hash-ref! [78] 100.0% [82] 630(0.7%) 0(0.0%) ??? ...stant-simplification/src/programs.rkt:153:5 loop [45] 100.0% ------------------------------------------------------------------------- ??? [77] 100.0% [83] 328(0.4%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:747:7 ??? [85] 100.0% ------------------------------------------------------------------------- hash-ref! [78] 100.0% [84] 308(0.4%) 0(0.0%) parse-loop14 ...s/racket/match/compiler.rkt:418:15 loop [45] 50.0% loop [6] 50.0% ------------------------------------------------------------------------- ??? [54] 22.2% ??? [83] 24.6% ??? [2] 25.0% ??? [77] 28.2% [85] 1334(1.6%) 1334(1.6%) ??? ...ects/racket/contract/private/guts.rkt:746:8 ------------------------------------------------------------------------- compile16 [80] 100.0% [86] 782(0.9%) 0(0.0%) temp74_0 (unknown source) expand-single [90] 100.0% ------------------------------------------------------------------------- bigfloat-hash [81] 100.0% [87] 328(0.4%) 328(0.4%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 ------------------------------------------------------------------------- bigfloat-hash [81] 100.0% [88] 302(0.4%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:387:0 new-mpfr [89] 100.0% ------------------------------------------------------------------------- sig+exp->bigfloat [88] 1.1% bf [11] 17.1% bfneg [70] 27.8% bfmul [69] 54.0% [89] 27512(32.1%) 27512(32.1%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------- temp74_0 [86] 100.0% [90] 782(0.9%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [91] 100.0% ------------------------------------------------------------------------- expand-single [90] 100.0% [91] 782(0.9%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [92] 100.0% ------------------------------------------------------------------------- expand-capturing-lifts [91] 100.0% [92] 782(0.9%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [93] 100.0% ------------------------------------------------------------------------- lambda-clause-expander [92] 28.3% for-loop [94] 71.7% [93] 782(0.9%) 0(0.0%) finish-bodys (unknown source) for-loop [94] 100.0% ------------------------------------------------------------------------- fallback-loop [42] 11.6% for-loop [94] 18.6% finish-bodys [93] 69.8% [94] 782(0.9%) 618(0.7%) for-loop (unknown source) finish-bodys [93] 51.2% for-loop [94] 18.6% expand-implicit [5] 8.1% syntax-e [8] 7.0% loop [21] 3.5% -------------------------------------------------------------------------