Profiling results ----------------- Total cpu time observed: 3352ms (out of 3524ms) Number of samples taken: 10 (once every 335ms) ========================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================= ??? [5] 100.0% [1] 3352(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% --------------------------------------------------------- ??? [5] 100.0% [2] 312(9.3%) 0(0.0%) run-improve41 ...lt-testing/src/mainloop.rkt:225:0 for-loop [4] 100.0% --------------------------------------------------------- profile-thunk16 [1] 100.0% [3] 3352(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 ??? [5] 100.0% --------------------------------------------------------- run-improve41 [2] 100.0% [4] 312(9.3%) 0(0.0%) for-loop ...ie/alt-testing/src/mainloop.rkt:240:10 run-iter! [6] 100.0% --------------------------------------------------------- run [3] 50.0% [5] 3352(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% prepare-points [7] 45.3% run-improve41 [2] 4.7% --------------------------------------------------------- for-loop [4] 100.0% [6] 312(9.3%) 0(0.0%) run-iter! ...ie/alt-testing/src/mainloop.rkt:206:0 choose-best-alt! [8]100.0% --------------------------------------------------------- ??? [5] 100.0% [7] 3040(90.7%) 0(0.0%) prepare-points ...alt-testing/src/points.rkt:214:0 loop [12] 33.4% loop [9] 32.6% make-exacts* [13] 23.8% for-loop [11] 10.2% --------------------------------------------------------- run-iter! [6] 100.0% [8] 312(9.3%) 0(0.0%) choose-best-alt! ...testing/src/mainloop.rkt:106:0 ??? [10] 100.0% --------------------------------------------------------- prepare-points [7] 100.0% [9] 992(29.6%) 0(0.0%) loop ...es/herbie/alt-testing/src/points.rkt:158:2 loop [12] 66.5% make-exacts* [13] 33.5% --------------------------------------------------------- choose-best-alt! [8]100.0% [10] 312(9.3%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 atab-pick-alt8 [14] 100.0% --------------------------------------------------------- prepare-points [7] 100.0% [11] 310(9.2%) 0(0.0%) for-loop ...rbie/alt-testing/src/points.rkt:255:26 ??? [15] 100.0% --------------------------------------------------------- loop [9] 39.4% prepare-points [7] 60.6% [12] 1674(49.9%) 0(0.0%) loop ...es/herbie/alt-testing/src/points.rkt:141:4 loop [16] 100.0% --------------------------------------------------------- loop [9] 31.4% prepare-points [7] 68.6% [13] 1056(31.5%) 0(0.0%) make-exacts* ...e/alt-testing/src/points.rkt:138:0 loop [16] 100.0% --------------------------------------------------------- ??? [10] 100.0% [14] 312(9.3%) 0(0.0%) atab-pick-alt8 ...ting/src/core/alt-table.rkt:64:0 write-json* [17] 100.0% --------------------------------------------------------- for-loop [11] 100.0% [15] 310(9.2%) 0(0.0%) ??? ...ies/herbie/alt-testing/src/points.rkt:230:7 for-loop [18] 100.0% --------------------------------------------------------- make-exacts* [13] 0.2% loop [12] 0.2% loop [16] 99.6% [16] 2730(81.4%) 0(0.0%) loop ...-7.5/collects/racket/private/map.rkt:40:19 loop [16] 99.6% ??? [20] 0.2% ??? [19] 0.1% --------------------------------------------------------- atab-pick-alt8 [14] 100.0% [17] 312(9.3%) 0(0.0%) write-json* ...ket-7.5/collects/json/main.rkt:94:0 loop [21] 100.0% --------------------------------------------------------- ??? [15] 100.0% [18] 310(9.2%) 0(0.0%) for-loop ...erbie/alt-testing/src/points.rkt:231:9 ??? [20] 100.0% --------------------------------------------------------- loop [16] 100.0% [19] 1744(52.0%) 360(10.7%) ??? ...s/herbie/alt-testing/src/programs.rkt:156:4 bf [22] 60.4% ??? [24] 18.9% --------------------------------------------------------- ??? [20] 12.0% for-loop [18] 12.0% loop [16] 76.1% [20] 1296(38.7%) 642(19.2%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ->flonum [23] 50.5% ??? [20] 12.0% --------------------------------------------------------- loop [21] 25.0% for-loop [25] 25.0% for-loop [26] 25.0% write-json* [17] 25.0% [21] 312(9.3%) 312(9.3%) loop /opt/racket-7.5/collects/json/main.rkt:132:2 for-loop [26] 25.0% for-loop [25] 25.0% loop [21] 25.0% --------------------------------------------------------- ??? [19] 100.0% [22] 1054(31.4%) 330(9.8%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 ??? [27] 34.5% new-mpfr [28] 34.2% --------------------------------------------------------- ??? [20] 100.0% [23] 654(19.5%) 654(19.5%) ->flonum ...rbie/alt-testing/src/programs.rkt:37:0 --------------------------------------------------------- ??? [19] 100.0% [24] 330(9.8%) 330(9.8%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 --------------------------------------------------------- loop [21] 100.0% [25] 312(9.3%) 0(0.0%) for-loop ...cket-7.5/collects/json/main.rkt:142:13 loop [21] 100.0% --------------------------------------------------------- loop [21] 100.0% [26] 312(9.3%) 0(0.0%) for-loop ...cket-7.5/collects/json/main.rkt:147:11 loop [21] 100.0% --------------------------------------------------------- bf [22] 100.0% [27] 364(10.9%) 364(10.9%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 --------------------------------------------------------- bf [22] 100.0% [28] 360(10.7%) 360(10.7%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ---------------------------------------------------------