Profiling results ----------------- Total cpu time observed: 20518ms (out of 21024ms) Number of samples taken: 47 (once every 437ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== run [4] 49.4% [1] 20518(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [2] 47.5% prepare-points [5] 26.4% loop [6] 18.3% run-improve50 [3] 7.7% ---------------------------------------------------------------------- ??? [1] 100.0% [2] 19502(95.0%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [4] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [3] 2476(12.1%) 0(0.0%) run-improve50 ...lt-testing/src/mainloop.rkt:234:0 for-loop [7] 52.3% prepare-points [5] 19.7% loop [6] 15.8% setup-alt-simplified [8] 12.1% ---------------------------------------------------------------------- profile-thunk16 [2] 98.0% [4] 19894(97.0%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ---------------------------------------------------------------------- run-improve50 [3] 4.3% ??? [1] 95.7% [5] 11334(55.2%) 0(0.0%) prepare-points ...alt-testing/src/points.rkt:214:0 loop [13] 47.8% make-exacts* [14] 21.4% loop [9] 19.4% for-loop [10] 11.4% ---------------------------------------------------------------------- run-improve50 [3] 5.2% ??? [1] 94.8% [6] 7588(37.0%) 0(0.0%) loop ...es/herbie/alt-testing/src/points.rkt:238:2 loop [9] 44.1% make-exacts* [14] 36.5% loop [13] 15.6% for-loop [10] 3.7% ---------------------------------------------------------------------- run-improve50 [3] 100.0% [7] 1296(6.3%) 0(0.0%) for-loop ...ie/alt-testing/src/mainloop.rkt:249:10 run-iter! [11] 100.0% ---------------------------------------------------------------------- run-improve50 [3] 100.0% [8] 300(1.5%) 0(0.0%) setup-alt-simplified ...-testing/src/glue.rkt:49:0 simplify-alt [12] 100.0% ---------------------------------------------------------------------- prepare-points [5] 39.7% loop [6] 60.3% [9] 5552(27.1%) 0(0.0%) loop ...es/herbie/alt-testing/src/points.rkt:158:2 loop [13] 67.9% make-exacts* [14] 32.1% ---------------------------------------------------------------------- loop [6] 18.0% prepare-points [5] 82.0% [10] 1574(7.7%) 0(0.0%) for-loop ...rbie/alt-testing/src/points.rkt:255:26 ??? [15] 100.0% ---------------------------------------------------------------------- for-loop [7] 100.0% [11] 1296(6.3%) 0(0.0%) run-iter! ...ie/alt-testing/src/mainloop.rkt:215:0 localize-error [16] 100.0% ---------------------------------------------------------------------- setup-alt-simplified [8] 100.0% [12] 300(1.5%) 0(0.0%) simplify-alt ...rbie/alt-testing/src/glue.rkt:76:0 ??? [30] 100.0% ---------------------------------------------------------------------- loop [6] 11.4% loop [9] 36.4% prepare-points [5] 52.2% [13] 10372(50.6%) 0(0.0%) loop ...es/herbie/alt-testing/src/points.rkt:141:4 loop [17] 100.0% ---------------------------------------------------------------------- loop [9] 25.5% prepare-points [5] 34.8% loop [6] 39.7% [14] 6976(34.0%) 0(0.0%) make-exacts* ...e/alt-testing/src/points.rkt:138:0 loop [17] 95.6% eval-prog [19] 4.4% ---------------------------------------------------------------------- for-loop [10] 100.0% [15] 1574(7.7%) 0(0.0%) ??? ...ies/herbie/alt-testing/src/points.rkt:230:7 for-loop [18] 100.0% ---------------------------------------------------------------------- run-iter! [11] 100.0% [16] 1296(6.3%) 0(0.0%) localize-error ...sting/src/core/localize.rkt:47:0 hash-ref! [26] 100.0% ---------------------------------------------------------------------- loop [13] 1.5% make-exacts* [14] 2.4% parse-loop12 [31] 7.1% loop [17] 89.1% [17] 18336(89.4%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [17] 89.1% ??? [21] 7.1% ??? [20] 3.7% ??? [25] 0.2% ---------------------------------------------------------------------- ??? [15] 100.0% [18] 1574(7.7%) 0(0.0%) for-loop ...erbie/alt-testing/src/points.rkt:231:9 ??? [25] 100.0% ---------------------------------------------------------------------- make-exacts* [14] 100.0% [19] 308(1.5%) 0(0.0%) eval-prog ...ie/alt-testing/src/programs.rkt:150:0 f137 [22] 100.0% ---------------------------------------------------------------------- loop [17] 100.0% [20] 15998(78.0%) 690(3.4%) ??? ...s/herbie/alt-testing/src/programs.rkt:156:4 ??? [23] 48.9% ??? [24] 44.8% ??? [27] 2.0% ---------------------------------------------------------------------- loop [17] 100.0% [21] 1296(6.3%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [26] 100.0% ---------------------------------------------------------------------- eval-prog [19] 100.0% [22] 308(1.5%) 0(0.0%) f137 .../collects/racket/match/compiler.rkt:507:40 ??? [25] 100.0% ---------------------------------------------------------------------- ??? [20] 100.0% [23] 7822(38.1%) 2620(12.8%) ??? ...acket/collects/racket/private/kw.rkt:444:14 bf* [29] 48.2% ...higher-order.rkt:346:33 [32] 8.7% ??? [35] 4.8% ??? [33] 4.8% ---------------------------------------------------------------------- ??? [20] 100.0% [24] 7164(34.9%) 328(1.6%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [28] 95.4% ---------------------------------------------------------------------- f137 [22] 10.5% loop [17] 35.6% for-loop [18] 53.8% [25] 2924(14.3%) 1616(7.9%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ??? [30] 34.2% ??? [34] 10.5% ---------------------------------------------------------------------- ??? [21] 50.0% localize-error [16] 50.0% [26] 1296(6.3%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 parse-loop12 [31] 100.0% ---------------------------------------------------------------------- ??? [20] 100.0% [27] 322(1.6%) 322(1.6%) ??? ...tract/private/arrow-higher-order.rkt:145:21 ---------------------------------------------------------------------- ??? [24] 100.0% [28] 6836(33.3%) 5326(26.0%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [45] 22.1% ---------------------------------------------------------------------- ??? [23] 100.0% [29] 3768(18.4%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [35] 100.0% ---------------------------------------------------------------------- ??? [30] 11.5% simplify-alt [12] 11.5% ??? [25] 76.9% [30] 1300(6.3%) 284(1.4%) ??? ...llects/racket/private/norm-define.rkt:53:83 ??? [37] 55.1% ??? [30] 11.5% loop [40] 11.5% ---------------------------------------------------------------------- hash-ref! [26] 100.0% [31] 1296(6.3%) 0(0.0%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 loop [17] 50.0% loop [36] 50.0% ---------------------------------------------------------------------- ??? [23] 100.0% [32] 678(3.3%) 354(1.7%) ...higher-order.rkt:346:33 (unknown source) ??? [38] 47.8% ---------------------------------------------------------------------- ??? [23] 100.0% [33] 378(1.8%) 378(1.8%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ---------------------------------------------------------------------- ??? [25] 100.0% [34] 308(1.5%) 0(0.0%) ??? ...ects/racket/contract/private/guts.rkt:644:8 ??? [39] 100.0% ---------------------------------------------------------------------- ??? [23] 9.1% bf* [29] 90.9% [35] 4146(20.2%) 432(2.1%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [41] 89.6% ---------------------------------------------------------------------- parse-loop12 [31] 1.5% loop [36] 98.5% [36] 1296(6.3%) 1296(6.3%) loop ...cket/collects/racket/private/map.rkt:36:19 loop [36] 98.5% ---------------------------------------------------------------------- ??? [30] 100.0% [37] 716(3.5%) 0(0.0%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [42] 100.0% ---------------------------------------------------------------------- ...higher-order.rkt:346:33 [32]100.0% [38] 324(1.6%) 324(1.6%) ??? ...cts/racket/contract/private/list.rkt:187:10 ---------------------------------------------------------------------- ??? [34] 100.0% [39] 308(1.5%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:357:18 hash-has-key? [43] 100.0% ---------------------------------------------------------------------- ??? [30] 100.0% [40] 300(1.5%) 0(0.0%) loop ...ie/alt-testing/src/core/simplify.rkt:237:2 pass [44] 100.0% ---------------------------------------------------------------------- ??? [35] 100.0% [41] 3714(18.1%) 2590(12.6%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [45] 30.3% ---------------------------------------------------------------------- ??? [37] 100.0% [42] 716(3.5%) 716(3.5%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ---------------------------------------------------------------------- ??? [39] 100.0% [43] 308(1.5%) 0(0.0%) hash-has-key? ...et/private/more-scheme.rkt:368:13 ??? [46] 100.0% ---------------------------------------------------------------------- loop [40] 100.0% [44] 300(1.5%) 0(0.0%) pass ...ie/alt-testing/src/core/simplify.rkt:227:2 for-loop [47] 100.0% ---------------------------------------------------------------------- bfmul [41] 42.7% real->bigfloat [28] 57.3% [45] 2634(12.8%) 2634(12.8%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ---------------------------------------------------------------------- hash-has-key? [43] 100.0% [46] 308(1.5%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:737:4 for-loop [48] 100.0% ---------------------------------------------------------------------- pass [44] 100.0% [47] 300(1.5%) 300(1.5%) for-loop ...t-testing/src/core/simplify.rkt:230:29 ---------------------------------------------------------------------- ??? [46] 100.0% [48] 308(1.5%) 308(1.5%) for-loop ...acket/contract/private/list.rkt:743:12 ----------------------------------------------------------------------