Profiling results ----------------- Total cpu time observed: 15186ms (out of 15304ms) Number of samples taken: 71 (once every 214ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== [1] 15186(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% ---------------------------------------------------------------------- hash-ref! [27] 100.0% [2] 2552(16.8%) 0(0.0%) ??? ...htlies/herbie/master/src/programs.rkt:196:5 loop [22] 100.0% ---------------------------------------------------------------------- ??? [1] 100.0% [3] 15186(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] 15186(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 [55] 1.4% run [4] 98.6% [5] 15186(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) loop [10] 80.0% run-improve47 [6] 16.0% errors [50] 1.4% eval-errors [9] 1.3% ??? [7] 0.7% ulp-difference [8] 0.7% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [5] 100.0% [6] 2428(16.0%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:365:0 loop [10] 60.4% for-loop [11] 39.6% ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [5] 100.0% [7] 208(1.4%) 208(1.4%) ??? ...cket-7.5/collects/racket/function.rkt:93:12 ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [5] 100.0% [8] 206(1.4%) 206(1.4%) ulp-difference ...herbie/master/src/float.rkt:19:0 ---------------------------------------------------------------------- .../more-scheme.rkt:261:28 [5] 100.0% [9] 200(1.3%) 0(0.0%) eval-errors .../herbie/master/src/points.rkt:181:0 for-loop [12] 100.0% ---------------------------------------------------------------------- run-improve47 [6] 10.8% .../more-scheme.rkt:261:28 [5] 89.2% [10] 13610(89.6%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:279:2 loop [13] 40.4% make-exacts-walkup [16] 31.5% loop [17] 26.5% filter-p&e [15] 1.6% ---------------------------------------------------------------------- run-improve47 [6] 100.0% [11] 962(6.3%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:384:4 run-iter! [14] 100.0% ---------------------------------------------------------------------- eval-errors [9] 100.0% [12] 200(1.3%) 200(1.3%) for-loop ...ies/herbie/master/src/points.rkt:183:2 ---------------------------------------------------------------------- loop [10] 100.0% [13] 5498(36.2%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:243:2 make-exacts-walkup [16] 67.4% loop [17] 32.6% ---------------------------------------------------------------------- for-loop [11] 100.0% [14] 962(6.3%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:346:0 localize! [18] 49.9% simplify! [19] 30.8% finalize-iter! [21] 19.3% ---------------------------------------------------------------------- loop [10] 100.0% [15] 218(1.4%) 0(0.0%) filter-p&e ...s/herbie/master/src/points.rkt:256:0 for-loop [20] 100.0% ---------------------------------------------------------------------- loop [13] 46.4% loop [10] 53.6% [16] 7990(52.6%) 0(0.0%) make-exacts-walkup .../master/src/points.rkt:222:0 loop [22] 65.3% eval-prog [23] 34.7% ---------------------------------------------------------------------- loop [13] 33.1% loop [10] 66.9% [17] 5402(35.6%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:226:4 loop [22] 100.0% ---------------------------------------------------------------------- run-iter! [14] 100.0% [18] 480(3.2%) 0(0.0%) localize! .../herbie/master/src/mainloop.rkt:127:0 localize-error [24] 100.0% ---------------------------------------------------------------------- run-iter! [14] 100.0% [19] 296(1.9%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:224:0 ??? [25] 100.0% ---------------------------------------------------------------------- filter-p&e [15] 100.0% [20] 218(1.4%) 218(1.4%) for-loop ...ies/herbie/master/src/points.rkt:258:2 ---------------------------------------------------------------------- run-iter! [14] 100.0% [21] 186(1.2%) 0(0.0%) finalize-iter! ...ie/master/src/mainloop.rkt:278:0 ??? [33] 100.0% ---------------------------------------------------------------------- make-exacts-walkup [16] 0.4% loop [17] 2.2% ??? [2] 19.4% loop [22] 78.1% [22] 13174(86.8%) 0(0.0%) loop (unknown source) loop [22] 78.1% hash-ref! [27] 19.4% composed [26] 2.5% ---------------------------------------------------------------------- make-exacts-walkup [16] 100.0% [23] 2770(18.2%) 0(0.0%) eval-prog .../herbie/master/src/programs.rkt:106:0 hash-ref! [27] 92.1% inductor [29] 7.9% ---------------------------------------------------------------------- localize! [18] 100.0% [24] 480(3.2%) 0(0.0%) localize-error ...aster/src/core/localize.rkt:57:0 hash-ref! [27] 100.0% ---------------------------------------------------------------------- simplify! [19] 100.0% [25] 296(1.9%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:42:0 egraph-run [28] 100.0% ---------------------------------------------------------------------- loop [22] 100.0% [26] 10622(69.9%) 230(1.5%) composed ...ollects/racket/private/list.rkt:321:16 ??? [30] 88.7% ??? [49] 9.2% ---------------------------------------------------------------------- localize-error [24] 3.9% map [38] 12.0% eval-prog [23] 16.5% loop [22] 67.6% [27] 3032(20.0%) 180(1.2%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 67.6% parse-loop15 [32] 15.8% bigfloat-hash [31] 13.6% ---------------------------------------------------------------------- ??? [25] 100.0% [28] 296(1.9%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [34] 100.0% ---------------------------------------------------------------------- eval-prog [23] 100.0% [29] 218(1.4%) 0(0.0%) inductor ...s/herbie/master/src/programs.rkt:127:4 ??? [33] 100.0% ---------------------------------------------------------------------- composed [26] 100.0% [30] 9418(62.0%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 bf-complex-mult [35] 85.9% bf-complex-add [37] 14.1% ---------------------------------------------------------------------- hash-ref! [27] 100.0% [31] 2372(15.6%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:168:0 bfcanonicalize [36] 89.9% sig+exp->bigfloat [40] 10.1% ---------------------------------------------------------------------- hash-ref! [27] 100.0% [32] 480(3.2%) 0(0.0%) parse-loop15 (unknown source) map [38] 100.0% ---------------------------------------------------------------------- finalize-iter! [21] 46.0% inductor [29] 54.0% [33] 404(2.7%) 218(1.4%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [41] 46.0% ---------------------------------------------------------------------- egraph-run [28] 100.0% [34] 296(1.9%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [39] 100.0% ---------------------------------------------------------------------- ??? [30] 100.0% [35] 8090(53.3%) 308(2.0%) bf-complex-mult .../master/src/bigcomplex.rkt:30:0 bf* [42] 59.8% ??? [49] 30.5% ...higher-order.rkt:379:33 [43] 5.9% ---------------------------------------------------------------------- bigfloat-hash [31] 100.0% [36] 2132(14.0%) 1912(12.6%) bfcanonicalize .../private/bigfloat/mpfr.rkt:158:0 bigfloat->sig+exp [46] 10.3% ---------------------------------------------------------------------- ??? [30] 100.0% [37] 1328(8.7%) 0(0.0%) bf-complex-add ...e/master/src/bigcomplex.rkt:23:0 ??? [49] 100.0% ---------------------------------------------------------------------- parse-loop15 [32] 100.0% [38] 480(3.2%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 hash-ref! [27] 75.6% ??? [45] 20.6% loop [48] 3.8% ---------------------------------------------------------------------- egraph-add-exprs [34] 100.0% [39] 296(1.9%) 0(0.0%) ??? ...s/herbie/master/src/core/simplify.rkt:103:6 for-loop [44] 100.0% ---------------------------------------------------------------------- bigfloat-hash [31] 100.0% [40] 240(1.6%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:401:0 new-mpfr [57] 100.0% ---------------------------------------------------------------------- ??? [33] 100.0% [41] 186(1.2%) 0(0.0%) for-loop ...ie/master/src/core/alt-table.rkt:201:2 atab-add-altn [47] 100.0% ---------------------------------------------------------------------- bf-complex-mult [35] 100.0% [42] 4840(31.9%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [49] 100.0% ---------------------------------------------------------------------- bf-complex-mult [35] 100.0% [43] 478(3.1%) 478(3.1%) ...higher-order.rkt:379:33 (unknown source) ---------------------------------------------------------------------- ??? [39] 100.0% [44] 296(1.9%) 296(1.9%) for-loop ...bie/master/src/core/simplify.rkt:121:2 ---------------------------------------------------------------------- map [38] 100.0% [45] 296(1.9%) 0(0.0%) ??? ...s/herbie/master/src/core/localize.rkt:49:36 ??? [51] 100.0% ---------------------------------------------------------------------- bfcanonicalize [36] 100.0% [46] 220(1.4%) 0(0.0%) bigfloat->sig+exp ...ivate/bigfloat/mpfr.rkt:386:0 size+limbs->integer [52] 100.0% ---------------------------------------------------------------------- for-loop [41] 100.0% [47] 186(1.2%) 0(0.0%) atab-add-altn ...ster/src/core/alt-table.rkt:204:0 errors [50] 100.0% ---------------------------------------------------------------------- map [38] 1.6% loop [48] 98.4% [48] 184(1.2%) 0(0.0%) loop ...-7.5/collects/racket/private/map.rkt:40:19 loop [48] 98.4% ??? [49] 1.6% ---------------------------------------------------------------------- loop [48] 1.9% composed [26] 9.9% bf-complex-add [37] 13.6% bf-complex-mult [35] 25.2% bf* [42] 49.4% [49] 9790(64.5%) 1820(12.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [53] 66.9% bfneg [54] 14.5% ---------------------------------------------------------------------- atab-add-altn [47] 31.0% .../more-scheme.rkt:261:28 [5] 69.0% [50] 600(4.0%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:203:0 for-loop [55] 69.0% temp85_0 [56] 31.0% ---------------------------------------------------------------------- ??? [45] 100.0% [51] 296(1.9%) 296(1.9%) ??? ...htlies/herbie/master/src/interface.rkt:82:2 ---------------------------------------------------------------------- bigfloat->sig+exp [46] 100.0% [52] 220(1.4%) 220(1.4%) size+limbs->integer ...vate/bigfloat/gmp.rkt:103:0 ---------------------------------------------------------------------- ??? [49] 100.0% [53] 6548(43.1%) 402(2.6%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [58] 49.2% new-mpfr [57] 44.7% ---------------------------------------------------------------------- ??? [49] 100.0% [54] 1422(9.4%) 0(0.0%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:632:4 new-mpfr [57] 72.0% ??? [58] 28.0% ---------------------------------------------------------------------- errors [50] 100.0% [55] 414(2.7%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:205:2 .../more-scheme.rkt:261:28 [5] 100.0% ---------------------------------------------------------------------- errors [50] 100.0% [56] 186(1.2%) 0(0.0%) temp85_0 (unknown source) compile15 [59] 100.0% ---------------------------------------------------------------------- sig+exp->bigfloat [40] 5.7% bfneg [54] 24.4% bfmul [53] 69.8% [57] 4190(27.6%) 4190(27.6%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ---------------------------------------------------------------------- bfneg [54] 11.0% bfmul [53] 89.0% [58] 3618(23.8%) 3618(23.8%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ---------------------------------------------------------------------- temp85_0 [56] 100.0% [59] 186(1.2%) 0(0.0%) compile15 (unknown source) temp91_0 [60] 100.0% ---------------------------------------------------------------------- compile15 [59] 100.0% [60] 186(1.2%) 0(0.0%) temp91_0 (unknown source) temp118_0 [61] 100.0% ---------------------------------------------------------------------- temp91_0 [60] 100.0% [61] 186(1.2%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [62] 100.0% ---------------------------------------------------------------------- temp118_0 [61] 100.0% [62] 186(1.2%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [63] 100.0% ---------------------------------------------------------------------- expand-capturing-lifts [62] 100.0% [63] 186(1.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [64] 100.0% ---------------------------------------------------------------------- lambda-clause-expander [63] 3.3% for-loop [65] 96.7% [64] 186(1.2%) 0(0.0%) finish-bodys (unknown source) for-loop [65] 100.0% ---------------------------------------------------------------------- for-loop [65] 6.2% finish-bodys [64] 93.8% [65] 186(1.2%) 0(0.0%) for-loop (unknown source) finish-bodys [64] 90.6% for-loop [65] 6.2% dispatch-transformer41 [66] 3.1% ---------------------------------------------------------------------- for-loop [65] 100.0% [66] 186(1.2%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [67] 100.0% ---------------------------------------------------------------------- dispatch-transformer41 [66] 100.0% [67] 186(1.2%) 186(1.2%) apply-transformer52 (unknown source) ----------------------------------------------------------------------