Profiling results ----------------- Total cpu time observed: 69576ms (out of 71196ms) Number of samples taken: 165 (once every 422ms) (Hiding functions with self<1.0% and local<2.0%: 1 of 81 hidden) ======================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================= ??? [5] 100.0% [1] 69576(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ----------------------------------------------------------------------- ??? [5] 100.0% [2] 320(0.5%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:205:0 for-loop [4] 100.0% ----------------------------------------------------------------------- profile-thunk16 [1] 100.0% [3] 69576(100.0%) 0(0.0%) run ...et-7.2/share/pkgs/profile-lib/main.rkt:39:2 ??? [5] 100.0% ----------------------------------------------------------------------- errors [2] 100.0% [4] 320(0.5%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:207:2 ??? [5] 100.0% ----------------------------------------------------------------------- for-loop [4] 0.2% run [3] 49.9% [5] 69576(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 49.9% loop [9] 46.1% run-improve47 [6] 2.9% eval-errors [7] 0.5% oracle-error [8] 0.2% errors [2] 0.2% precision->real [16] 0.2% ----------------------------------------------------------------------- ??? [5] 100.0% [6] 4034(5.8%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:342:0 loop [9] 76.1% for-loop [10] 23.9% ----------------------------------------------------------------------- ??? [5] 100.0% [7] 672(1.0%) 0(0.0%) eval-errors .../herbie/master/src/points.rkt:179:0 for-loop [11] 100.0% ----------------------------------------------------------------------- ??? [5] 100.0% [8] 344(0.5%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:188:0 for-loop [12] 100.0% ----------------------------------------------------------------------- run-improve47 [6] 4.6% ??? [5] 95.4% [9] 67276(96.7%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:284:2 loop [17] 34.2% loop [13] 33.0% make-exacts-walkup [18] 29.6% for-loop [14] 3.2% ----------------------------------------------------------------------- run-improve47 [6] 100.0% [10] 964(1.4%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:359:4 run-iter! [15] 100.0% ----------------------------------------------------------------------- eval-errors [7] 100.0% [11] 672(1.0%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:181:2 ??? [45] 50.6% precision->real [16] 49.4% ----------------------------------------------------------------------- oracle-error [8] 100.0% [12] 344(0.5%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:189:2 loop [37] 100.0% ----------------------------------------------------------------------- loop [9] 100.0% [13] 22216(31.9%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:243:2 make-exacts-walkup [18] 51.2% loop [17] 48.8% ----------------------------------------------------------------------- loop [9] 100.0% [14] 2154(3.1%) 0(0.0%) for-loop ...es/herbie/master/src/points.rkt:304:19 ??? [19] 100.0% ----------------------------------------------------------------------- for-loop [10] 100.0% [15] 964(1.4%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:323:0 localize! [20] 65.6% simplify! [21] 34.4% ----------------------------------------------------------------------- ??? [5] 49.1% for-loop [11] 50.9% [16] 652(0.9%) 320(0.5%) precision->real ...e/master/src/programs.rkt:92:33 infer-representation [54] 50.9% ----------------------------------------------------------------------- loop [13] 32.1% loop [9] 67.9% [17] 33822(48.6%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:226:4 loop [37] 99.0% gen-andmap [24] 1.0% ----------------------------------------------------------------------- loop [13] 36.3% loop [9] 63.7% [18] 31300(45.0%) 0(0.0%) make-exacts-walkup .../master/src/points.rkt:222:0 loop [37] 95.6% eval-prog [22] 4.4% ----------------------------------------------------------------------- for-loop [14] 100.0% [19] 2154(3.1%) 308(0.4%) ??? ...ightlies/herbie/master/src/points.rkt:106:2 ??? [53] 71.8% do-curry [26] 13.9% ----------------------------------------------------------------------- run-iter! [15] 100.0% [20] 632(0.9%) 0(0.0%) localize! .../herbie/master/src/mainloop.rkt:123:0 localize-error [23] 100.0% ----------------------------------------------------------------------- run-iter! [15] 100.0% [21] 332(0.5%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:220:0 ??? [25] 100.0% ----------------------------------------------------------------------- make-exacts-walkup [18] 100.0% [22] 1388(2.0%) 0(0.0%) eval-prog ...s/herbie/master/src/programs.rkt:83:0 temp85_0 [27] 74.6% loop [47] 25.4% ----------------------------------------------------------------------- localize! [20] 100.0% [23] 632(0.9%) 0(0.0%) localize-error ...aster/src/core/localize.rkt:65:0 hash-ref! [28] 100.0% ----------------------------------------------------------------------- loop [17] 100.0% [24] 354(0.5%) 0(0.0%) gen-andmap ...ollects/racket/private/map.rkt:275:2 check-args [29] 100.0% ----------------------------------------------------------------------- simplify! [21] 100.0% [25] 332(0.5%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:26:0 one-iter [30] 100.0% ----------------------------------------------------------------------- ??? [19] 100.0% [26] 300(0.4%) 300(0.4%) do-curry ...-7.2/collects/racket/function.rkt:71:2 ----------------------------------------------------------------------- eval-prog [22] 100.0% [27] 1036(1.5%) 0(0.0%) temp85_0 (unknown source) compile15 [31] 100.0% ----------------------------------------------------------------------- localize-error [23] 38.1% map [35] 61.9% [28] 632(0.9%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop30 [32] 100.0% ----------------------------------------------------------------------- gen-andmap [24] 100.0% [29] 354(0.5%) 354(0.5%) check-args ...ollects/racket/private/map.rkt:180:2 ----------------------------------------------------------------------- ??? [25] 100.0% [30] 332(0.5%) 0(0.0%) one-iter ...rbie/master/src/core/simplify.rkt:72:0 find-matches [33] 100.0% ----------------------------------------------------------------------- temp85_0 [27] 100.0% [31] 1036(1.5%) 0(0.0%) compile15 (unknown source) temp91_0 [34] 100.0% ----------------------------------------------------------------------- hash-ref! [28] 100.0% [32] 632(0.9%) 0(0.0%) parse-loop30 ...s/racket/match/compiler.rkt:418:15 map [35] 100.0% ----------------------------------------------------------------------- one-iter [30] 100.0% [33] 332(0.5%) 0(0.0%) find-matches .../master/src/core/simplify.rkt:62:0 for-loop [36] 100.0% ----------------------------------------------------------------------- compile15 [31] 100.0% [34] 1036(1.5%) 0(0.0%) temp91_0 (unknown source) temp118_0 [38] 59.7% compile-top9 [39] 40.3% ----------------------------------------------------------------------- parse-loop30 [32] 100.0% [35] 632(0.9%) 0(0.0%) map ...t-7.2/collects/racket/private/map.rkt:35:13 hash-ref! [28] 61.9% loop [37] 38.1% ----------------------------------------------------------------------- for-loop [36] 50.0% find-matches [33] 50.0% [36] 332(0.5%) 0(0.0%) for-loop ...rbie/master/src/core/simplify.rkt:64:8 for-loop [36] 50.0% match-e [40] 50.0% ----------------------------------------------------------------------- map [35] 0.1% for-loop [12] 0.5% loop [17] 1.0% make-exacts-walkup [18] 2.5% loop [37] 95.9% [37] 64356(92.5%) 324(0.5%) loop ...-7.2/collects/racket/private/map.rkt:40:19 loop [37] 95.9% composed [41] 2.6% ??? [45] 0.9% ??? [52] 0.1% ??? [80] 0.0% ----------------------------------------------------------------------- temp91_0 [34] 100.0% [38] 618(0.9%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [42] 100.0% ----------------------------------------------------------------------- temp91_0 [34] 100.0% [39] 418(0.6%) 0(0.0%) compile-top9 (unknown source) compile-forms33 [43] 100.0% ----------------------------------------------------------------------- for-loop [36] 100.0% [40] 332(0.5%) 0(0.0%) match-e .../herbie/master/src/core/ematch.rkt:39:0 for-loop [44] 100.0% ----------------------------------------------------------------------- loop [37] 100.0% [41] 58300(83.8%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [45] 100.0% ----------------------------------------------------------------------- loop [47] 36.3% temp118_0 [38] 63.7% [42] 970(1.4%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [46] 63.7% loop [47] 36.3% ----------------------------------------------------------------------- compile-top9 [39] 100.0% [43] 418(0.6%) 0(0.0%) compile-forms33 (unknown source) for-loop [55] 100.0% ----------------------------------------------------------------------- match-e [40] 100.0% [44] 332(0.5%) 332(0.5%) for-loop ...erbie/master/src/core/ematch.rkt:52:11 ----------------------------------------------------------------------- for-loop [11] 0.5% loop [37] 7.0% composed [41] 92.5% [45] 63046(90.6%) 370(0.5%) ??? ...htlies/herbie/master/src/programs.rkt:108:2 ??? [48] 86.0% ??? [53] 9.7% real->precision [49] 3.2% real->precision [51] 0.5% ----------------------------------------------------------------------- expand-capturing-lifts [42] 100.0% [46] 618(0.9%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [50] 100.0% ----------------------------------------------------------------------- loop [47] 33.3% expand-capturing-lifts [42] 33.3% eval-prog [22] 33.3% [47] 352(0.5%) 0(0.0%) loop (unknown source) expand-capturing-lifts [42] 33.3% loop [47] 33.3% for-loop [55] 33.3% ----------------------------------------------------------------------- ??? [45] 100.0% [48] 54198(77.9%) 472(0.7%) ??? ...t-7.2/collects/racket/private/kw.rkt:594:14 ??? [52] 95.1% ??? [53] 4.0% ----------------------------------------------------------------------- ??? [45] 100.0% [49] 2020(2.9%) 368(0.5%) real->precision ...e/master/src/programs.rkt:86:33 infer-representation [54] 81.8% ----------------------------------------------------------------------- lambda-clause-expander [46] 18.2% for-loop [55] 81.8% [50] 618(0.9%) 0(0.0%) finish-bodys (unknown source) for-loop [55] 100.0% ----------------------------------------------------------------------- ??? [45] 100.0% [51] 340(0.5%) 0(0.0%) real->precision ...e/master/src/programs.rkt:87:33 infer-representation [54] 100.0% ----------------------------------------------------------------------- loop [37] 1.2% ??? [48] 98.8% [52] 52166(75.0%) 998(1.4%) ??? ...tract/private/arrow-higher-order.rkt:364:33 bf-complex-div [56] 47.1% bf-complex-exp [57] 41.1% bf-complex-add [59] 5.5% bf-complex-neg [60] 4.3% ----------------------------------------------------------------------- ??? [19] 15.7% ??? [48] 22.2% ??? [45] 62.1% [53] 9856(14.2%) 5352(7.7%) ??? ...tract/private/arrow-higher-order.rkt:360:33 bf [58] 30.0% sample-multi-bounded [61] 15.7% ----------------------------------------------------------------------- precision->real [16] 14.3% real->precision [51] 14.6% real->precision [49] 71.1% [54] 2324(3.3%) 1696(2.4%) infer-representation .../master/src/float.rkt:15:0 return/no-unsupplied [68] 27.0% ----------------------------------------------------------------------- for-loop [55] 3.4% run-module-instance!125 [63] 12.7% loop [47] 12.7% compile-forms33 [43] 30.1% finish-bodys [50] 41.1% [55] 1388(2.0%) 352(0.5%) for-loop (unknown source) finish-bodys [50] 33.7% compile-module-linklet57 [62] 30.1% run-module-instance!125 [63] 12.7% expand-body7 [64] 4.0% for-loop [55] 3.4% dispatch-transformer41 [65] 3.4% ----------------------------------------------------------------------- ??? [52] 100.0% [56] 24566(35.3%) 1766(2.5%) bf-complex-div ...e/master/src/bigcomplex.rkt:54:0 ??? [72] 44.0% bf* [66] 36.5% ...higher-order.rkt:364:33 [67] 12.3% ----------------------------------------------------------------------- ??? [52] 100.0% [57] 21460(30.8%) 678(1.0%) bf-complex-exp ...e/master/src/bigcomplex.rkt:37:0 ??? [72] 76.9% bf* [66] 16.8% ...higher-order.rkt:364:33 [67] 3.1% ----------------------------------------------------------------------- ??? [53] 100.0% [58] 2958(4.3%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [79] 83.2% ??? [80] 16.8% ----------------------------------------------------------------------- ??? [52] 100.0% [59] 2894(4.2%) 0(0.0%) bf-complex-add ...e/master/src/bigcomplex.rkt:23:0 ??? [72] 100.0% ----------------------------------------------------------------------- ??? [52] 100.0% [60] 2248(3.2%) 0(0.0%) bf-complex-neg ...e/master/src/bigcomplex.rkt:20:0 ??? [72] 84.0% ...higher-order.rkt:364:33 [67] 16.0% ----------------------------------------------------------------------- ??? [53] 100.0% [61] 1546(2.2%) 300(0.4%) sample-multi-bounded ...master/src/points.rkt:15:0 random-ranges [69] 41.0% return/no-unsupplied [68] 19.9% for-loop [70] 19.7% ----------------------------------------------------------------------- for-loop [55] 100.0% [62] 418(0.6%) 418(0.6%) compile-module-linklet57 (unknown source) ----------------------------------------------------------------------- for-loop [55] 100.0% [63] 352(0.5%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [55] 100.0% ----------------------------------------------------------------------- for-loop [55] 100.0% [64] 334(0.5%) 334(0.5%) expand-body7 (unknown source) ----------------------------------------------------------------------- for-loop [55] 100.0% [65] 284(0.4%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [71] 100.0% ----------------------------------------------------------------------- bf-complex-exp [57] 28.7% bf-complex-div [56] 71.3% [66] 12580(18.1%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [72] 100.0% ----------------------------------------------------------------------- bf-complex-neg [60] 8.9% bf-complex-exp [57] 16.3% bf-complex-div [56] 74.8% [67] 4054(5.8%) 988(1.4%) ...higher-order.rkt:364:33 (unknown source) ??? [73] 38.2% ??? [78] 37.4% ----------------------------------------------------------------------- sample-multi-bounded [61] 32.9% infer-representation [54] 67.1% [68] 936(1.3%) 332(0.5%) return/no-unsupplied ...ct/private/arr-i.rkt:542:0 filter [74] 64.5% ----------------------------------------------------------------------- sample-multi-bounded [61] 100.0% [69] 634(0.9%) 300(0.4%) random-ranges ...erbie/master/src/common.rkt:183:0 build--> [75] 52.7% ----------------------------------------------------------------------- sample-multi-bounded [61] 100.0% [70] 304(0.4%) 304(0.4%) for-loop ...lies/herbie/master/src/points.rkt:23:4 ----------------------------------------------------------------------- dispatch-transformer41 [65] 100.0% [71] 284(0.4%) 284(0.4%) apply-transformer52 (unknown source) ----------------------------------------------------------------------- bf-complex-neg [60] 4.2% bf-complex-add [59] 6.5% bf-complex-div [56] 24.2% bf* [66] 28.2% bf-complex-exp [57] 37.0% [72] 44670(64.2%) 13912(20.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfdiv [76] 48.8% bfneg [77] 20.0% ----------------------------------------------------------------------- ...higher-order.rkt:364:33 [67]100.0% [73] 1548(2.2%) 1210(1.7%) ??? ...cts/racket/contract/private/list.rkt:209:10 ??? [78] 21.8% ----------------------------------------------------------------------- return/no-unsupplied [68] 100.0% [74] 604(0.9%) 604(0.9%) filter ...2/collects/racket/private/list.rkt:256:2 ----------------------------------------------------------------------- random-ranges [69] 100.0% [75] 334(0.5%) 334(0.5%) build--> ...act/private/arrow-val-first.rkt:1088:0 ----------------------------------------------------------------------- ??? [72] 100.0% [76] 21816(31.4%) 0(0.0%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [79] 81.1% ??? [80] 18.9% ----------------------------------------------------------------------- ??? [72] 100.0% [77] 8942(12.9%) 334(0.5%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [79] 74.9% ??? [80] 21.3% ----------------------------------------------------------------------- ??? [73] 18.2% ...higher-order.rkt:364:33 [67] 81.8% [78] 1856(2.7%) 1856(2.7%) ??? ...ects/racket/contract/private/guts.rkt:772:8 ----------------------------------------------------------------------- bf [58] 9.2% bfneg [77] 24.9% bfdiv [76] 65.9% [79] 26862(38.6%) 26862(38.6%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ----------------------------------------------------------------------- loop [37] 5.1% bf [58] 7.2% bfneg [77] 27.8% bfdiv [76] 59.9% [80] 6870(9.9%) 6870(9.9%) ??? /opt/racket-7.2/collects/ffi/unsafe.rkt:905:4 -----------------------------------------------------------------------