Profiling results ----------------- Total cpu time observed: 4868ms (out of 5008ms) Number of samples taken: 23 (once every 212ms) ==================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ==================================================================== [1] 4868(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% -------------------------------------------------------------------- for-loop [68] 100.0% [2] 200(4.1%) 0(0.0%) expand-implicit (unknown source) resolve+shift28 [63] 100.0% -------------------------------------------------------------------- ??? [1] 100.0% [3] 4868(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [4] 100.0% -------------------------------------------------------------------- profile-thunk16 [3] 100.0% [4] 4868(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [5] 100.0% -------------------------------------------------------------------- for-loop [49] 4.4% run [4] 95.6% [5] 4868(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [35] 37.1% get-final-combination [6] 23.4% run-improve47 [7] 20.5% oracle-error [8] 8.5% ??? [62] 4.4% eval-errors [9] 4.1% errors [45] 2.1% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [5] 100.0% [6] 1248(25.6%) 0(0.0%) get-final-combination ...up/src/mainloop.rkt:371:0 infer-splitpoints [11] 67.8% f34 [13] 32.2% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [5] 100.0% [7] 998(20.5%) 0(0.0%) run-improve47 ...gg-cleanup/src/mainloop.rkt:346:0 for-loop [10] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [5] 100.0% [8] 412(8.5%) 0(0.0%) oracle-error ...e/egg-cleanup/src/points.rkt:188:0 for-loop [12] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [5] 100.0% [9] 200(4.1%) 0(0.0%) eval-errors ...ie/egg-cleanup/src/points.rkt:179:0 for-loop [14] 100.0% -------------------------------------------------------------------- run-improve47 [7] 100.0% [10] 998(20.5%) 0(0.0%) for-loop ...bie/egg-cleanup/src/mainloop.rkt:365:4 run-iter! [15] 100.0% -------------------------------------------------------------------- get-final-combination [6] 100.0% [11] 846(17.4%) 0(0.0%) infer-splitpoints ...nup/src/core/regimes.rkt:34:0 for-loop [16] 100.0% -------------------------------------------------------------------- oracle-error [8] 100.0% [12] 412(8.5%) 0(0.0%) for-loop ...erbie/egg-cleanup/src/points.rkt:189:2 loop [59] 100.0% -------------------------------------------------------------------- get-final-combination [6] 100.0% [13] 402(8.3%) 0(0.0%) f34 (unknown source) sindices->spoints [17] 100.0% -------------------------------------------------------------------- eval-errors [9] 100.0% [14] 200(4.1%) 200(4.1%) for-loop ...erbie/egg-cleanup/src/points.rkt:181:2 -------------------------------------------------------------------- for-loop [10] 100.0% [15] 998(20.5%) 0(0.0%) run-iter! ...ie/egg-cleanup/src/mainloop.rkt:327:0 simplify! [19] 57.5% gen-series! [21] 22.4% choose-best-alt! [22] 20.0% -------------------------------------------------------------------- infer-splitpoints [11] 100.0% [16] 846(17.4%) 0(0.0%) for-loop .../egg-cleanup/src/core/regimes.rkt:47:6 option-on-expr [18] 100.0% -------------------------------------------------------------------- f34 [13] 100.0% [17] 402(8.3%) 0(0.0%) sindices->spoints ...up/src/core/regimes.rkt:194:0 for-loop [20] 100.0% -------------------------------------------------------------------- for-loop [16] 100.0% [18] 846(17.4%) 0(0.0%) option-on-expr ...eanup/src/core/regimes.rkt:126:0 err-lsts->split-indices [24] 49.4% for-loop [27] 26.2% sort-context-on-expr [28] 24.3% -------------------------------------------------------------------- run-iter! [15] 100.0% [19] 574(11.8%) 0(0.0%) simplify! ...ie/egg-cleanup/src/mainloop.rkt:224:0 ??? [23] 100.0% -------------------------------------------------------------------- sindices->spoints [17] 100.0% [20] 402(8.3%) 0(0.0%) for-loop ...egg-cleanup/src/core/regimes.rkt:233:9 binary-search-floats [25] 100.0% -------------------------------------------------------------------- run-iter! [15] 100.0% [21] 224(4.6%) 0(0.0%) gen-series! .../egg-cleanup/src/mainloop.rkt:160:0 for-loop [26] 100.0% -------------------------------------------------------------------- run-iter! [15] 100.0% [22] 200(4.1%) 0(0.0%) choose-best-alt! ...cleanup/src/mainloop.rkt:117:0 ...ow-val-first.rkt:486:18 [29]100.0% -------------------------------------------------------------------- simplify! [19] 100.0% [23] 574(11.8%) 0(0.0%) ??? ...rbie/egg-cleanup/src/core/simplify.rkt:35:0 egraph-run [30] 100.0% -------------------------------------------------------------------- option-on-expr [18] 100.0% [24] 418(8.6%) 0(0.0%) err-lsts->split-indices .../core/regimes.rkt:262:0 loop [31] 100.0% -------------------------------------------------------------------- for-loop [20] 100.0% [25] 402(8.3%) 0(0.0%) binary-search-floats ...src/core/regimes.rkt:175:0 pred [32] 100.0% -------------------------------------------------------------------- gen-series! [21] 100.0% [26] 224(4.6%) 0(0.0%) for-loop ...bie/egg-cleanup/src/mainloop.rkt:167:7 taylor-alt [33] 100.0% -------------------------------------------------------------------- option-on-expr [18] 100.0% [27] 222(4.6%) 0(0.0%) for-loop ...egg-cleanup/src/core/regimes.rkt:136:4 errors [45] 100.0% -------------------------------------------------------------------- option-on-expr [18] 100.0% [28] 206(4.2%) 0(0.0%) sort-context-on-expr ...src/core/regimes.rkt:119:0 eval-prog [48] 100.0% -------------------------------------------------------------------- choose-best-alt! [22] 100.0% [29] 200(4.1%) 0(0.0%) ...ow-val-first.rkt:486:18 (unknown source) ??? [34] 100.0% -------------------------------------------------------------------- ??? [23] 100.0% [30] 574(11.8%) 0(0.0%) egraph-run ...gg-cleanup/src/core/eggmath.rkt:51:0 egraph-add-exprs [36] 100.0% -------------------------------------------------------------------- err-lsts->split-indices [24] 100.0% [31] 418(8.6%) 0(0.0%) loop ...bie/egg-cleanup/src/core/regimes.rkt:313:4 for-loop [37] 100.0% -------------------------------------------------------------------- binary-search-floats [25] 100.0% [32] 402(8.3%) 0(0.0%) pred ...bie/egg-cleanup/src/core/regimes.rkt:204:4 prepare-points-intervals [35] 100.0% -------------------------------------------------------------------- for-loop [26] 100.0% [33] 224(4.6%) 0(0.0%) taylor-alt ...e/egg-cleanup/src/mainloop.rkt:146:0 for-loop [38] 100.0% -------------------------------------------------------------------- ...ow-val-first.rkt:486:18 [29]100.0% [34] 200(4.1%) 0(0.0%) ??? ...bie/egg-cleanup/src/core/alt-table.rkt:58:0 argmin [39] 100.0% -------------------------------------------------------------------- pred [32] 18.2% .../more-scheme.rkt:261:28 [5] 81.8% [35] 2210(45.4%) 0(0.0%) prepare-points-intervals ...p/src/points.rkt:110:0 loop [40] 91.0% eval-prog [48] 9.0% -------------------------------------------------------------------- egraph-run [30] 100.0% [36] 574(11.8%) 0(0.0%) egraph-add-exprs ...nup/src/core/eggmath.rkt:111:0 ??? [41] 100.0% -------------------------------------------------------------------- loop [31] 100.0% [37] 418(8.6%) 200(4.1%) for-loop ...egg-cleanup/src/core/regimes.rkt:278:4 for-loop [42] 52.2% -------------------------------------------------------------------- taylor-alt [33] 100.0% [38] 224(4.6%) 0(0.0%) for-loop ...bie/egg-cleanup/src/mainloop.rkt:152:6 ??? [64] 100.0% -------------------------------------------------------------------- ??? [34] 100.0% [39] 200(4.1%) 0(0.0%) argmin ...acket-7.5/collects/racket/list.rkt:765:0 ??? [43] 100.0% -------------------------------------------------------------------- prepare-points-intervals [35] 100.0% [40] 2010(41.3%) 0(0.0%) loop ...es/herbie/egg-cleanup/src/points.rkt:123:4 loop [44] 70.1% ??? [46] 29.9% -------------------------------------------------------------------- egraph-add-exprs [36] 100.0% [41] 574(11.8%) 0(0.0%) ??? ...rbie/egg-cleanup/src/core/simplify.rkt:93:6 for-loop [47] 100.0% -------------------------------------------------------------------- for-loop [37] 100.0% [42] 218(4.5%) 218(4.5%) for-loop ...egg-cleanup/src/core/regimes.rkt:282:8 -------------------------------------------------------------------- argmin [39] 100.0% [43] 200(4.1%) 0(0.0%) ??? .../herbie/egg-cleanup/src/mainloop.rkt:114:10 errors [45] 100.0% -------------------------------------------------------------------- loop [40] 100.0% [44] 1410(29.0%) 200(4.1%) loop ...ies/herbie/egg-cleanup/src/points.rkt:81:2 ??? [62] 85.8% -------------------------------------------------------------------- ??? [43] 32.1% .../more-scheme.rkt:261:28 [5] 32.4% for-loop [27] 35.6% [45] 624(12.8%) 0(0.0%) errors .../herbie/egg-cleanup/src/points.rkt:201:0 for-loop [49] 67.9% eval-prog [48] 32.1% -------------------------------------------------------------------- loop [40] 100.0% [46] 600(12.3%) 0(0.0%) ??? ...ies/herbie/egg-cleanup/src/points.rkt:106:2 ??? [64] 100.0% -------------------------------------------------------------------- ??? [41] 100.0% [47] 574(11.8%) 574(11.8%) for-loop ...gg-cleanup/src/core/simplify.rkt:112:2 -------------------------------------------------------------------- errors [45] 33.0% prepare-points-intervals [35] 33.0% sort-context-on-expr [28] 34.0% [48] 606(12.4%) 0(0.0%) eval-prog ...bie/egg-cleanup/src/programs.rkt:83:0 temp85_0 [50] 66.0% loop [59] 34.0% -------------------------------------------------------------------- errors [45] 100.0% [49] 424(8.7%) 0(0.0%) for-loop ...erbie/egg-cleanup/src/points.rkt:203:2 .../more-scheme.rkt:261:28 [5] 100.0% -------------------------------------------------------------------- eval-prog [48] 100.0% [50] 400(8.2%) 0(0.0%) temp85_0 (unknown source) compile15 [51] 100.0% -------------------------------------------------------------------- temp85_0 [50] 100.0% [51] 400(8.2%) 0(0.0%) compile15 (unknown source) temp91_0 [52] 100.0% -------------------------------------------------------------------- compile15 [51] 100.0% [52] 400(8.2%) 0(0.0%) temp91_0 (unknown source) temp118_0 [53] 100.0% -------------------------------------------------------------------- temp91_0 [52] 100.0% [53] 400(8.2%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [54] 100.0% -------------------------------------------------------------------- temp118_0 [53] 48.2% loop [59] 51.8% [54] 830(17.1%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [55] 48.2% dispatch-transformer41 [56] 27.0% loop [59] 24.8% -------------------------------------------------------------------- expand-capturing-lifts [54] 100.0% [55] 400(8.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [57] 100.0% -------------------------------------------------------------------- expand-capturing-lifts [54] 100.0% [56] 224(4.6%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [58] 100.0% -------------------------------------------------------------------- lambda-clause-expander [55] 32.1% for-loop [68] 67.9% [57] 400(8.2%) 0(0.0%) finish-bodys (unknown source) for-loop [68] 100.0% -------------------------------------------------------------------- dispatch-transformer41 [56] 100.0% [58] 224(4.6%) 0(0.0%) apply-transformer52 (unknown source) loop [59] 100.0% -------------------------------------------------------------------- expand-capturing-lifts [54] 12.2% eval-prog [48] 12.2% loop [59] 12.4% apply-transformer52 [58] 13.3% eval-const-expr [85] 13.3% for-loop [12] 36.6% [59] 842(17.3%) 206(4.2%) loop (unknown source) ??? [60] 36.6% expand-capturing-lifts [54] 25.5% core-form-sym [61] 13.3% loop [59] 12.4% -------------------------------------------------------------------- loop [59] 100.0% [60] 412(8.5%) 0(0.0%) ??? ...es/herbie/egg-cleanup/src/points.rkt:190:26 ??? [62] 100.0% -------------------------------------------------------------------- loop [59] 100.0% [61] 224(4.6%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [63] 100.0% -------------------------------------------------------------------- ??? [60] 20.1% .../more-scheme.rkt:261:28 [5] 20.7% loop [44] 59.1% [62] 2046(42.0%) 404(8.3%) ??? ...s/herbie/egg-cleanup/src/programs.rkt:115:2 ??? [64] 40.5% ??? [66] 20.1% ??? [67] 19.6% -------------------------------------------------------------------- expand-implicit [2] 47.2% core-form-sym [61] 52.8% [63] 424(8.7%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [65] 100.0% -------------------------------------------------------------------- location-do [72] 6.8% for-loop [38] 6.8% ??? [46] 36.3% ??? [62] 50.1% [64] 1652(33.9%) 424(8.7%) ??? ...tract/private/arrow-higher-order.rkt:375:33 sample-multi-bounded [69] 36.3% ival-mult [70] 24.5% location-do [72] 6.8% approximate9 [71] 6.8% -------------------------------------------------------------------- resolve+shift28 [63] 100.0% [65] 424(8.7%) 0(0.0%) fallback-loop (unknown source) for-loop [68] 100.0% -------------------------------------------------------------------- ??? [62] 100.0% [66] 412(8.5%) 412(8.5%) ??? ...ie/egg-cleanup/src/syntax/syntax.rkt:214:17 -------------------------------------------------------------------- ??? [62] 100.0% [67] 402(8.3%) 202(4.1%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-log [73] 49.8% -------------------------------------------------------------------- fallback-loop [65] 24.4% for-loop [68] 30.8% finish-bodys [57] 44.9% [68] 624(12.8%) 624(12.8%) for-loop (unknown source) finish-bodys [57] 33.9% for-loop [68] 30.8% expand-implicit [2] 6.4% -------------------------------------------------------------------- ??? [64] 100.0% [69] 600(12.3%) 400(8.2%) sample-multi-bounded ...leanup/src/points.rkt:15:0 random-ranges [77] 33.3% -------------------------------------------------------------------- ??? [64] 100.0% [70] 404(8.3%) 0(0.0%) ival-mult ...egg-cleanup/src/biginterval.rkt:119:0 bfmul [74] 100.0% -------------------------------------------------------------------- ??? [64] 100.0% [71] 224(4.6%) 0(0.0%) approximate9 ...g-cleanup/src/core/taylor.rkt:12:0 for-loop [75] 100.0% -------------------------------------------------------------------- location-do [72] 50.0% ??? [64] 50.0% [72] 224(4.6%) 0(0.0%) location-do ...e/egg-cleanup/src/programs.rkt:64:0 location-do [72] 50.0% ??? [64] 50.0% -------------------------------------------------------------------- ??? [67] 100.0% [73] 200(4.1%) 0(0.0%) ival-log .../egg-cleanup/src/biginterval.rkt:201:0 bflog [76] 100.0% -------------------------------------------------------------------- ival-mult [70] 100.0% [74] 404(8.3%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [78] 50.5% ??? [80] 49.5% -------------------------------------------------------------------- approximate9 [71] 100.0% [75] 224(4.6%) 0(0.0%) for-loop .../egg-cleanup/src/core/taylor.rkt:30:18 taylor-sqrt [79] 100.0% -------------------------------------------------------------------- ival-log [73] 100.0% [76] 200(4.1%) 0(0.0%) bflog ...-lib/math/private/bigfloat/mpfr.rkt:632:4 new-mpfr [78] 100.0% -------------------------------------------------------------------- sample-multi-bounded [69] 100.0% [77] 200(4.1%) 0(0.0%) random-ranges .../egg-cleanup/src/common.rkt:171:0 cons/c [81] 100.0% -------------------------------------------------------------------- bflog [76] 49.5% bfmul [74] 50.5% [78] 404(8.3%) 404(8.3%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 -------------------------------------------------------------------- for-loop [75] 100.0% [79] 224(4.6%) 0(0.0%) taylor-sqrt ...g-cleanup/src/core/taylor.rkt:352:0 first-nonzero-exp [82] 100.0% -------------------------------------------------------------------- bfmul [74] 100.0% [80] 200(4.1%) 200(4.1%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 -------------------------------------------------------------------- random-ranges [77] 100.0% [81] 200(4.1%) 200(4.1%) cons/c .../racket/contract/private/guts.rkt:500:15 -------------------------------------------------------------------- taylor-sqrt [79] 100.0% [82] 224(4.6%) 0(0.0%) first-nonzero-exp ...nup/src/core/taylor.rkt:266:0 hash-ref! [83] 100.0% -------------------------------------------------------------------- first-nonzero-exp [82] 100.0% [83] 224(4.6%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop75 [84] 100.0% -------------------------------------------------------------------- hash-ref! [83] 100.0% [84] 224(4.6%) 0(0.0%) parse-loop75 (unknown source) eval-const-expr [85] 100.0% -------------------------------------------------------------------- parse-loop75 [84] 100.0% [85] 224(4.6%) 0(0.0%) eval-const-expr ...-cleanup/src/programs.rkt:118:0 loop [59] 100.0% --------------------------------------------------------------------