Profiling results ----------------- Total cpu time observed: 14324ms (out of 15060ms) Number of samples taken: 40 (once every 358ms) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== run [4] 50.0% [1] 14324(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [2] 50.0% loop [8] 44.6% run-improve39 [3] 5.4% ------------------------------------------------------------------------ ??? [1] 100.0% [2] 14324(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [4] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [3] 1536(10.7%) 0(0.0%) run-improve39 ...al-sampler/src/mainloop.rkt:287:0 setup-prog!32 [5] 56.5% for-loop [6] 30.2% for-loop [7] 13.3% ------------------------------------------------------------------------ profile-thunk16 [2] 100.0% [4] 14324(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------ run-improve39 [3] 100.0% [5] 868(6.1%) 0(0.0%) setup-prog!32 ...val-sampler/src/mainloop.rkt:63:0 loop [8] 100.0% ------------------------------------------------------------------------ run-improve39 [3] 100.0% [6] 464(3.2%) 0(0.0%) for-loop ...terval-sampler/src/mainloop.rkt:299:29 ??? [9] 100.0% ------------------------------------------------------------------------ run-improve39 [3] 100.0% [7] 204(1.4%) 0(0.0%) for-loop ...nterval-sampler/src/mainloop.rkt:304:8 run-iter! [10] 100.0% ------------------------------------------------------------------------ setup-prog!32 [5] 6.4% ??? [1] 93.6% [8] 13656(95.3%) 0(0.0%) loop ...e/biginterval-sampler/src/points.rkt:241:2 make-exacts-intervals [11] 97.3% for-loop [12] 1.9% filter-p&e [16] 0.8% ------------------------------------------------------------------------ for-loop [6] 100.0% [9] 464(3.2%) 0(0.0%) ??? ...interval-sampler/src/core/simplify.rkt:31:0 extract-smallest-best-effort [13] 50.4% iterate-egraph!7 [14] 49.6% ------------------------------------------------------------------------ for-loop [7] 100.0% [10] 204(1.4%) 0(0.0%) run-iter! ...terval-sampler/src/mainloop.rkt:268:0 localize-error [15] 100.0% ------------------------------------------------------------------------ loop [8] 100.0% [11] 13282(92.7%) 0(0.0%) make-exacts-intervals ...pler/src/points.rkt:182:0 for-loop [17] 97.4% eval-prog [18] 2.6% ------------------------------------------------------------------------ loop [8] 100.0% [12] 260(1.8%) 0(0.0%) for-loop ...interval-sampler/src/points.rkt:256:19 for-loop [19] 100.0% ------------------------------------------------------------------------ ??? [9] 100.0% [13] 234(1.6%) 234(1.6%) extract-smallest-best-effort ...simplify.rkt:160:0 ------------------------------------------------------------------------ ??? [9] 100.0% [14] 230(1.6%) 0(0.0%) iterate-egraph!7 ...ler/src/core/simplify.rkt:55:0 one-iter [20] 100.0% ------------------------------------------------------------------------ run-iter! [10] 100.0% [15] 204(1.4%) 0(0.0%) localize-error ...mpler/src/core/localize.rkt:51:0 hash-ref! [21] 100.0% ------------------------------------------------------------------------ loop [8] 100.0% [16] 114(0.8%) 0(0.0%) filter-p&e ...nterval-sampler/src/points.rkt:212:0 for-loop [22] 100.0% ------------------------------------------------------------------------ make-exacts-intervals [11] 100.0% [17] 12936(90.3%) 330(2.3%) for-loop ...ginterval-sampler/src/points.rkt:185:2 loop [23] 94.7% ??? [38] 2.7% ------------------------------------------------------------------------ make-exacts-intervals [11] 100.0% [18] 346(2.4%) 0(0.0%) eval-prog ...terval-sampler/src/programs.rkt:108:0 loop [24] 100.0% ------------------------------------------------------------------------ for-loop [12] 100.0% [19] 260(1.8%) 0(0.0%) for-loop ...ginterval-sampler/src/points.rkt:233:4 ??? [38] 100.0% ------------------------------------------------------------------------ iterate-egraph!7 [14] 100.0% [20] 230(1.6%) 0(0.0%) one-iter ...val-sampler/src/core/simplify.rkt:66:0 for-loop [25] 100.0% ------------------------------------------------------------------------ loop [32] 50.0% localize-error [15] 50.0% [21] 204(1.4%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop14 [26] 100.0% ------------------------------------------------------------------------ filter-p&e [16] 100.0% [22] 114(0.8%) 114(0.8%) for-loop ...ginterval-sampler/src/points.rkt:214:2 ------------------------------------------------------------------------ for-loop [17] 100.0% [23] 12256(85.6%) 0(0.0%) loop ...e/biginterval-sampler/src/points.rkt:167:2 ??? [27] 85.1% ??? [38] 12.9% ??? [30] 2.0% ------------------------------------------------------------------------ loop [24] 33.3% expand-capturing-lifts [28] 33.3% eval-prog [18] 33.3% [24] 346(2.4%) 0(0.0%) loop (unknown source) expand-capturing-lifts [28] 33.3% loop [24] 33.3% for-loop [29] 33.3% ------------------------------------------------------------------------ for-loop [25] 50.0% one-iter [20] 50.0% [25] 230(1.6%) 0(0.0%) for-loop ...al-sampler/src/core/simplify.rkt:76:12 for-loop [25] 50.0% match-e [31] 50.0% ------------------------------------------------------------------------ hash-ref! [21] 100.0% [26] 204(1.4%) 0(0.0%) parse-loop14 ...s/racket/match/compiler.rkt:418:15 loop [32] 100.0% ------------------------------------------------------------------------ loop [23] 100.0% [27] 10424(72.8%) 0(0.0%) ??? .../biginterval-sampler/src/programs.rkt:124:2 ??? [33] 86.7% ??? [37] 13.3% ------------------------------------------------------------------------ loop [24] 100.0% [28] 346(2.4%) 0(0.0%) expand-capturing-lifts (unknown source) loop [24] 100.0% ------------------------------------------------------------------------ for-loop [29] 18.0% loop [24] 34.3% run-module-instance!125 [34] 47.8% [29] 346(2.4%) 0(0.0%) for-loop (unknown source) run-module-instance!125 [34] 52.2% namespace->name [35] 29.8% for-loop [29] 18.0% ------------------------------------------------------------------------ loop [23] 100.0% [30] 250(1.7%) 250(1.7%) ??? ...contract/private/arrow-val-first.rkt:388:18 ------------------------------------------------------------------------ for-loop [25] 100.0% [31] 230(1.6%) 230(1.6%) match-e ...terval-sampler/src/core/ematch.rkt:46:0 ------------------------------------------------------------------------ parse-loop14 [26] 5.4% loop [32] 94.6% [32] 204(1.4%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:40:19 loop [32] 94.6% hash-ref! [21] 2.7% map [36] 2.7% ------------------------------------------------------------------------ ??? [27] 100.0% [33] 9040(63.1%) 290(2.0%) ??? ...acket/collects/racket/private/kw.rkt:592:14 ??? [37] 96.8% ------------------------------------------------------------------------ for-loop [29] 100.0% [34] 346(2.4%) 140(1.0%) run-module-instance!125 (unknown source) for-loop [29] 91.9% ------------------------------------------------------------------------ for-loop [29] 100.0% [35] 206(1.4%) 206(1.4%) namespace->name (unknown source) ------------------------------------------------------------------------ loop [32] 100.0% [36] 204(1.4%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:35:13 ??? [38] 100.0% ------------------------------------------------------------------------ ??? [27] 13.7% ??? [33] 86.3% [37] 10134(70.7%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-mult [39] 80.1% mk-ival [41] 13.7% ival-add [42] 6.2% ------------------------------------------------------------------------ map [36] 8.5% for-loop [19] 10.9% for-loop [17] 14.6% loop [23] 66.0% [38] 2396(16.7%) 594(4.1%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [40] 75.2% ------------------------------------------------------------------------ ??? [37] 100.0% [39] 8120(56.7%) 0(0.0%) ival-mult ...rval-sampler/src/biginterval.rkt:90:0 bf* [43] 74.3% bfmax* [45] 9.8% bfmin* [46] 8.2% ...higher-order.rkt:361:33 [48] 4.2% foldl [49] 3.6% ------------------------------------------------------------------------ ??? [38] 100.0% [40] 1802(12.6%) 824(5.8%) ->flonum ...interval-sampler/src/programs.rkt:36:0 return/no-unsupplied [47] 36.7% ??? [54] 17.5% ------------------------------------------------------------------------ ??? [37] 100.0% [41] 1384(9.7%) 336(2.3%) mk-ival ...terval-sampler/src/biginterval.rkt:48:0 bf [44] 75.7% ------------------------------------------------------------------------ ??? [37] 100.0% [42] 630(4.4%) 286(2.0%) ival-add ...erval-sampler/src/biginterval.rkt:72:0 ??? [51] 54.6% ------------------------------------------------------------------------ ival-mult [39] 100.0% [43] 6030(42.1%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [51] 100.0% ------------------------------------------------------------------------ mk-ival [41] 100.0% [44] 1048(7.3%) 440(3.1%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [53] 58.0% ------------------------------------------------------------------------ ival-mult [39] 100.0% [45] 792(5.5%) 286(2.0%) bfmax* ...nterval-sampler/src/biginterval.rkt:87:0 foldl [49] 63.9% ------------------------------------------------------------------------ ival-mult [39] 100.0% [46] 666(4.6%) 0(0.0%) bfmin* ...nterval-sampler/src/biginterval.rkt:84:0 foldl [49] 100.0% ------------------------------------------------------------------------ ->flonum [40] 100.0% [47] 662(4.6%) 662(4.6%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 ------------------------------------------------------------------------ ival-mult [39] 100.0% [48] 342(2.4%) 0(0.0%) ...higher-order.rkt:361:33 (unknown source) ??? [50] 100.0% ------------------------------------------------------------------------ ival-mult [39] 19.8% bfmax* [45] 34.6% bfmin* [46] 45.6% [49] 1462(10.2%) 0(0.0%) foldl ...et/collects/racket/private/list.rkt:229:4 ??? [51] 100.0% ------------------------------------------------------------------------ ...higher-order.rkt:361:33 [48] 100.0% [50] 342(2.4%) 342(2.4%) ??? ...cts/racket/contract/private/list.rkt:209:10 ------------------------------------------------------------------------ ival-add [42] 4.4% foldl [49] 18.7% bf* [43] 77.0% [51] 7836(54.7%) 288(2.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmax2 [52] 96.3% ------------------------------------------------------------------------ ??? [51] 100.0% [52] 7548(52.7%) 292(2.0%) bfmax2 ...lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [53] 57.3% ??? [54] 38.8% ------------------------------------------------------------------------ bf [44] 12.3% bfmax2 [52] 87.7% [53] 4934(34.4%) 4934(34.4%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------ ->flonum [40] 9.7% bfmax2 [52] 90.3% [54] 3246(22.7%) 3246(22.7%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------