Profiling results ----------------- Total cpu time observed: 131124ms (out of 133596ms) Number of samples taken: 334 (once every 393ms) (Hiding functions with self<1.0% and local<2.0%: 2 of 80 hidden) ========================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ========================================================================== ??? [6] 100.0% [1] 131124(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [4] 100.0% -------------------------------------------------------------------------- hash-ref! [25] 100.0% [2] 1394(1.1%) 0(0.0%) ??? ...htlies/herbie/master/src/programs.rkt:161:5 loop [20] 100.0% -------------------------------------------------------------------------- ??? [6] 100.0% [3] 304(0.2%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:205:0 for-loop [5] 100.0% -------------------------------------------------------------------------- profile-thunk16 [1] 100.0% [4] 131124(100.0%) 0(0.0%) run ...et-7.2/share/pkgs/profile-lib/main.rkt:39:2 ??? [6] 100.0% -------------------------------------------------------------------------- errors [3] 100.0% [5] 304(0.2%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:207:2 ??? [6] 100.0% -------------------------------------------------------------------------- for-loop [5] 0.1% run [4] 50.0% [6] 131124(100.0%) 304(0.2%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% loop [9] 47.2% run-improve47 [7] 2.5% oracle-error [8] 0.1% errors [3] 0.1% -------------------------------------------------------------------------- ??? [6] 100.0% [7] 6448(4.9%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:345:0 loop [9] 80.3% for-loop [10] 19.7% -------------------------------------------------------------------------- ??? [6] 100.0% [8] 356(0.3%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:188:0 for-loop [11] 100.0% -------------------------------------------------------------------------- run-improve47 [7] 4.0% ??? [6] 96.0% [9] 128866(98.3%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:281:2 loop [15] 36.6% loop [12] 33.6% make-exacts-walkup [16] 28.3% for-loop [13] 1.5% -------------------------------------------------------------------------- run-improve47 [7] 100.0% [10] 1270(1.0%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:364:4 run-iter! [14] 100.0% -------------------------------------------------------------------------- oracle-error [8] 100.0% [11] 356(0.3%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:189:2 loop [20] 100.0% -------------------------------------------------------------------------- loop [9] 100.0% [12] 43338(33.1%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:244:2 make-exacts-walkup [16] 50.9% loop [15] 49.1% -------------------------------------------------------------------------- loop [9] 100.0% [13] 1938(1.5%) 0(0.0%) for-loop ...es/herbie/master/src/points.rkt:301:19 ??? [17] 100.0% -------------------------------------------------------------------------- for-loop [10] 100.0% [14] 1270(1.0%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:326:0 localize! [18] 76.2% gen-rewrites! [19] 23.8% -------------------------------------------------------------------------- loop [12] 31.1% loop [9] 68.9% [15] 68424(52.2%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:227:4 loop [20] 100.0% -------------------------------------------------------------------------- loop [12] 37.7% loop [9] 62.3% [16] 58504(44.6%) 0(0.0%) make-exacts-walkup .../master/src/points.rkt:222:0 loop [20] 93.8% eval-prog [21] 6.2% -------------------------------------------------------------------------- for-loop [13] 100.0% [17] 1938(1.5%) 310(0.2%) ??? ...ightlies/herbie/master/src/points.rkt:106:2 ??? [36] 84.0% -------------------------------------------------------------------------- run-iter! [14] 100.0% [18] 968(0.7%) 0(0.0%) localize! .../herbie/master/src/mainloop.rkt:126:0 localize-error [22] 100.0% -------------------------------------------------------------------------- run-iter! [14] 100.0% [19] 302(0.2%) 0(0.0%) gen-rewrites! ...bie/master/src/mainloop.rkt:182:0 for-loop [23] 100.0% -------------------------------------------------------------------------- map [38] 0.0% ??? [33] 0.0% for-loop [11] 0.3% make-exacts-walkup [16] 0.6% loop [15] 0.8% ??? [2] 1.1% loop [20] 97.2% [20] 125992(96.1%) 1330(1.0%) loop ...-7.2/collects/racket/private/map.rkt:40:19 loop [20] 97.2% composed [24] 1.4% hash-ref! [25] 1.1% ??? [29] 0.3% ??? [36] 0.0% ??? [42] 0.0% ??? [71] 0.0% -------------------------------------------------------------------------- make-exacts-walkup [16] 100.0% [21] 3650(2.8%) 0(0.0%) eval-prog ...s/herbie/master/src/programs.rkt:83:0 hash-ref! [25] 47.0% inductor [26] 33.8% loop [58] 9.8% temp85_0 [27] 9.4% -------------------------------------------------------------------------- localize! [18] 100.0% [22] 968(0.7%) 0(0.0%) localize-error ...aster/src/core/localize.rkt:66:0 hash-ref! [25] 100.0% -------------------------------------------------------------------------- gen-rewrites! [19] 100.0% [23] 302(0.2%) 0(0.0%) for-loop .../herbie/master/src/mainloop.rkt:190:11 rewrite-expression-head20 [28] 100.0% -------------------------------------------------------------------------- loop [20] 100.0% [24] 117002(89.2%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [29] 100.0% -------------------------------------------------------------------------- localize-error [22] 8.0% map [38] 28.1% eval-prog [21] 28.4% loop [20] 35.6% [25] 2684(2.0%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 35.6% parse-loop30 [31] 34.0% bigfloat-hash [30] 28.4% ??? [33] 2.1% -------------------------------------------------------------------------- eval-prog [21] 33.3% inductor [26] 66.7% [26] 1234(0.9%) 0(0.0%) inductor ...s/herbie/master/src/programs.rkt:104:4 inductor [26] 66.7% ??? [36] 33.3% -------------------------------------------------------------------------- eval-prog [21] 100.0% [27] 344(0.3%) 0(0.0%) temp85_0 (unknown source) compile15 [32] 100.0% -------------------------------------------------------------------------- for-loop [23] 100.0% [28] 302(0.2%) 0(0.0%) rewrite-expression-head20 ...core/matcher.rkt:87:0 rewriter [34] 100.0% -------------------------------------------------------------------------- loop [20] 4.3% composed [24] 95.7% [29] 122272(93.2%) 2320(1.8%) ??? ...htlies/herbie/master/src/programs.rkt:115:2 ??? [35] 92.6% ??? [36] 5.5% -------------------------------------------------------------------------- hash-ref! [25] 100.0% [30] 1716(1.3%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 sig+exp->bigfloat [37] 81.2% bfcanonicalize [40] 18.8% -------------------------------------------------------------------------- hash-ref! [25] 100.0% [31] 968(0.7%) 0(0.0%) parse-loop30 ...s/racket/match/compiler.rkt:418:15 map [38] 100.0% -------------------------------------------------------------------------- temp85_0 [27] 100.0% [32] 344(0.3%) 0(0.0%) compile15 (unknown source) temp91_0 [39] 100.0% -------------------------------------------------------------------------- hash-ref! [25] 100.0% [33] 334(0.3%) 0(0.0%) ??? ...s/herbie/master/src/core/localize.rkt:23:13 loop [20] 100.0% -------------------------------------------------------------------------- rewrite-expression-head20 [28] 100.0% [34] 302(0.2%) 0(0.0%) rewriter ...erbie/master/src/core/matcher.rkt:90:2 *rules* [41] 100.0% -------------------------------------------------------------------------- ??? [29] 100.0% [35] 113240(86.4%) 360(0.3%) ??? ...t-7.2/collects/racket/private/kw.rkt:594:14 ??? [42] 99.7% -------------------------------------------------------------------------- loop [20] 3.4% inductor [26] 12.5% ??? [17] 16.4% ??? [29] 67.7% [36] 9908(7.6%) 2762(2.1%) ??? ...tract/private/arrow-higher-order.rkt:360:33 bf [43] 59.0% sample-multi-bounded [44] 13.1% -------------------------------------------------------------------------- bigfloat-hash [30] 100.0% [37] 1394(1.1%) 340(0.3%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:387:0 new-mpfr [70] 75.6% -------------------------------------------------------------------------- parse-loop30 [31] 100.0% [38] 968(0.7%) 0(0.0%) map ...t-7.2/collects/racket/private/map.rkt:35:13 hash-ref! [25] 83.6% loop [46] 8.6% loop [20] 7.8% -------------------------------------------------------------------------- compile15 [32] 100.0% [39] 344(0.3%) 0(0.0%) temp91_0 (unknown source) temp118_0 [45] 100.0% -------------------------------------------------------------------------- bigfloat-hash [30] 100.0% [40] 322(0.2%) 322(0.2%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 -------------------------------------------------------------------------- rewriter [34] 100.0% [41] 302(0.2%) 0(0.0%) *rules* ...erbie/master/src/syntax/rules.rkt:666:0 for-loop [47] 100.0% -------------------------------------------------------------------------- loop [20] 0.3% ??? [35] 99.7% [42] 113182(86.3%) 344(0.3%) ??? ...tract/private/arrow-higher-order.rkt:364:33 bf-complex-exp [48] 69.4% bf-complex-div [49] 25.2% bf-complex-add [50] 3.7% -------------------------------------------------------------------------- ??? [36] 100.0% [43] 5850(4.5%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [70] 100.0% -------------------------------------------------------------------------- ??? [36] 100.0% [44] 1296(1.0%) 0(0.0%) sample-multi-bounded ...master/src/points.rkt:15:0 random-ranges [51] 100.0% -------------------------------------------------------------------------- temp91_0 [39] 100.0% [45] 344(0.3%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [52] 100.0% -------------------------------------------------------------------------- map [38] 5.9% loop [46] 94.1% [46] 332(0.3%) 0(0.0%) loop ...-7.2/collects/racket/private/map.rkt:54:19 loop [46] 94.1% ??? [53] 5.9% -------------------------------------------------------------------------- *rules* [41] 100.0% [47] 302(0.2%) 0(0.0%) for-loop ...lies/herbie/master/src/common.rkt:74:9 ormap [54] 100.0% -------------------------------------------------------------------------- ??? [42] 100.0% [48] 78502(59.9%) 282(0.2%) bf-complex-exp ...e/master/src/bigcomplex.rkt:37:0 ??? [61] 92.6% bf* [55] 7.0% -------------------------------------------------------------------------- ??? [42] 100.0% [49] 28578(21.8%) 2818(2.1%) bf-complex-div ...e/master/src/bigcomplex.rkt:54:0 bf* [55] 49.2% ??? [61] 39.6% ...higher-order.rkt:364:33 [57] 1.2% -------------------------------------------------------------------------- ??? [42] 100.0% [50] 4242(3.2%) 292(0.2%) bf-complex-add ...e/master/src/bigcomplex.rkt:23:0 ??? [61] 85.1% ...higher-order.rkt:364:33 [57] 8.0% -------------------------------------------------------------------------- sample-multi-bounded [44] 100.0% [51] 1296(1.0%) 322(0.2%) random-ranges ...erbie/master/src/common.rkt:183:0 cons/c [56] 75.2% -------------------------------------------------------------------------- temp118_0 [45] 49.1% loop [58] 50.9% [52] 700(0.5%) 0(0.0%) expand-capturing-lifts (unknown source) loop [58] 50.9% lambda-clause-expander [59] 49.1% -------------------------------------------------------------------------- loop [46] 100.0% [53] 332(0.3%) 0(0.0%) ??? ...s/herbie/master/src/core/localize.rkt:58:36 ??? [60] 100.0% -------------------------------------------------------------------------- for-loop [47] 100.0% [54] 302(0.2%) 302(0.2%) ormap ....2/collects/racket/private/map.rkt:141:13 -------------------------------------------------------------------------- bf-complex-exp [48] 28.1% bf-complex-div [49] 71.9% [55] 19576(14.9%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [61] 100.0% -------------------------------------------------------------------------- random-ranges [51] 100.0% [56] 974(0.7%) 326(0.2%) cons/c .../racket/contract/private/guts.rkt:504:15 coerce-contract [63] 66.5% -------------------------------------------------------------------------- bf-complex-add [50] 48.9% bf-complex-div [49] 51.1% [57] 696(0.5%) 0(0.0%) ...higher-order.rkt:364:33 (unknown source) ??? [62] 100.0% -------------------------------------------------------------------------- loop [58] 33.3% expand-capturing-lifts [52] 33.3% eval-prog [21] 33.3% [58] 356(0.3%) 0(0.0%) loop (unknown source) expand-capturing-lifts [52] 33.3% loop [58] 33.3% for-loop [67] 33.3% -------------------------------------------------------------------------- expand-capturing-lifts [52] 100.0% [59] 344(0.3%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [64] 100.0% -------------------------------------------------------------------------- ??? [53] 100.0% [60] 332(0.3%) 332(0.3%) ??? ...htlies/herbie/master/src/interface.rkt:70:2 -------------------------------------------------------------------------- bf-complex-add [50] 3.3% bf-complex-div [49] 10.4% bf* [55] 18.0% bf-complex-exp [48] 66.9% [61] 108750(82.9%) 67688(51.6%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [65] 23.5% bfneg [66] 14.3% -------------------------------------------------------------------------- ...higher-order.rkt:364:33 [57] 100.0% [62] 696(0.5%) 0(0.0%) ??? ...cts/racket/contract/private/list.rkt:209:10 ??? [68] 100.0% -------------------------------------------------------------------------- cons/c [56] 100.0% [63] 648(0.5%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:308:0 coerce-contract/f [69] 100.0% -------------------------------------------------------------------------- lambda-clause-expander [59] 9.1% for-loop [67] 90.9% [64] 344(0.3%) 0(0.0%) finish-bodys (unknown source) for-loop [67] 100.0% -------------------------------------------------------------------------- ??? [61] 100.0% [65] 25524(19.5%) 690(0.5%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [70] 74.5% ??? [71] 22.8% -------------------------------------------------------------------------- ??? [61] 100.0% [66] 15538(11.8%) 0(0.0%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [70] 62.9% ??? [71] 37.1% -------------------------------------------------------------------------- for-loop [67] 4.1% temp37_0 [73] 17.0% run-module-instance!125 [74] 17.0% loop [58] 17.0% finish-bodys [64] 45.0% [67] 700(0.5%) 356(0.3%) for-loop (unknown source) finish-bodys [64] 41.0% run-module-instance!125 [74] 17.0% temp37_0 [73] 17.0% for-loop [67] 4.1% dispatch-transformer41 [75] 4.1% -------------------------------------------------------------------------- ??? [62] 100.0% [68] 696(0.5%) 696(0.5%) ??? ...ects/racket/contract/private/guts.rkt:772:8 -------------------------------------------------------------------------- coerce-contract [63] 100.0% [69] 648(0.5%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:373:0 coerce-simple-value [72] 100.0% -------------------------------------------------------------------------- sig+exp->bigfloat [37] 3.0% bf [43] 16.4% bfneg [66] 27.4% bfmul [65] 53.3% [70] 35710(27.2%) 35710(27.2%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 -------------------------------------------------------------------------- loop [20] 3.0% bfneg [66] 48.3% bfmul [65] 48.7% [71] 11926(9.1%) 11926(9.1%) ??? /opt/racket-7.2/collects/ffi/unsafe.rkt:905:4 -------------------------------------------------------------------------- coerce-contract/f [69] 100.0% [72] 648(0.5%) 648(0.5%) coerce-simple-value ...ract/private/guts.rkt:386:0 -------------------------------------------------------------------------- for-loop [67] 100.0% [73] 356(0.3%) 0(0.0%) temp37_0 (unknown source) for-loop [67] 100.0% -------------------------------------------------------------------------- for-loop [67] 100.0% [74] 356(0.3%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [67] 100.0% -------------------------------------------------------------------------- for-loop [67] 100.0% [75] 344(0.3%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [76] 100.0% -------------------------------------------------------------------------- dispatch-transformer41 [75] 100.0% [76] 344(0.3%) 0(0.0%) apply-transformer52 (unknown source) apply-transformer-in-context [77]100.0% -------------------------------------------------------------------------- apply-transformer52 [76] 100.0% [77] 344(0.3%) 0(0.0%) apply-transformer-in-context (unknown source) parse-app [78] 100.0% -------------------------------------------------------------------------- apply-transformer-in-context [77]100.0% [78] 344(0.3%) 344(0.3%) parse-app ...collects/racket/private/kw.rkt:1107:2 --------------------------------------------------------------------------