Profiling results ----------------- Total cpu time observed: 2576ms (out of 2792ms) Number of samples taken: 13 (once every 198ms) ==================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ==================================================================== [1] 2576(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 100.0% -------------------------------------------------------------------- hash-ref! [54] 100.0% [2] 320(12.4%) 0(0.0%) ??? ...bie/ival-pow-test/src/core/taylor.rkt:67:15 ??? [49] 100.0% -------------------------------------------------------------------- hash-ref! [54] 100.0% [3] 320(12.4%) 0(0.0%) ??? ...ie/ival-pow-test/src/core/taylor.rkt:290:26 for-loop [7] 100.0% -------------------------------------------------------------------- ??? [49] 100.0% [4] 320(12.4%) 0(0.0%) approximate9 ...-pow-test/src/core/taylor.rkt:11:0 loop [8] 100.0% -------------------------------------------------------------------- matcher [55] 100.0% [5] 194(7.5%) 0(0.0%) ??? ...e/ival-pow-test/src/core/matcher.rkt:127:11 for-loop [9] 100.0% -------------------------------------------------------------------- ??? [1] 100.0% [6] 2576(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [10] 100.0% -------------------------------------------------------------------- ??? [3] 100.0% [7] 320(12.4%) 0(0.0%) for-loop ...al-pow-test/src/core/taylor.rkt:290:52 hash-ref! [54] 100.0% -------------------------------------------------------------------- approximate9 [4] 100.0% [8] 320(12.4%) 0(0.0%) loop ...bie/ival-pow-test/src/core/taylor.rkt:86:4 hash-ref! [54] 100.0% -------------------------------------------------------------------- ??? [5] 100.0% [9] 194(7.5%) 0(0.0%) for-loop ...l-pow-test/src/core/matcher.rkt:129:15 matcher [55] 100.0% -------------------------------------------------------------------- profile-thunk16 [6] 100.0% [10] 2576(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [11]100.0% -------------------------------------------------------------------- for-loop [52] 6.8% run [10] 93.2% [11] 2576(100.0%) 156(6.1%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [12] 44.3% prepare-points-intervals [13] 39.6% eval-errors [15] 6.4% *bit-width* [14] 3.7% errors [48] 3.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11]100.0% [12] 1236(48.0%) 0(0.0%) run-improve47 ...l-pow-test/src/mainloop.rkt:346:0 for-loop [16] 83.5% simplify! [23] 16.5% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11]100.0% [13] 1020(39.6%) 0(0.0%) prepare-points-intervals ...t/src/points.rkt:120:0 loop [17] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11]100.0% [14] 192(7.5%) 192(7.5%) *bit-width* ...ie/ival-pow-test/src/float.rkt:34:0 -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11]100.0% [15] 164(6.4%) 0(0.0%) eval-errors .../ival-pow-test/src/points.rkt:168:0 for-loop [18] 100.0% -------------------------------------------------------------------- run-improve47 [12] 100.0% [16] 1032(40.1%) 0(0.0%) for-loop ...e/ival-pow-test/src/mainloop.rkt:365:4 run-iter! [19] 100.0% -------------------------------------------------------------------- prepare-points-intervals [13] 100.0% [17] 1020(39.6%) 0(0.0%) loop .../herbie/ival-pow-test/src/points.rkt:132:4 loop [20] 84.5% ??? [22] 15.5% -------------------------------------------------------------------- eval-errors [15] 100.0% [18] 164(6.4%) 0(0.0%) for-loop ...bie/ival-pow-test/src/points.rkt:170:2 ??? [21] 100.0% -------------------------------------------------------------------- for-loop [16] 100.0% [19] 1032(40.1%) 0(0.0%) run-iter! .../ival-pow-test/src/mainloop.rkt:327:0 simplify! [23] 31.6% gen-series! [25] 31.0% gen-rewrites! [26] 18.8% finalize-iter! [27] 18.6% -------------------------------------------------------------------- loop [17] 100.0% [20] 862(33.5%) 168(6.5%) loop ...s/herbie/ival-pow-test/src/points.rkt:79:2 ??? [24] 42.9% hash-update! [28] 19.7% ??? [30] 17.9% -------------------------------------------------------------------- for-loop [18] 100.0% [21] 164(6.4%) 164(6.4%) ??? .../ival-pow-test/src/syntax/syntax.rkt:214:17 -------------------------------------------------------------------- loop [17] 100.0% [22] 158(6.1%) 0(0.0%) ??? ...s/herbie/ival-pow-test/src/points.rkt:113:6 sample-multi-bounded [29] 100.0% -------------------------------------------------------------------- run-improve47 [12] 38.5% run-iter! [19] 61.5% [23] 530(20.6%) 0(0.0%) simplify! .../ival-pow-test/src/mainloop.rkt:224:0 ??? [31] 100.0% -------------------------------------------------------------------- loop [20] 100.0% [24] 370(14.4%) 370(14.4%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 -------------------------------------------------------------------- run-iter! [19] 100.0% [25] 320(12.4%) 0(0.0%) gen-series! ...val-pow-test/src/mainloop.rkt:160:0 for-loop [32] 100.0% -------------------------------------------------------------------- run-iter! [19] 100.0% [26] 194(7.5%) 0(0.0%) gen-rewrites! ...l-pow-test/src/mainloop.rkt:183:0 for-loop [33] 100.0% -------------------------------------------------------------------- run-iter! [19] 100.0% [27] 192(7.5%) 0(0.0%) finalize-iter! ...-pow-test/src/mainloop.rkt:278:0 ??? [34] 100.0% -------------------------------------------------------------------- loop [20] 100.0% [28] 170(6.6%) 170(6.6%) hash-update! ...cket/private/more-scheme.rkt:365:4 -------------------------------------------------------------------- ??? [22] 100.0% [29] 158(6.1%) 0(0.0%) sample-multi-bounded ...w-test/src/points.rkt:14:0 random-ranges [35] 100.0% -------------------------------------------------------------------- loop [20] 100.0% [30] 154(6.0%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-sub [36] 100.0% -------------------------------------------------------------------- simplify! [23] 100.0% [31] 530(20.6%) 0(0.0%) ??? ...ie/ival-pow-test/src/core/simplify.rkt:42:0 egraph-run [37] 100.0% -------------------------------------------------------------------- gen-series! [25] 100.0% [32] 320(12.4%) 0(0.0%) for-loop ...e/ival-pow-test/src/mainloop.rkt:167:7 taylor-alt [38] 100.0% -------------------------------------------------------------------- gen-rewrites! [26] 100.0% [33] 194(7.5%) 0(0.0%) for-loop .../ival-pow-test/src/mainloop.rkt:191:11 rewrite-expression-head24 [39] 100.0% -------------------------------------------------------------------- finalize-iter! [27] 100.0% [34] 192(7.5%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [40] 100.0% -------------------------------------------------------------------- sample-multi-bounded [29] 100.0% [35] 158(6.1%) 158(6.1%) random-ranges ...val-pow-test/src/common.rkt:164:0 -------------------------------------------------------------------- ??? [30] 100.0% [36] 154(6.0%) 0(0.0%) ival-sub ...val-pow-test/src/biginterval.rkt:108:0 bfsub [41] 100.0% -------------------------------------------------------------------- ??? [31] 100.0% [37] 530(20.6%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [42] 100.0% -------------------------------------------------------------------- for-loop [32] 100.0% [38] 320(12.4%) 0(0.0%) taylor-alt ...ival-pow-test/src/mainloop.rkt:146:0 for-loop [43] 100.0% -------------------------------------------------------------------- for-loop [33] 100.0% [39] 194(7.5%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [44] 100.0% -------------------------------------------------------------------- ??? [34] 100.0% [40] 192(7.5%) 0(0.0%) for-loop ...l-pow-test/src/core/alt-table.rkt:46:2 atab-add-altn [45] 100.0% -------------------------------------------------------------------- ival-sub [36] 100.0% [41] 154(6.0%) 0(0.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [46] 100.0% -------------------------------------------------------------------- egraph-run [37] 100.0% [42] 530(20.6%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [47] 100.0% -------------------------------------------------------------------- taylor-alt [38] 100.0% [43] 320(12.4%) 0(0.0%) for-loop ...e/ival-pow-test/src/mainloop.rkt:152:6 ??? [49] 100.0% -------------------------------------------------------------------- rewrite-expression-head24 [39] 33.3% matcher [55] 66.7% [44] 194(7.5%) 0(0.0%) rewriter ...val-pow-test/src/core/matcher.rkt:87:2 for-loop [50] 100.0% -------------------------------------------------------------------- for-loop [40] 100.0% [45] 192(7.5%) 0(0.0%) atab-add-altn ...test/src/core/alt-table.rkt:194:0 errors [48] 100.0% -------------------------------------------------------------------- bfsub [41] 100.0% [46] 154(6.0%) 154(6.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 -------------------------------------------------------------------- egraph-add-exprs [42] 100.0% [47] 530(20.6%) 0(0.0%) ??? ...e/ival-pow-test/src/core/simplify.rkt:102:6 for-loop [51] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11] 44.8% atab-add-altn [45] 55.2% [48] 348(13.5%) 0(0.0%) errors ...erbie/ival-pow-test/src/points.rkt:190:0 for-loop [52] 100.0% -------------------------------------------------------------------- ??? [2] 33.3% location-do [53] 33.3% for-loop [43] 33.3% [49] 320(12.4%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 location-do [53] 33.3% approximate9 [4] 33.3% hash-ref! [54] 33.3% -------------------------------------------------------------------- rewriter [44] 100.0% [50] 194(7.5%) 0(0.0%) for-loop ...val-pow-test/src/core/matcher.rkt:89:4 matcher [55] 100.0% -------------------------------------------------------------------- ??? [47] 100.0% [51] 530(20.6%) 530(20.6%) for-loop ...l-pow-test/src/core/simplify.rkt:121:2 -------------------------------------------------------------------- errors [48] 100.0% [52] 348(13.5%) 0(0.0%) for-loop ...bie/ival-pow-test/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [11]100.0% -------------------------------------------------------------------- ??? [49] 100.0% [53] 320(12.4%) 0(0.0%) location-do ...ival-pow-test/src/programs.rkt:63:0 ??? [49] 100.0% -------------------------------------------------------------------- ??? [57] 20.0% ??? [49] 20.0% loop [8] 20.0% for-loop [7] 40.0% [54] 320(12.4%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [3] 40.0% ??? [2] 20.0% ??? [57] 20.0% simplify* [56] 20.0% -------------------------------------------------------------------- for-loop [9] 40.0% for-loop [50] 60.0% [55] 194(7.5%) 0(0.0%) matcher ...val-pow-test/src/core/matcher.rkt:115:2 ??? [5] 40.0% rewriter [44] 40.0% constant? [58] 20.0% -------------------------------------------------------------------- hash-ref! [54] 100.0% [56] 320(12.4%) 320(12.4%) simplify* ...val-pow-test/src/core/reduce.rkt:29:0 -------------------------------------------------------------------- hash-ref! [54] 100.0% [57] 320(12.4%) 0(0.0%) ??? ...bie/ival-pow-test/src/core/taylor.rkt:44:15 hash-ref! [54] 100.0% -------------------------------------------------------------------- matcher [55] 100.0% [58] 194(7.5%) 0(0.0%) constant? ...-pow-test/src/syntax/syntax.rkt:726:0 value? [59] 100.0% -------------------------------------------------------------------- constant? [58] 100.0% [59] 194(7.5%) 194(7.5%) value? .../ival-pow-test/src/syntax/types.rkt:18:0 --------------------------------------------------------------------