Profiling results ----------------- Total cpu time observed: 36768ms (out of 37780ms) Number of samples taken: 89 (once every 413ms) ======================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================= run [4] 50.0% [1] 36768(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [2] 50.0% loop [7] 47.8% run-improve39 [3] 2.2% ----------------------------------------------------------------------- ??? [1] 100.0% [2] 36768(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [4] 100.0% ----------------------------------------------------------------------- ??? [1] 100.0% [3] 1636(4.4%) 0(0.0%) run-improve39 ...al-sampler/src/mainloop.rkt:287:0 setup-prog!32 [5] 82.0% ??? [6] 18.0% ----------------------------------------------------------------------- profile-thunk16 [2] 100.0% [4] 36768(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ----------------------------------------------------------------------- run-improve39 [3] 100.0% [5] 1342(3.6%) 0(0.0%) setup-prog!32 ...val-sampler/src/mainloop.rkt:63:0 loop [7] 100.0% ----------------------------------------------------------------------- run-improve39 [3] 100.0% [6] 294(0.8%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [8] 100.0% ----------------------------------------------------------------------- setup-prog!32 [5] 3.7% ??? [1] 96.3% [7] 36474(99.2%) 642(1.7%) loop ...e/biginterval-sampler/src/points.rkt:241:2 make-exacts-intervals [9] 88.0% for-loop [10] 10.2% ----------------------------------------------------------------------- ??? [6] 100.0% [8] 294(0.8%) 0(0.0%) for-loop ...al-sampler/src/core/alt-table.rkt:51:2 loop [11] 100.0% ----------------------------------------------------------------------- loop [7] 100.0% [9] 32100(87.3%) 0(0.0%) make-exacts-intervals ...pler/src/points.rkt:182:0 for-loop [12] 98.9% eval-prog [14] 1.1% ----------------------------------------------------------------------- loop [7] 100.0% [10] 3732(10.2%) 0(0.0%) for-loop ...interval-sampler/src/points.rkt:256:19 ??? [30] 80.2% for-loop [13] 19.8% ----------------------------------------------------------------------- for-loop [8] 100.0% [11] 294(0.8%) 0(0.0%) loop ...erval-sampler/src/core/alt-table.rkt:184:2 argmax [15] 100.0% ----------------------------------------------------------------------- make-exacts-intervals [9] 100.0% [12] 31752(86.4%) 0(0.0%) for-loop ...ginterval-sampler/src/points.rkt:185:2 loop [16] 98.0% ??? [20] 2.0% ----------------------------------------------------------------------- for-loop [10] 100.0% [13] 738(2.0%) 320(0.9%) for-loop ...ginterval-sampler/src/points.rkt:233:4 ??? [20] 56.6% ----------------------------------------------------------------------- make-exacts-intervals [9] 100.0% [14] 348(0.9%) 0(0.0%) eval-prog ...terval-sampler/src/programs.rkt:108:0 loop [17] 100.0% ----------------------------------------------------------------------- loop [11] 100.0% [15] 294(0.8%) 0(0.0%) argmax ...92/racket/collects/racket/list.rkt:766:0 for-loop [18] 100.0% ----------------------------------------------------------------------- for-loop [12] 100.0% [16] 31132(84.7%) 322(0.9%) loop ...e/biginterval-sampler/src/points.rkt:167:2 ??? [19] 97.9% ??? [20] 1.0% ----------------------------------------------------------------------- loop [17] 33.3% expand-capturing-lifts [21] 33.3% eval-prog [14] 33.3% [17] 348(0.9%) 0(0.0%) loop (unknown source) expand-capturing-lifts [21] 33.3% loop [17] 33.3% for-loop [22] 33.3% ----------------------------------------------------------------------- argmax [15] 100.0% [18] 294(0.8%) 0(0.0%) for-loop ...nterval-sampler/src/programs.rkt:183:2 table-ref [23] 100.0% ----------------------------------------------------------------------- loop [16] 100.0% [19] 30492(82.9%) 0(0.0%) ??? .../biginterval-sampler/src/programs.rkt:124:2 ??? [24] 87.6% ??? [30] 12.4% ----------------------------------------------------------------------- loop [16] 23.5% for-loop [13] 30.8% for-loop [12] 45.7% [20] 1356(3.7%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [25] 69.2% sample-multi-bounded [26] 30.8% ----------------------------------------------------------------------- loop [17] 100.0% [21] 348(0.9%) 0(0.0%) expand-capturing-lifts (unknown source) loop [17] 100.0% ----------------------------------------------------------------------- run-module-instance!125 [28] 50.0% loop [17] 50.0% [22] 348(0.9%) 0(0.0%) for-loop (unknown source) run-module-instance!125 [28] 50.0% [running body] [27] 50.0% ----------------------------------------------------------------------- for-loop [18] 100.0% [23] 294(0.8%) 0(0.0%) table-ref ...ginterval-sampler/src/common.rkt:47:0 ??? [29] 100.0% ----------------------------------------------------------------------- ??? [19] 100.0% [24] 26710(72.6%) 350(1.0%) ??? ...acket/collects/racket/private/kw.rkt:592:14 ??? [30] 98.7% ----------------------------------------------------------------------- ??? [20] 100.0% [25] 938(2.6%) 938(2.6%) ->flonum ...interval-sampler/src/programs.rkt:36:0 ----------------------------------------------------------------------- ??? [20] 100.0% [26] 418(1.1%) 418(1.1%) sample-multi-bounded ...ampler/src/points.rkt:43:0 ----------------------------------------------------------------------- for-loop [22] 100.0% [27] 348(0.9%) 348(0.9%) [running body] ...ket/base-env/unit-prims.rkt":##f ----------------------------------------------------------------------- for-loop [22] 100.0% [28] 348(0.9%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [22] 100.0% ----------------------------------------------------------------------- table-ref [23] 100.0% [29] 294(0.8%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:798:4 ??? [44] 100.0% ----------------------------------------------------------------------- for-loop [10] 9.0% ??? [19] 11.4% ??? [24] 79.6% [30] 33136(90.1%) 3642(9.9%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-div [31] 44.4% mk-ival [32] 15.4% ival-sub [33] 13.6% ival-log [34] 12.2% ival-neg [35] 3.5% ----------------------------------------------------------------------- ??? [30] 100.0% [31] 14704(40.0%) 3956(10.8%) ival-div ...rval-sampler/src/biginterval.rkt:104:0 ??? [43] 31.6% bfmax* [37] 22.2% bfmin* [38] 8.8% foldl [41] 6.5% ...higher-order.rkt:357:33 [40] 2.0% ...higher-order.rkt:361:33 [42] 2.0% ----------------------------------------------------------------------- ??? [30] 100.0% [32] 5098(13.9%) 302(0.8%) mk-ival ...terval-sampler/src/biginterval.rkt:51:0 bf [36] 94.1% ----------------------------------------------------------------------- ??? [30] 100.0% [33] 4510(12.3%) 1042(2.8%) ival-sub ...erval-sampler/src/biginterval.rkt:81:0 ??? [43] 76.9% ----------------------------------------------------------------------- ??? [30] 100.0% [34] 4038(11.0%) 788(2.1%) ival-log ...rval-sampler/src/biginterval.rkt:121:0 ??? [43] 72.6% force [39] 7.9% ----------------------------------------------------------------------- ??? [30] 100.0% [35] 1144(3.1%) 0(0.0%) ival-neg ...erval-sampler/src/biginterval.rkt:71:0 ??? [43] 100.0% ----------------------------------------------------------------------- mk-ival [32] 100.0% [36] 4796(13.0%) 622(1.7%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [48] 74.2% ??? [49] 12.8% ----------------------------------------------------------------------- ival-div [31] 100.0% [37] 3262(8.9%) 0(0.0%) bfmax* ...nterval-sampler/src/biginterval.rkt:90:0 foldl [41] 89.3% ...higher-order.rkt:361:33 [42] 10.7% ----------------------------------------------------------------------- ival-div [31] 100.0% [38] 1294(3.5%) 0(0.0%) bfmin* ...nterval-sampler/src/biginterval.rkt:87:0 foldl [41] 100.0% ----------------------------------------------------------------------- ival-log [34] 100.0% [39] 318(0.9%) 318(0.9%) force ...collects/racket/private/promise.rkt:109:0 ----------------------------------------------------------------------- ival-div [31] 100.0% [40] 298(0.8%) 0(0.0%) ...higher-order.rkt:357:33 (unknown source) ??? [44] 100.0% ----------------------------------------------------------------------- ival-div [31] 18.4% bfmin* [38] 25.1% bfmax* [37] 56.5% [41] 5160(14.0%) 394(1.1%) foldl ...et/collects/racket/private/list.rkt:229:4 ??? [43] 92.4% ----------------------------------------------------------------------- ival-div [31] 45.6% bfmax* [37] 54.4% [42] 640(1.7%) 292(0.8%) ...higher-order.rkt:361:33 (unknown source) ??? [44] 54.4% ----------------------------------------------------------------------- ival-neg [35] 6.7% ival-log [34] 17.3% ival-sub [33] 20.4% ival-div [31] 27.4% foldl [41] 28.1% [43] 16960(46.1%) 2404(6.5%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfsub [45] 70.3% bflog [46] 15.5% ----------------------------------------------------------------------- ??? [29] 31.3% ...higher-order.rkt:357:33 [40] 31.7% ...higher-order.rkt:361:33 [42] 37.0% [44] 940(2.6%) 646(1.8%) ??? ...cts/racket/contract/private/list.rkt:209:10 ??? [47] 31.3% ----------------------------------------------------------------------- ??? [43] 100.0% [45] 11926(32.4%) 0(0.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [48] 72.8% ??? [49] 27.2% ----------------------------------------------------------------------- ??? [43] 100.0% [46] 2630(7.2%) 0(0.0%) bflog ...-lib/math/private/bigfloat/mpfr.rkt:618:4 ??? [49] 51.4% new-mpfr [48] 48.6% ----------------------------------------------------------------------- ??? [44] 100.0% [47] 294(0.8%) 294(0.8%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ----------------------------------------------------------------------- bflog [46] 9.4% bf [36] 26.3% bfsub [45] 64.2% [48] 13526(36.8%) 13526(36.8%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ----------------------------------------------------------------------- bf [36] 11.8% bflog [46] 26.0% bfsub [45] 62.2% [49] 5204(14.2%) 5204(14.2%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 -----------------------------------------------------------------------