Profiling results ----------------- Total cpu time observed: 10718ms (out of 11088ms) Number of samples taken: 29 (once every 370ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== ??? [3] 100.0% [1] 10004(93.3%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [2] 100.0% ---------------------------------------------------------------------- profile-thunk16 [1] 93.3% [2] 10718(100.0%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [3] 100.0% ---------------------------------------------------------------------- run [2] 53.3% [3] 10718(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 loop [4] 51.7% profile-thunk16 [1] 46.7% run-improve50 [5] 1.6% ---------------------------------------------------------------------- ??? [3] 100.0% [4] 10366(96.7%) 0(0.0%) loop ...s/herbie/simplify-bug/src/points.rkt:193:2 make-exacts* [10] 51.3% loop [6] 41.8% filter-points [7] 3.7% for-loop [9] 3.1% ---------------------------------------------------------------------- ??? [3] 100.0% [5] 352(3.3%) 0(0.0%) run-improve50 ...mplify-bug/src/mainloop.rkt:234:0 setup-alt-simplified [8] 100.0% ---------------------------------------------------------------------- loop [4] 100.0% [6] 4330(40.4%) 0(0.0%) loop ...s/herbie/simplify-bug/src/points.rkt:151:2 loop [11] 59.3% make-exacts* [10] 40.7% ---------------------------------------------------------------------- loop [4] 100.0% [7] 388(3.6%) 0(0.0%) filter-points ...simplify-bug/src/points.rkt:159:0 for-loop [12] 100.0% ---------------------------------------------------------------------- run-improve50 [5] 100.0% [8] 352(3.3%) 0(0.0%) setup-alt-simplified ...lify-bug/src/glue.rkt:48:0 simplify-alt [13] 100.0% ---------------------------------------------------------------------- loop [4] 100.0% [9] 326(3.0%) 0(0.0%) for-loop ...bie/simplify-bug/src/points.rkt:200:24 for-loop [14] 100.0% ---------------------------------------------------------------------- loop [6] 24.9% loop [4] 75.1% [10] 7086(66.1%) 0(0.0%) make-exacts* .../simplify-bug/src/points.rkt:138:0 loop [17] 52.5% map [15] 47.5% ---------------------------------------------------------------------- loop [6] 100.0% [11] 2566(23.9%) 0(0.0%) loop ...s/herbie/simplify-bug/src/points.rkt:141:4 map [15] 100.0% ---------------------------------------------------------------------- filter-points [7] 100.0% [12] 388(3.6%) 388(3.6%) for-loop ...rbie/simplify-bug/src/points.rkt:162:4 ---------------------------------------------------------------------- setup-alt-simplified [8] 100.0% [13] 352(3.3%) 0(0.0%) simplify-alt ...bie/simplify-bug/src/glue.rkt:81:0 ??? [16] 100.0% ---------------------------------------------------------------------- for-loop [9] 100.0% [14] 326(3.0%) 326(3.0%) for-loop ...bie/simplify-bug/src/points.rkt:201:26 ---------------------------------------------------------------------- loop [11] 43.2% make-exacts* [10] 56.8% [15] 5934(55.4%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [17] 100.0% ---------------------------------------------------------------------- ??? [16] 50.0% simplify-alt [13] 50.0% [16] 352(3.3%) 0(0.0%) ??? ...llects/racket/private/norm-define.rkt:53:83 ??? [16] 50.0% iterate-egraph!13 [18] 50.0% ---------------------------------------------------------------------- make-exacts* [10] 0.1% map [15] 1.4% loop [17] 98.5% [17] 9652(90.1%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [17] 98.5% ??? [19] 1.5% ->flonum [20] 0.0% ---------------------------------------------------------------------- ??? [16] 100.0% [18] 352(3.3%) 0(0.0%) iterate-egraph!13 ...g/src/core/simplify.rkt:102:0 one-iter [21] 100.0% ---------------------------------------------------------------------- loop [17] 100.0% [19] 8610(80.3%) 358(3.3%) ??? .../herbie/simplify-bug/src/programs.rkt:155:4 ??? [22] 87.6% ??? [23] 8.2% ---------------------------------------------------------------------- loop [17] 100.0% [20] 1042(9.7%) 720(6.7%) ->flonum ...bie/simplify-bug/src/programs.rkt:37:0 ??? [25] 30.9% ---------------------------------------------------------------------- iterate-egraph!13 [18] 100.0% [21] 352(3.3%) 0(0.0%) one-iter ...mplify-bug/src/core/simplify.rkt:113:0 for-loop [24] 100.0% ---------------------------------------------------------------------- ??? [19] 100.0% [22] 7546(70.4%) 2280(21.3%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [33] 35.1% ??? [26] 13.3% bf* [27] 11.2% ...higher-order.rkt:346:33 [29] 5.5% bf/ [30] 4.7% ---------------------------------------------------------------------- ??? [19] 100.0% [23] 706(6.6%) 0(0.0%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [28] 100.0% ---------------------------------------------------------------------- for-loop [24] 50.0% one-iter [21] 50.0% [24] 352(3.3%) 0(0.0%) for-loop ...plify-bug/src/core/simplify.rkt:123:12 for-loop [24] 50.0% match-e [31] 50.0% ---------------------------------------------------------------------- ->flonum [20] 100.0% [25] 322(3.0%) 0(0.0%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [32] 100.0% ---------------------------------------------------------------------- ??? [22] 100.0% [26] 1000(9.3%) 1000(9.3%) ??? ...rivate/unconstrained-domain-arrow.rkt:40:13 ---------------------------------------------------------------------- ??? [22] 100.0% [27] 844(7.9%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [33] 100.0% ---------------------------------------------------------------------- ??? [23] 100.0% [28] 706(6.6%) 352(3.3%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [37] 50.1% ---------------------------------------------------------------------- ??? [22] 100.0% [29] 418(3.9%) 0(0.0%) ...higher-order.rkt:346:33 (unknown source) ??? [34] 100.0% ---------------------------------------------------------------------- ??? [22] 100.0% [30] 354(3.3%) 354(3.3%) bf/ ...th/private/bigfloat/bigfloat-mpfr.rkt:102:0 ---------------------------------------------------------------------- for-loop [24] 100.0% [31] 352(3.3%) 352(3.3%) match-e ...e/simplify-bug/src/core/ematch.rkt:46:0 ---------------------------------------------------------------------- ??? [25] 100.0% [32] 322(3.0%) 322(3.0%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ---------------------------------------------------------------------- bf* [27] 24.2% ??? [22] 75.8% [33] 3494(32.6%) 854(8.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfdiv [35] 54.9% bfsqrt [36] 20.7% ---------------------------------------------------------------------- ...higher-order.rkt:346:33 [29]100.0% [34] 418(3.9%) 418(3.9%) ??? ...cts/racket/contract/private/list.rkt:187:10 ---------------------------------------------------------------------- ??? [33] 100.0% [35] 1918(17.9%) 1560(14.6%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [37] 18.7% ---------------------------------------------------------------------- ??? [33] 100.0% [36] 722(6.7%) 0(0.0%) bfsqrt ...lib/math/private/bigfloat/mpfr.rkt:616:4 ??? [37] 100.0% ---------------------------------------------------------------------- real->bigfloat [28] 24.7% bfdiv [35] 25.0% bfsqrt [36] 50.3% [37] 1434(13.4%) 1434(13.4%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ----------------------------------------------------------------------