Profiling results ----------------- Total cpu time observed: 16544ms (out of 17120ms) Number of samples taken: 41 (once every 404ms) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== run [9] 50.0% [1] 16544(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [4] 50.0% loop [14] 27.6% prepare-points [5] 20.5% run-improve39 [6] 1.9% ------------------------------------------------------------------------ ??? [33] 100.0% [2] 330(2.0%) 0(0.0%) best-alt ...-simplification/src/mainloop.rkt:108:0 argmins [7] 100.0% ------------------------------------------------------------------------ loop [51] 100.0% [3] 320(1.9%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [8] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [4] 16544(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [9] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [5] 6776(41.0%) 0(0.0%) prepare-points ...plification/src/points.rkt:156:0 loop [22] 33.5% make-exacts* [23] 31.2% loop [18] 30.4% for-loop [11] 4.9% ------------------------------------------------------------------------ ??? [1] 100.0% [6] 626(3.8%) 0(0.0%) run-improve39 ...lification/src/mainloop.rkt:286:0 for-loop [12] 52.7% setup-prog!32 [13] 47.3% ------------------------------------------------------------------------ best-alt [2] 100.0% [7] 330(2.0%) 0(0.0%) argmins ...ant-simplification/src/common.rkt:142:0 ??? [10] 100.0% ------------------------------------------------------------------------ syntax-e [3] 100.0% [8] 320(1.9%) 0(0.0%) syntax-e/no-taint (unknown source) loop [51] 100.0% ------------------------------------------------------------------------ profile-thunk16 [4] 100.0% [9] 16544(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------ argmins [7] 100.0% [10] 330(2.0%) 0(0.0%) ??? ...tant-simplification/src/mainloop.rkt:110:19 errors [15] 100.0% ------------------------------------------------------------------------ prepare-points [5] 100.0% [11] 330(2.0%) 0(0.0%) for-loop ...t-simplification/src/points.rkt:195:19 ??? [16] 100.0% ------------------------------------------------------------------------ run-improve39 [6] 100.0% [12] 330(2.0%) 0(0.0%) for-loop ...-simplification/src/mainloop.rkt:303:8 run-iter! [17] 100.0% ------------------------------------------------------------------------ run-improve39 [6] 100.0% [13] 296(1.8%) 0(0.0%) setup-prog!32 ...plification/src/mainloop.rkt:63:0 loop [14] 100.0% ------------------------------------------------------------------------ setup-prog!32 [13] 3.1% ??? [1] 96.9% [14] 9438(57.0%) 0(0.0%) loop ...nstant-simplification/src/points.rkt:180:2 loop [22] 45.1% make-exacts* [23] 44.8% loop [18] 10.2% ------------------------------------------------------------------------ ??? [10] 100.0% [15] 330(2.0%) 0(0.0%) errors ...tant-simplification/src/points.rkt:203:0 for-loop [20] 100.0% ------------------------------------------------------------------------ for-loop [11] 100.0% [16] 330(2.0%) 0(0.0%) ??? ...onstant-simplification/src/points.rkt:172:7 for-loop [19] 100.0% ------------------------------------------------------------------------ for-loop [12] 100.0% [17] 330(2.0%) 0(0.0%) run-iter! ...simplification/src/mainloop.rkt:267:0 choose-best-alt! [21] 100.0% ------------------------------------------------------------------------ loop [14] 31.7% prepare-points [5] 68.3% [18] 3020(18.3%) 0(0.0%) loop ...nstant-simplification/src/points.rkt:124:2 loop [22] 67.5% make-exacts* [23] 32.5% ------------------------------------------------------------------------ ??? [16] 100.0% [19] 330(2.0%) 0(0.0%) for-loop ...nt-simplification/src/points.rkt:173:9 ??? [33] 100.0% ------------------------------------------------------------------------ errors [15] 100.0% [20] 330(2.0%) 0(0.0%) for-loop ...nt-simplification/src/points.rkt:206:4 ??? [29] 100.0% ------------------------------------------------------------------------ run-iter! [17] 100.0% [21] 330(2.0%) 0(0.0%) choose-best-alt! ...ication/src/mainloop.rkt:113:0 ??? [24] 100.0% ------------------------------------------------------------------------ loop [18] 23.8% prepare-points [5] 26.5% loop [14] 49.7% [22] 8560(51.7%) 0(0.0%) loop ...nstant-simplification/src/points.rkt:107:4 loop [25] 96.0% loop [27] 4.0% ------------------------------------------------------------------------ loop [18] 13.4% prepare-points [5] 28.9% loop [14] 57.7% [23] 7324(44.3%) 0(0.0%) make-exacts* ...implification/src/points.rkt:104:0 loop [25] 87.2% eval-prog [26] 12.8% ------------------------------------------------------------------------ choose-best-alt! [21] 100.0% [24] 330(2.0%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 ??? [28] 100.0% ------------------------------------------------------------------------ loop [22] 0.3% make-exacts* [23] 2.3% loop [25] 97.4% [25] 14606(88.3%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:40:19 loop [25] 97.4% ??? [29] 2.5% ??? [33] 0.1% ------------------------------------------------------------------------ make-exacts* [23] 100.0% [26] 938(5.7%) 0(0.0%) eval-prog ...simplification/src/programs.rkt:109:0 temp68_2 [30] 100.0% ------------------------------------------------------------------------ loop [22] 100.0% [27] 340(2.1%) 340(2.1%) loop ...cket/collects/racket/private/map.rkt:277:4 ------------------------------------------------------------------------ ??? [24] 100.0% [28] 330(2.0%) 0(0.0%) ??? ...-simplification/src/core/alt-table.rkt:54:0 ??? [33] 100.0% ------------------------------------------------------------------------ for-loop [20] 2.3% loop [25] 97.7% [29] 14652(88.6%) 646(3.9%) ??? ...stant-simplification/src/programs.rkt:129:2 bf [31] 64.4% ??? [32] 29.0% ??? [33] 2.3% ------------------------------------------------------------------------ eval-prog [26] 100.0% [30] 938(5.7%) 0(0.0%) temp68_2 (unknown source) compile16 [34] 100.0% ------------------------------------------------------------------------ ??? [29] 100.0% [31] 9432(57.0%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [47] 59.2% ??? [48] 40.8% ------------------------------------------------------------------------ ??? [29] 100.0% [32] 4244(25.7%) 1678(10.1%) ??? ...acket/collects/racket/private/kw.rkt:592:14 bf* [35] 42.0% ??? [39] 18.5% ------------------------------------------------------------------------ ??? [29] 17.5% ??? [28] 17.5% loop [25] 30.1% for-loop [19] 35.0% [33] 944(5.7%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [37] 47.6% sample-multi-bounded [38] 35.0% best-alt [2] 17.5% ------------------------------------------------------------------------ temp68_2 [30] 100.0% [34] 938(5.7%) 0(0.0%) compile16 (unknown source) temp74_0 [36] 100.0% ------------------------------------------------------------------------ ??? [32] 100.0% [35] 1782(10.8%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [39] 100.0% ------------------------------------------------------------------------ compile16 [34] 100.0% [36] 938(5.7%) 0(0.0%) temp74_0 (unknown source) expand-single [40] 64.8% compile-top9 [42] 35.2% ------------------------------------------------------------------------ ??? [33] 100.0% [37] 614(3.7%) 614(3.7%) ->flonum ...t-simplification/src/programs.rkt:36:0 ------------------------------------------------------------------------ ??? [33] 100.0% [38] 330(2.0%) 0(0.0%) sample-multi-bounded ...cation/src/points.rkt:43:0 loop [41] 100.0% ------------------------------------------------------------------------ ??? [32] 30.6% bf* [35] 69.4% [39] 2566(15.5%) 764(4.6%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [43] 70.2% ------------------------------------------------------------------------ temp74_0 [36] 100.0% [40] 608(3.7%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [44] 100.0% ------------------------------------------------------------------------ sample-multi-bounded [38] 100.0% [41] 330(2.0%) 0(0.0%) loop ...onstant-simplification/src/points.rkt:65:6 random-exp [45] 100.0% ------------------------------------------------------------------------ temp74_0 [36] 100.0% [42] 330(2.0%) 0(0.0%) compile-top9 (unknown source) compile-forms31 [46] 100.0% ------------------------------------------------------------------------ ??? [39] 100.0% [43] 1802(10.9%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 ??? [48] 60.6% new-mpfr [47] 39.4% ------------------------------------------------------------------------ expand-single [40] 100.0% [44] 608(3.7%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [49] 100.0% ------------------------------------------------------------------------ loop [41] 100.0% [45] 330(2.0%) 330(2.0%) random-exp ...-simplification/src/common.rkt:243:0 ------------------------------------------------------------------------ compile-top9 [42] 100.0% [46] 330(2.0%) 0(0.0%) compile-forms31 (unknown source) loop! [50] 100.0% ------------------------------------------------------------------------ bfmul [43] 11.3% bf [31] 88.7% [47] 6294(38.0%) 6294(38.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------ bfmul [43] 22.1% bf [31] 77.9% [48] 4940(29.9%) 4940(29.9%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------ expand-capturing-lifts [44] 100.0% [49] 608(3.7%) 0(0.0%) lambda-clause-expander (unknown source) loop [51] 100.0% ------------------------------------------------------------------------ compile-forms31 [46] 100.0% [50] 330(2.0%) 0(0.0%) loop! (unknown source) for-loop [52] 100.0% ------------------------------------------------------------------------ syntax-e/no-taint [8] 17.5% apply-transformer52 [55] 17.5% lambda-clause-expander [49] 64.9% [51] 608(3.7%) 0(0.0%) loop (unknown source) dispatch-transformer41 [53] 64.9% syntax-e [3] 17.5% gf [54] 17.5% ------------------------------------------------------------------------ loop! [50] 100.0% [52] 330(2.0%) 330(2.0%) for-loop (unknown source) ------------------------------------------------------------------------ loop [51] 100.0% [53] 608(3.7%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [55] 100.0% ------------------------------------------------------------------------ loop [51] 100.0% [54] 320(1.9%) 320(1.9%) gf (unknown source) ------------------------------------------------------------------------ dispatch-transformer41 [53] 100.0% [55] 608(3.7%) 0(0.0%) apply-transformer52 (unknown source) loop [51] 52.6% apply-transformer-in-context [56] 47.4% ------------------------------------------------------------------------ apply-transformer52 [55] 100.0% [56] 288(1.7%) 0(0.0%) apply-transformer-in-context (unknown source) go [57] 100.0% ------------------------------------------------------------------------ apply-transformer-in-context [56]100.0% [57] 288(1.7%) 0(0.0%) go .../collects/racket/private/qq-and-or.rkt:50:20 loop [58] 100.0% ------------------------------------------------------------------------ go [57] 100.0% [58] 288(1.7%) 288(1.7%) loop ...llects/racket/private/qq-and-or.rkt:101:61 ------------------------------------------------------------------------