Profiling results ----------------- Total cpu time observed: 1716ms (out of 2060ms) Number of samples taken: 8 (once every 214ms) =================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee =================================================================== [1] 1716(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% ------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [2] 202(11.8%) 0(0.0%) errors .../herbie/egg-cleanup/src/points.rkt:201:0 for-loop [4] 100.0% ------------------------------------------------------------------- ??? [1] 100.0% [3] 1716(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% ------------------------------------------------------------------- errors [2] 100.0% [4] 202(11.8%) 0(0.0%) for-loop ...erbie/egg-cleanup/src/points.rkt:203:2 .../more-scheme.rkt:261:28 [6]100.0% ------------------------------------------------------------------- profile-thunk16 [3] 100.0% [5] 1716(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [6]100.0% ------------------------------------------------------------------- for-loop [4] 5.9% run [5] 94.1% [6] 1716(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [7] 62.1% run-improve47 [8] 14.0% oracle-error [9] 12.1% errors [2] 5.9% ??? [18] 5.9% ------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [7] 1066(62.1%) 0(0.0%) prepare-points-intervals ...p/src/points.rkt:110:0 loop [10] 100.0% ------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [8] 240(14.0%) 0(0.0%) run-improve47 ...gg-cleanup/src/mainloop.rkt:346:0 simplify! [11] 100.0% ------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6]100.0% [9] 208(12.1%) 0(0.0%) oracle-error ...e/egg-cleanup/src/points.rkt:188:0 for-loop [12] 100.0% ------------------------------------------------------------------- prepare-points-intervals [7] 100.0% [10] 1066(62.1%) 0(0.0%) loop ...es/herbie/egg-cleanup/src/points.rkt:123:4 loop [13] 100.0% ------------------------------------------------------------------- run-improve47 [8] 100.0% [11] 240(14.0%) 0(0.0%) simplify! ...ie/egg-cleanup/src/mainloop.rkt:224:0 ??? [14] 100.0% ------------------------------------------------------------------- oracle-error [9] 100.0% [12] 208(12.1%) 0(0.0%) for-loop ...erbie/egg-cleanup/src/points.rkt:189:2 loop [15] 100.0% ------------------------------------------------------------------- loop [10] 100.0% [13] 1066(62.1%) 0(0.0%) loop ...ies/herbie/egg-cleanup/src/points.rkt:81:2 ??? [18] 100.0% ------------------------------------------------------------------- simplify! [11] 100.0% [14] 240(14.0%) 0(0.0%) ??? ...rbie/egg-cleanup/src/core/simplify.rkt:35:0 egraph-run [16] 100.0% ------------------------------------------------------------------- for-loop [12] 100.0% [15] 208(12.1%) 0(0.0%) loop (unknown source) ??? [17] 100.0% ------------------------------------------------------------------- ??? [14] 100.0% [16] 240(14.0%) 0(0.0%) egraph-run ...gg-cleanup/src/core/eggmath.rkt:51:0 egraph-add-exprs [19] 100.0% ------------------------------------------------------------------- loop [15] 100.0% [17] 208(12.1%) 0(0.0%) ??? ...es/herbie/egg-cleanup/src/points.rkt:190:26 ??? [18] 100.0% ------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 13.7% ??? [17] 14.1% loop [13] 72.2% [18] 1476(86.0%) 202(11.8%) ??? ...s/herbie/egg-cleanup/src/programs.rkt:115:2 ??? [20] 72.2% ??? [22] 14.1% ------------------------------------------------------------------- egraph-run [16] 100.0% [19] 240(14.0%) 0(0.0%) egraph-add-exprs ...nup/src/core/eggmath.rkt:111:0 ??? [21] 100.0% ------------------------------------------------------------------- ??? [18] 100.0% [20] 1066(62.1%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 mk-ival [23] 60.0% ival-mult [24] 40.0% ------------------------------------------------------------------- egraph-add-exprs [19] 100.0% [21] 240(14.0%) 0(0.0%) ??? ...rbie/egg-cleanup/src/core/simplify.rkt:93:6 for-loop [25] 100.0% ------------------------------------------------------------------- ??? [18] 100.0% [22] 208(12.1%) 208(12.1%) ??? ...ie/egg-cleanup/src/syntax/syntax.rkt:214:17 ------------------------------------------------------------------- ??? [20] 100.0% [23] 640(37.3%) 0(0.0%) mk-ival ...ie/egg-cleanup/src/biginterval.rkt:65:0 bf [26] 100.0% ------------------------------------------------------------------- ??? [20] 100.0% [24] 426(24.8%) 200(11.7%) ival-mult ...egg-cleanup/src/biginterval.rkt:119:0 bfmul [27] 53.1% ------------------------------------------------------------------- ??? [21] 100.0% [25] 240(14.0%) 240(14.0%) for-loop ...gg-cleanup/src/core/simplify.rkt:112:2 ------------------------------------------------------------------- mk-ival [23] 100.0% [26] 640(37.3%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 new-mpfr [29] 66.2% ??? [28] 33.8% ------------------------------------------------------------------- ival-mult [24] 100.0% [27] 226(13.2%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [28] 100.0% ------------------------------------------------------------------- bf [26] 48.9% bfmul [27] 51.1% [28] 442(25.8%) 442(25.8%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ------------------------------------------------------------------- bf [26] 100.0% [29] 424(24.7%) 424(24.7%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 -------------------------------------------------------------------