Profiling results ----------------- Total cpu time observed: 139174ms (out of 141728ms) Number of samples taken: 356 (once every 391ms) (Hiding functions with self<1.0% and local<2.0%: 2 of 71 hidden) ============================================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================================================== ??? [8] 100.0% [1] 139174(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% ---------------------------------------------------------------------------------------------- hash-ref! [33] 100.0% [2] 1452(1.0%) 0(0.0%) ??? ...htlies/herbie/master/src/programs.rkt:161:5 loop [27] 100.0% ---------------------------------------------------------------------------------------------- for-loop [65] 100.0% [3] 360(0.3%) 0(0.0%) namespace-module-use->module+linklet-instances144 ... module-path-index-resolve [6] 100.0% ---------------------------------------------------------------------------------------------- ??? [8] 100.0% [4] 324(0.2%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:205:0 for-loop [7] 100.0% ---------------------------------------------------------------------------------------------- profile-thunk16 [1] 100.0% [5] 139174(100.0%) 0(0.0%) run ...et-7.2/share/pkgs/profile-lib/main.rkt:39:2 ??? [8] 100.0% ---------------------------------------------------------------------------------------------- namespace-module-use->module+linklet-instances144 [3]100.0% [6] 360(0.3%) 0(0.0%) module-path-index-resolve (unknown source) standard-module-name-resolver [9] 100.0% ---------------------------------------------------------------------------------------------- errors [4] 100.0% [7] 324(0.2%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:207:2 ??? [8] 100.0% ---------------------------------------------------------------------------------------------- for-loop [7] 0.1% run [5] 50.0% [8] 139174(100.0%) 324(0.2%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% loop [13] 47.6% run-improve47 [10] 2.2% oracle-error [12] 0.1% errors [4] 0.1% ---------------------------------------------------------------------------------------------- module-path-index-resolve [6] 100.0% [9] 360(0.3%) 0(0.0%) standard-module-name-resolver (unknown source) weak-intern! [11] 100.0% ---------------------------------------------------------------------------------------------- ??? [8] 100.0% [10] 6160(4.4%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:345:0 loop [13] 78.5% for-loop [14] 16.8% ??? [16] 4.7% ---------------------------------------------------------------------------------------------- standard-module-name-resolver [9] 100.0% [11] 360(0.3%) 0(0.0%) weak-intern! (unknown source) for-loop [65] 100.0% ---------------------------------------------------------------------------------------------- ??? [8] 100.0% [12] 292(0.2%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:188:0 for-loop [15] 100.0% ---------------------------------------------------------------------------------------------- run-improve47 [10] 3.5% ??? [8] 96.5% [13] 137236(98.6%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:281:2 loop [21] 34.4% loop [17] 34.0% make-exacts-walkup [22] 30.0% for-loop [18] 1.4% ??? [23] 0.2% ---------------------------------------------------------------------------------------------- run-improve47 [10] 100.0% [14] 1034(0.7%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:364:4 run-iter! [19] 100.0% ---------------------------------------------------------------------------------------------- oracle-error [12] 100.0% [15] 292(0.2%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:189:2 loop [27] 100.0% ---------------------------------------------------------------------------------------------- run-improve47 [10] 100.0% [16] 288(0.2%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:390:18 make-alt-table [20] 100.0% ---------------------------------------------------------------------------------------------- loop [13] 100.0% [17] 46692(33.5%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:244:2 make-exacts-walkup [22] 50.7% loop [21] 49.3% ---------------------------------------------------------------------------------------------- loop [13] 100.0% [18] 1884(1.4%) 0(0.0%) for-loop ...es/herbie/master/src/points.rkt:301:19 ??? [23] 100.0% ---------------------------------------------------------------------------------------------- for-loop [14] 100.0% [19] 1034(0.7%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:326:0 localize! [24] 68.1% gen-rewrites! [25] 31.9% ---------------------------------------------------------------------------------------------- ??? [16] 100.0% [20] 288(0.2%) 0(0.0%) make-alt-table ...ster/src/core/alt-table.rkt:32:0 for-loop [26] 100.0% ---------------------------------------------------------------------------------------------- loop [17] 32.8% loop [13] 67.2% [21] 70240(50.5%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:227:4 loop [27] 99.5% composed [32] 0.5% ---------------------------------------------------------------------------------------------- loop [17] 36.5% loop [13] 63.5% [22] 64812(46.6%) 0(0.0%) make-exacts-walkup .../master/src/points.rkt:222:0 loop [27] 96.1% eval-prog [28] 3.9% ---------------------------------------------------------------------------------------------- loop [13] 13.7% for-loop [18] 86.3% [23] 2184(1.6%) 0(0.0%) ??? ...ightlies/herbie/master/src/points.rkt:106:2 ??? [40] 86.3% compose [30] 13.7% ---------------------------------------------------------------------------------------------- run-iter! [19] 100.0% [24] 704(0.5%) 0(0.0%) localize! .../herbie/master/src/mainloop.rkt:126:0 localize-error [29] 100.0% ---------------------------------------------------------------------------------------------- run-iter! [19] 100.0% [25] 330(0.2%) 330(0.2%) gen-rewrites! ...bie/master/src/mainloop.rkt:182:0 ---------------------------------------------------------------------------------------------- make-alt-table [20] 100.0% [26] 288(0.2%) 0(0.0%) for-loop ...ie/master/src/core/alt-table.rkt:35:15 ??? [31] 100.0% ---------------------------------------------------------------------------------------------- map [42] 0.0% for-loop [15] 0.2% ??? [2] 1.1% make-exacts-walkup [22] 1.2% loop [21] 2.1% loop [27] 95.4% [27] 134618(96.7%) 0(0.0%) loop ...-7.2/collects/racket/private/map.rkt:40:19 loop [27] 95.4% composed [32] 3.0% hash-ref! [33] 1.1% ??? [35] 0.2% ??? [45] 0.0% ??? [67] 0.0% ---------------------------------------------------------------------------------------------- make-exacts-walkup [22] 100.0% [28] 2548(1.8%) 0(0.0%) eval-prog ...s/herbie/master/src/programs.rkt:83:0 hash-ref! [33] 68.6% temp85_0 [34] 17.3% loop [58] 14.1% ---------------------------------------------------------------------------------------------- localize! [24] 100.0% [29] 704(0.5%) 0(0.0%) localize-error ...aster/src/core/localize.rkt:66:0 hash-ref! [33] 100.0% ---------------------------------------------------------------------------------------------- ??? [23] 100.0% [30] 300(0.2%) 300(0.2%) compose ...collects/racket/private/list.rkt:385:12 ---------------------------------------------------------------------------------------------- for-loop [26] 100.0% [31] 288(0.2%) 288(0.2%) ??? ...7.2/collects/racket/private/for.rkt:1233:14 ---------------------------------------------------------------------------------------------- loop [21] 0.3% loop [27] 99.7% [32] 126686(91.0%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [35] 100.0% ---------------------------------------------------------------------------------------------- localize-error [29] 7.2% map [42] 21.5% loop [27] 34.2% eval-prog [28] 37.1% [33] 2452(1.8%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 bigfloat-hash [36] 37.1% ??? [2] 34.2% parse-loop30 [37] 28.7% ---------------------------------------------------------------------------------------------- eval-prog [28] 100.0% [34] 440(0.3%) 0(0.0%) temp85_0 (unknown source) compile15 [38] 100.0% ---------------------------------------------------------------------------------------------- loop [27] 4.1% composed [32] 95.9% [35] 132146(95.0%) 356(0.3%) ??? ...htlies/herbie/master/src/programs.rkt:115:2 ??? [39] 92.2% ??? [40] 7.0% ---------------------------------------------------------------------------------------------- hash-ref! [33] 100.0% [36] 1748(1.3%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 sig+exp->bigfloat [41] 63.8% bfcanonicalize [43] 36.2% ---------------------------------------------------------------------------------------------- hash-ref! [33] 100.0% [37] 704(0.5%) 0(0.0%) parse-loop30 ...s/racket/match/compiler.rkt:418:15 map [42] 100.0% ---------------------------------------------------------------------------------------------- temp85_0 [34] 100.0% [38] 440(0.3%) 0(0.0%) compile15 (unknown source) temp91_0 [44] 100.0% ---------------------------------------------------------------------------------------------- ??? [35] 100.0% [39] 121854(87.6%) 1008(0.7%) ??? ...t-7.2/collects/racket/private/kw.rkt:594:14 ??? [45] 99.2% ---------------------------------------------------------------------------------------------- ??? [23] 16.9% ??? [35] 83.1% [40] 11120(8.0%) 1412(1.0%) ??? ...tract/private/arrow-higher-order.rkt:360:33 bf [46] 70.4% sample-multi-bounded [47] 16.9% ---------------------------------------------------------------------------------------------- bigfloat-hash [36] 100.0% [41] 1116(0.8%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:387:0 new-mpfr [66] 100.0% ---------------------------------------------------------------------------------------------- parse-loop30 [37] 100.0% [42] 704(0.5%) 0(0.0%) map ...t-7.2/collects/racket/private/map.rkt:35:13 hash-ref! [33] 75.0% loop [27] 25.0% ---------------------------------------------------------------------------------------------- bigfloat-hash [36] 100.0% [43] 632(0.5%) 632(0.5%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 ---------------------------------------------------------------------------------------------- compile15 [38] 100.0% [44] 440(0.3%) 0(0.0%) temp91_0 (unknown source) temp118_0 [48] 100.0% ---------------------------------------------------------------------------------------------- loop [27] 0.6% ??? [39] 99.4% [45] 121550(87.3%) 696(0.5%) ??? ...tract/private/arrow-higher-order.rkt:364:33 bf-complex-exp [49] 73.5% bf-complex-div [50] 22.6% bf-complex-add [51] 2.1% bf-complex-neg [52] 1.2% ---------------------------------------------------------------------------------------------- ??? [40] 100.0% [46] 7824(5.6%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [66] 96.2% ??? [67] 3.8% ---------------------------------------------------------------------------------------------- ??? [40] 100.0% [47] 1884(1.4%) 900(0.6%) sample-multi-bounded ...master/src/points.rkt:15:0 random-ranges [53] 52.2% ---------------------------------------------------------------------------------------------- temp91_0 [44] 100.0% [48] 440(0.3%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [54] 100.0% ---------------------------------------------------------------------------------------------- ??? [45] 100.0% [49] 89358(64.2%) 998(0.7%) bf-complex-exp ...e/master/src/bigcomplex.rkt:37:0 ??? [59] 90.4% bf* [55] 8.1% ...higher-order.rkt:364:33 [56] 0.4% ---------------------------------------------------------------------------------------------- ??? [45] 100.0% [50] 27482(19.7%) 1038(0.7%) bf-complex-div ...e/master/src/bigcomplex.rkt:54:0 ??? [59] 46.0% bf* [55] 38.5% ...higher-order.rkt:364:33 [56] 11.7% ---------------------------------------------------------------------------------------------- ??? [45] 100.0% [51] 2522(1.8%) 0(0.0%) bf-complex-add ...e/master/src/bigcomplex.rkt:23:0 ??? [59] 100.0% ---------------------------------------------------------------------------------------------- ??? [45] 100.0% [52] 1492(1.1%) 0(0.0%) bf-complex-neg ...e/master/src/bigcomplex.rkt:20:0 ??? [59] 76.1% ...higher-order.rkt:364:33 [56] 23.9% ---------------------------------------------------------------------------------------------- sample-multi-bounded [47] 100.0% [53] 984(0.7%) 984(0.7%) random-ranges ...erbie/master/src/common.rkt:183:0 ---------------------------------------------------------------------------------------------- loop [58] 45.0% temp118_0 [48] 55.0% [54] 800(0.6%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [57] 55.0% loop [58] 45.0% ---------------------------------------------------------------------------------------------- bf-complex-exp [49] 40.5% bf-complex-div [50] 59.5% [55] 17804(12.8%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [59] 100.0% ---------------------------------------------------------------------------------------------- bf-complex-exp [49] 9.0% bf-complex-neg [52] 9.1% bf-complex-div [50] 81.9% [56] 3918(2.8%) 706(0.5%) ...higher-order.rkt:364:33 (unknown source) ??? [60] 72.9% ??? [64] 9.1% ---------------------------------------------------------------------------------------------- expand-capturing-lifts [54] 100.0% [57] 440(0.3%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [61] 100.0% ---------------------------------------------------------------------------------------------- loop [58] 33.3% expand-capturing-lifts [54] 33.3% eval-prog [28] 33.3% [58] 360(0.3%) 0(0.0%) loop (unknown source) expand-capturing-lifts [54] 33.3% loop [58] 33.3% for-loop [65] 33.3% ---------------------------------------------------------------------------------------------- bf-complex-neg [52] 1.0% bf-complex-add [51] 2.2% bf-complex-div [50] 11.0% bf* [55] 15.5% bf-complex-exp [49] 70.3% [59] 114900(82.6%) 74290(53.4%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfdiv [62] 22.3% bfneg [63] 13.1% ---------------------------------------------------------------------------------------------- ...higher-order.rkt:364:33 [56] 100.0% [60] 2856(2.1%) 1056(0.8%) ??? ...cts/racket/contract/private/list.rkt:209:10 ??? [64] 63.0% ---------------------------------------------------------------------------------------------- lambda-clause-expander [57] 25.0% for-loop [65] 75.0% [61] 440(0.3%) 0(0.0%) finish-bodys (unknown source) for-loop [65] 100.0% ---------------------------------------------------------------------------------------------- ??? [59] 100.0% [62] 25594(18.4%) 2542(1.8%) bfdiv ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [66] 70.2% ??? [67] 19.8% ---------------------------------------------------------------------------------------------- ??? [59] 100.0% [63] 15016(10.8%) 0(0.0%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [66] 65.6% ??? [67] 34.4% ---------------------------------------------------------------------------------------------- ...higher-order.rkt:364:33 [56] 16.5% ??? [60] 83.5% [64] 2156(1.5%) 2156(1.5%) ??? ...ects/racket/contract/private/guts.rkt:772:8 ---------------------------------------------------------------------------------------------- weak-intern! [11] 11.2% temp37_0 [68] 11.2% run-module-instance!125 [69] 11.2% loop [58] 11.2% finish-bodys [61] 55.0% [65] 800(0.6%) 800(0.6%) for-loop (unknown source) finish-bodys [61] 41.2% run-module-instance!125 [69] 11.2% temp37_0 [68] 11.2% namespace-module-use->module+linklet-instances144 [3] 11.2% ---------------------------------------------------------------------------------------------- sig+exp->bigfloat [41] 3.1% bf [46] 20.6% bfneg [63] 27.0% bfdiv [62] 49.3% [66] 36468(26.2%) 36468(26.2%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ---------------------------------------------------------------------------------------------- bf [46] 2.8% loop [27] 3.3% bfdiv [62] 46.6% bfneg [63] 47.3% [67] 10898(7.8%) 10898(7.8%) ??? /opt/racket-7.2/collects/ffi/unsafe.rkt:905:4 ---------------------------------------------------------------------------------------------- for-loop [65] 100.0% [68] 360(0.3%) 0(0.0%) temp37_0 (unknown source) for-loop [65] 100.0% ---------------------------------------------------------------------------------------------- for-loop [65] 100.0% [69] 360(0.3%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [65] 100.0% ----------------------------------------------------------------------------------------------