Profiling results ----------------- Total cpu time observed: 5650ms (out of 5728ms) Number of samples taken: 26 (once every 217ms) ===================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ===================================================================== [1] 5650(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [5] 100.0% --------------------------------------------------------------------- for-loop [75] 100.0% [2] 224(4.0%) 0(0.0%) expand-implicit (unknown source) resolve+shift28 [6] 100.0% --------------------------------------------------------------------- matcher [61] 100.0% [3] 208(3.7%) 0(0.0%) ??? ...e-to-egg-herbie/src/core/matcher.rkt:130:11 for-loop [7] 100.0% --------------------------------------------------------------------- for-loop [75] 100.0% [4] 200(3.5%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [6] 100.0% --------------------------------------------------------------------- ??? [1] 100.0% [5] 5650(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [8] 100.0% --------------------------------------------------------------------- expand-identifier [4] 47.2% expand-implicit [2] 52.8% [6] 424(7.5%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [9] 100.0% --------------------------------------------------------------------- ??? [3] 100.0% [7] 208(3.7%) 0(0.0%) for-loop ...egg-herbie/src/core/matcher.rkt:132:15 matcher [61] 100.0% --------------------------------------------------------------------- profile-thunk16 [5] 100.0% [8] 5650(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [10]100.0% --------------------------------------------------------------------- resolve+shift28 [6] 100.0% [9] 424(7.5%) 0(0.0%) fallback-loop (unknown source) for-loop [75] 100.0% --------------------------------------------------------------------- for-loop [56] 7.5% run [8] 92.5% [10] 5650(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [11] 58.1% prepare-points-intervals [12] 24.9% ??? [23] 5.5% loop [13] 4.0% oracle-error [14] 3.9% ulp-difference [63] 2.0% errors [50] 1.7% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10]100.0% [11] 3604(63.8%) 0(0.0%) run-improve47 ...egg-herbie/src/mainloop.rkt:346:0 for-loop [15] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10]100.0% [12] 1408(24.9%) 0(0.0%) prepare-points-intervals ...e/src/points.rkt:110:0 loop [16] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10]100.0% [13] 224(4.0%) 0(0.0%) loop (unknown source) eval-prog [57] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10]100.0% [14] 218(3.9%) 0(0.0%) oracle-error ...to-egg-herbie/src/points.rkt:188:0 for-loop [17] 100.0% --------------------------------------------------------------------- run-improve47 [11] 100.0% [15] 3604(63.8%) 0(0.0%) for-loop ...e-to-egg-herbie/src/mainloop.rkt:365:4 run-iter! [18] 100.0% --------------------------------------------------------------------- prepare-points-intervals [12] 100.0% [16] 1408(24.9%) 0(0.0%) loop ...ve-more-to-egg-herbie/src/points.rkt:123:4 loop [19] 57.0% ??? [20] 43.0% --------------------------------------------------------------------- oracle-error [14] 100.0% [17] 218(3.9%) 0(0.0%) for-loop ...ore-to-egg-herbie/src/points.rkt:189:2 map [51] 100.0% --------------------------------------------------------------------- for-loop [15] 100.0% [18] 3604(63.8%) 0(0.0%) run-iter! ...-to-egg-herbie/src/mainloop.rkt:327:0 simplify! [21] 46.3% finalize-iter! [22] 41.7% localize! [24] 6.2% gen-rewrites! [25] 5.8% --------------------------------------------------------------------- loop [16] 100.0% [19] 802(14.2%) 0(0.0%) loop ...ove-more-to-egg-herbie/src/points.rkt:81:2 ??? [23] 100.0% --------------------------------------------------------------------- loop [16] 100.0% [20] 606(10.7%) 0(0.0%) ??? ...ove-more-to-egg-herbie/src/points.rkt:106:2 do-curry [26] 34.0% ??? [30] 33.0% ??? [29] 33.0% --------------------------------------------------------------------- run-iter! [18] 100.0% [21] 1668(29.5%) 0(0.0%) simplify! ...-to-egg-herbie/src/mainloop.rkt:224:0 ??? [27] 100.0% --------------------------------------------------------------------- run-iter! [18] 100.0% [22] 1504(26.6%) 0(0.0%) finalize-iter! ...gg-herbie/src/mainloop.rkt:278:0 ??? [28] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10] 43.6% loop [19] 56.4% [23] 1422(25.2%) 0(0.0%) ??? ...e-more-to-egg-herbie/src/programs.rkt:115:2 ??? [29] 44.0% ??? [30] 28.1% ??? [31] 27.8% --------------------------------------------------------------------- run-iter! [18] 100.0% [24] 224(4.0%) 0(0.0%) localize! ...-to-egg-herbie/src/mainloop.rkt:127:0 localize-error [32] 100.0% --------------------------------------------------------------------- run-iter! [18] 100.0% [25] 208(3.7%) 0(0.0%) gen-rewrites! ...egg-herbie/src/mainloop.rkt:183:0 for-loop [33] 100.0% --------------------------------------------------------------------- ??? [20] 100.0% [26] 206(3.6%) 206(3.6%) do-curry ...-7.5/collects/racket/function.rkt:71:2 --------------------------------------------------------------------- simplify! [21] 100.0% [27] 1668(29.5%) 0(0.0%) ??? ...re-to-egg-herbie/src/core/simplify.rkt:44:0 egraph-run [34] 100.0% --------------------------------------------------------------------- finalize-iter! [22] 100.0% [28] 1504(26.6%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [35] 100.0% --------------------------------------------------------------------- ??? [20] 24.2% ??? [23] 75.8% [29] 826(14.6%) 224(4.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-mult [36] 48.7% sample-multi-bounded [41] 24.2% --------------------------------------------------------------------- ??? [20] 33.3% ??? [23] 66.7% [30] 600(10.6%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-div [37] 66.7% ??? [40] 33.3% --------------------------------------------------------------------- ??? [23] 100.0% [31] 396(7.0%) 396(7.0%) ??? ...cket-7.5/collects/racket/function.rkt:93:12 --------------------------------------------------------------------- localize! [24] 100.0% [32] 224(4.0%) 0(0.0%) localize-error ...erbie/src/core/localize.rkt:65:0 hash-ref! [38] 100.0% --------------------------------------------------------------------- gen-rewrites! [25] 100.0% [33] 208(3.7%) 0(0.0%) for-loop ...-to-egg-herbie/src/mainloop.rkt:191:11 rewrite-expression-head20 [39] 100.0% --------------------------------------------------------------------- ??? [27] 100.0% [34] 1668(29.5%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [42] 100.0% --------------------------------------------------------------------- ??? [28] 100.0% [35] 1504(26.6%) 0(0.0%) for-loop ...egg-herbie/src/core/alt-table.rkt:55:2 atab-add-altn [43] 56.4% errors [50] 29.7% loop [46] 14.0% --------------------------------------------------------------------- ??? [29] 100.0% [36] 402(7.1%) 402(7.1%) ival-mult ...-egg-herbie/src/biginterval.rkt:119:0 --------------------------------------------------------------------- ??? [30] 100.0% [37] 400(7.1%) 0(0.0%) ival-div ...o-egg-herbie/src/biginterval.rkt:155:0 bfdiv [44] 100.0% --------------------------------------------------------------------- localize-error [32] 100.0% [38] 224(4.0%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop30 [45] 100.0% --------------------------------------------------------------------- for-loop [33] 100.0% [39] 208(3.7%) 0(0.0%) rewrite-expression-head20 ...core/matcher.rkt:87:0 rewriter [47] 100.0% --------------------------------------------------------------------- ??? [30] 100.0% [40] 200(3.5%) 200(3.5%) ??? ...cts/racket/contract/private/list.rkt:209:10 --------------------------------------------------------------------- ??? [29] 100.0% [41] 200(3.5%) 0(0.0%) sample-multi-bounded ...herbie/src/points.rkt:15:0 random-ranges [48] 100.0% --------------------------------------------------------------------- egraph-run [34] 100.0% [42] 1668(29.5%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [49] 100.0% --------------------------------------------------------------------- for-loop [35] 100.0% [43] 848(15.0%) 0(0.0%) atab-add-altn ...rbie/src/core/alt-table.rkt:203:0 errors [50] 100.0% --------------------------------------------------------------------- ival-div [37] 100.0% [44] 400(7.1%) 0(0.0%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [52] 100.0% --------------------------------------------------------------------- hash-ref! [38] 100.0% [45] 224(4.0%) 0(0.0%) parse-loop30 (unknown source) map [51] 100.0% --------------------------------------------------------------------- for-loop [35] 100.0% [46] 210(3.7%) 210(3.7%) loop ...to-egg-herbie/src/core/alt-table.rkt:177:2 --------------------------------------------------------------------- rewrite-expression-head20 [39] 33.3% matcher [61] 66.7% [47] 208(3.7%) 0(0.0%) rewriter ...o-egg-herbie/src/core/matcher.rkt:90:2 for-loop [53] 100.0% --------------------------------------------------------------------- sample-multi-bounded [41] 100.0% [48] 200(3.5%) 0(0.0%) random-ranges ...o-egg-herbie/src/common.rkt:171:0 cons/c [54] 100.0% --------------------------------------------------------------------- egraph-add-exprs [42] 100.0% [49] 1668(29.5%) 0(0.0%) ??? ...e-to-egg-herbie/src/core/simplify.rkt:103:6 for-loop [55] 100.0% --------------------------------------------------------------------- .../more-scheme.rkt:261:28 [10] 13.2% for-loop [35] 29.9% atab-add-altn [43] 56.9% [50] 1490(26.4%) 0(0.0%) errors ...-more-to-egg-herbie/src/points.rkt:201:0 for-loop [56] 71.5% eval-prog [57] 28.5% --------------------------------------------------------------------- for-loop [17] 49.3% parse-loop30 [45] 50.7% [51] 442(7.8%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 loop [58] 50.7% ??? [59] 49.3% --------------------------------------------------------------------- bfdiv [44] 100.0% [52] 400(7.1%) 400(7.1%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 --------------------------------------------------------------------- rewriter [47] 100.0% [53] 208(3.7%) 0(0.0%) for-loop ...o-egg-herbie/src/core/matcher.rkt:92:4 matcher [61] 66.7% for-loop [60] 33.3% --------------------------------------------------------------------- random-ranges [48] 100.0% [54] 200(3.5%) 200(3.5%) cons/c .../racket/contract/private/guts.rkt:500:15 --------------------------------------------------------------------- ??? [49] 100.0% [55] 1668(29.5%) 1668(29.5%) for-loop ...egg-herbie/src/core/simplify.rkt:122:2 --------------------------------------------------------------------- errors [50] 100.0% [56] 1066(18.9%) 224(4.0%) for-loop ...ore-to-egg-herbie/src/points.rkt:203:2 .../more-scheme.rkt:261:28 [10] 79.0% --------------------------------------------------------------------- loop [13] 34.6% errors [50] 65.4% [57] 648(11.5%) 0(0.0%) eval-prog ...e-to-egg-herbie/src/programs.rkt:83:0 temp85_0 [62] 100.0% --------------------------------------------------------------------- map [51] 1.6% loop [58] 98.4% [58] 224(4.0%) 0(0.0%) loop ...-7.5/collects/racket/private/map.rkt:40:19 loop [58] 98.4% step [64] 1.6% --------------------------------------------------------------------- map [51] 100.0% [59] 218(3.9%) 0(0.0%) ??? ...ve-more-to-egg-herbie/src/points.rkt:190:26 ulp-difference [63] 100.0% --------------------------------------------------------------------- for-loop [53] 100.0% [60] 208(3.7%) 0(0.0%) for-loop ...o-egg-herbie/src/core/matcher.rkt:99:8 fix-up-variables [65] 100.0% --------------------------------------------------------------------- for-loop [7] 50.0% for-loop [53] 50.0% [61] 208(3.7%) 0(0.0%) matcher ...o-egg-herbie/src/core/matcher.rkt:118:2 ??? [3] 50.0% rewriter [47] 50.0% --------------------------------------------------------------------- eval-prog [57] 100.0% [62] 648(11.5%) 0(0.0%) temp85_0 (unknown source) compile15 [66] 100.0% --------------------------------------------------------------------- ??? [59] 49.5% .../more-scheme.rkt:261:28 [10] 50.5% [63] 440(7.8%) 440(7.8%) ulp-difference ...to-egg-herbie/src/float.rkt:20:0 --------------------------------------------------------------------- loop [58] 100.0% [64] 224(4.0%) 224(4.0%) step ...ket-7.5/collects/racket/function.rkt:145:9 --------------------------------------------------------------------- for-loop [60] 100.0% [65] 208(3.7%) 0(0.0%) fix-up-variables ...bie/src/core/matcher.rkt:111:2 pattern-match [67] 100.0% --------------------------------------------------------------------- temp85_0 [62] 100.0% [66] 648(11.5%) 0(0.0%) compile15 (unknown source) temp91_0 [68] 100.0% --------------------------------------------------------------------- fix-up-variables [65] 100.0% [67] 208(3.7%) 0(0.0%) pattern-match ...-herbie/src/core/matcher.rkt:30:0 for-loop [69] 100.0% --------------------------------------------------------------------- compile15 [66] 100.0% [68] 648(11.5%) 0(0.0%) temp91_0 (unknown source) temp118_0 [70] 100.0% --------------------------------------------------------------------- pattern-match [67] 100.0% [69] 208(3.7%) 0(0.0%) for-loop ...o-egg-herbie/src/core/matcher.rkt:27:9 core457 [71] 100.0% --------------------------------------------------------------------- temp91_0 [68] 100.0% [70] 648(11.5%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [72] 100.0% --------------------------------------------------------------------- for-loop [69] 100.0% [71] 208(3.7%) 208(3.7%) core457 ...acket/contract/private/arr-i.rkt:976:19 --------------------------------------------------------------------- temp118_0 [70] 100.0% [72] 648(11.5%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [73] 100.0% --------------------------------------------------------------------- expand-capturing-lifts [72] 100.0% [73] 648(11.5%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [74] 100.0% --------------------------------------------------------------------- lambda-clause-expander [73] 15.9% for-loop [75] 84.1% [74] 648(11.5%) 0(0.0%) finish-bodys (unknown source) for-loop [75] 100.0% --------------------------------------------------------------------- fallback-loop [9] 6.7% for-loop [75] 18.2% finish-bodys [74] 75.1% [75] 648(11.5%) 424(7.5%) for-loop (unknown source) finish-bodys [74] 63.5% for-loop [75] 18.2% add-local-binding!39 [76] 4.9% expand-implicit [2] 4.9% expand-identifier [4] 1.7% --------------------------------------------------------------------- for-loop [75] 100.0% [76] 224(4.0%) 224(4.0%) add-local-binding!39 (unknown source) ---------------------------------------------------------------------