Profiling results ----------------- Total cpu time observed: 172438ms (out of 174548ms) Number of samples taken: 434 (once every 397ms) (Hiding functions with self<1.0% and local<2.0%: 2 of 74 hidden) =============================================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee =============================================================================================== ??? [6] 100.0% [1] 172438(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [4] 100.0% ----------------------------------------------------------------------------------------------- hash-ref! [29] 100.0% [2] 1666(1.0%) 0(0.0%) ??? ...htlies/herbie/master/src/programs.rkt:151:5 loop [24] 100.0% ----------------------------------------------------------------------------------------------- ??? [6] 100.0% [3] 1052(0.6%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:205:0 for-loop [5] 100.0% ----------------------------------------------------------------------------------------------- profile-thunk16 [1] 100.0% [4] 172438(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] 1052(0.6%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:207:2 ??? [6] 100.0% ----------------------------------------------------------------------------------------------- for-loop [5] 0.2% run [4] 49.9% [6] 172438(100.0%) 356(0.2%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 49.9% loop [10] 47.1% run-improve47 [7] 2.2% errors [3] 0.2% oracle-error [8] 0.2% eval-errors [9] 0.2% ??? [32] 0.1% ----------------------------------------------------------------------------------------------- ??? [6] 100.0% [7] 7568(4.4%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:342:0 loop [10] 79.4% for-loop [11] 16.3% simplify! [14] 4.4% ----------------------------------------------------------------------------------------------- ??? [6] 100.0% [8] 698(0.4%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:188:0 for-loop [12] 100.0% ----------------------------------------------------------------------------------------------- ??? [6] 100.0% [9] 612(0.4%) 0(0.0%) eval-errors .../herbie/master/src/points.rkt:179:0 for-loop [13] 100.0% ----------------------------------------------------------------------------------------------- run-improve47 [7] 3.6% ??? [6] 96.4% [10] 168514(97.7%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:284:2 loop [15] 34.6% loop [20] 33.5% make-exacts-walkup [21] 29.8% for-loop [16] 2.1% ----------------------------------------------------------------------------------------------- run-improve47 [7] 100.0% [11] 1232(0.7%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:359:4 run-iter! [17] 100.0% ----------------------------------------------------------------------------------------------- oracle-error [8] 100.0% [12] 698(0.4%) 360(0.2%) for-loop ...ies/herbie/master/src/points.rkt:189:2 loop [24] 48.4% ----------------------------------------------------------------------------------------------- eval-errors [9] 100.0% [13] 612(0.4%) 300(0.2%) for-loop ...ies/herbie/master/src/points.rkt:181:2 precision->real [19] 51.0% ----------------------------------------------------------------------------------------------- run-improve47 [7] 100.0% [14] 330(0.2%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:220:0 for-loop [18] 100.0% ----------------------------------------------------------------------------------------------- loop [10] 100.0% [15] 58280(33.8%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:243:2 loop [20] 53.3% make-exacts-walkup [21] 46.7% ----------------------------------------------------------------------------------------------- loop [10] 100.0% [16] 3562(2.1%) 334(0.2%) for-loop ...es/herbie/master/src/points.rkt:304:19 ??? [22] 90.6% ----------------------------------------------------------------------------------------------- for-loop [11] 100.0% [17] 1232(0.7%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:323:0 localize! [23] 100.0% ----------------------------------------------------------------------------------------------- simplify! [14] 100.0% [18] 330(0.2%) 330(0.2%) for-loop ...s/herbie/master/src/mainloop.rkt:258:6 ----------------------------------------------------------------------------------------------- for-loop [13] 100.0% [19] 312(0.2%) 0(0.0%) precision->real ...e/master/src/programs.rkt:92:33 infer-representation [46] 100.0% ----------------------------------------------------------------------------------------------- loop [15] 35.5% loop [10] 64.5% [20] 87512(50.7%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:226:4 loop [24] 100.0% ----------------------------------------------------------------------------------------------- loop [15] 35.1% loop [10] 64.9% [21] 77440(44.9%) 336(0.2%) make-exacts-walkup .../master/src/points.rkt:222:0 loop [24] 95.5% eval-prog [25] 4.1% ----------------------------------------------------------------------------------------------- for-loop [16] 100.0% [22] 3228(1.9%) 0(0.0%) ??? ...ightlies/herbie/master/src/points.rkt:106:2 ??? [37] 78.8% compose [27] 10.7% ??? [44] 10.5% ----------------------------------------------------------------------------------------------- run-iter! [17] 100.0% [23] 1232(0.7%) 0(0.0%) localize! .../herbie/master/src/mainloop.rkt:123:0 localize-error [26] 100.0% ----------------------------------------------------------------------------------------------- map [40] 0.0% for-loop [12] 0.2% make-exacts-walkup [21] 0.5% ??? [2] 1.0% loop [20] 1.2% loop [24] 97.0% [24] 164272(95.3%) 0(0.0%) loop ...-7.2/collects/racket/private/map.rkt:40:19 loop [24] 97.0% composed [28] 1.6% hash-ref! [29] 1.0% ??? [32] 0.3% ??? [44] 0.0% ----------------------------------------------------------------------------------------------- make-exacts-walkup [21] 100.0% [25] 3142(1.8%) 0(0.0%) eval-prog ...s/herbie/master/src/programs.rkt:83:0 hash-ref! [29] 64.7% inductor [30] 14.3% loop [58] 10.6% temp85_0 [31] 10.5% ----------------------------------------------------------------------------------------------- localize! [23] 100.0% [26] 1232(0.7%) 438(0.3%) localize-error ...aster/src/core/localize.rkt:65:0 hash-ref! [29] 64.4% ----------------------------------------------------------------------------------------------- ??? [22] 100.0% [27] 346(0.2%) 346(0.2%) compose ...collects/racket/private/list.rkt:385:12 ----------------------------------------------------------------------------------------------- loop [24] 100.0% [28] 155424(90.1%) 344(0.2%) composed ...ollects/racket/private/list.rkt:321:16 ??? [32] 99.8% ----------------------------------------------------------------------------------------------- localize-error [26] 7.0% map [40] 21.1% eval-prog [25] 34.9% loop [24] 37.0% [29] 2826(1.6%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 37.0% bigfloat-hash [33] 34.9% parse-loop30 [34] 28.1% ----------------------------------------------------------------------------------------------- eval-prog [25] 33.3% inductor [30] 66.7% [30] 448(0.3%) 0(0.0%) inductor ...es/herbie/master/src/programs.rkt:97:4 inductor [30] 66.7% ??? [37] 33.3% ----------------------------------------------------------------------------------------------- eval-prog [25] 100.0% [31] 330(0.2%) 0(0.0%) temp85_0 (unknown source) compile15 [35] 100.0% ----------------------------------------------------------------------------------------------- ??? [6] 0.4% loop [24] 3.9% composed [28] 95.6% [32] 162164(94.0%) 3574(2.1%) ??? ...htlies/herbie/master/src/programs.rkt:108:2 ??? [36] 90.4% ??? [37] 5.4% real->precision [38] 1.6% real->precision [42] 0.4% ----------------------------------------------------------------------------------------------- hash-ref! [29] 100.0% [33] 2032(1.2%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bfcanonicalize [39] 64.7% sig+exp->bigfloat [41] 35.3% ----------------------------------------------------------------------------------------------- hash-ref! [29] 100.0% [34] 794(0.5%) 0(0.0%) parse-loop30 ...s/racket/match/compiler.rkt:418:15 map [40] 100.0% ----------------------------------------------------------------------------------------------- temp85_0 [31] 100.0% [35] 330(0.2%) 0(0.0%) compile15 (unknown source) temp91_0 [43] 100.0% ----------------------------------------------------------------------------------------------- ??? [32] 100.0% [36] 146620(85.0%) 1328(0.8%) ??? ...t-7.2/collects/racket/private/kw.rkt:594:14 ??? [44] 99.1% ----------------------------------------------------------------------------------------------- inductor [30] 3.8% ??? [22] 21.7% ??? [32] 74.4% [37] 11708(6.8%) 2998(1.7%) ??? ...tract/private/arrow-higher-order.rkt:360:33 bf [45] 62.2% sample-multi-bounded [47] 9.0% ??? [61] 3.1% ----------------------------------------------------------------------------------------------- ??? [32] 100.0% [38] 2558(1.5%) 694(0.4%) real->precision ...e/master/src/programs.rkt:86:33 infer-representation [46] 72.9% ----------------------------------------------------------------------------------------------- bigfloat-hash [33] 100.0% [39] 1314(0.8%) 1314(0.8%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 ----------------------------------------------------------------------------------------------- parse-loop30 [34] 100.0% [40] 794(0.5%) 0(0.0%) map ...t-7.2/collects/racket/private/map.rkt:35:13 hash-ref! [29] 75.0% loop [24] 25.0% ----------------------------------------------------------------------------------------------- bigfloat-hash [33] 100.0% [41] 718(0.4%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:387:0 new-mpfr [66] 100.0% ----------------------------------------------------------------------------------------------- ??? [32] 100.0% [42] 696(0.4%) 0(0.0%) real->precision ...e/master/src/programs.rkt:87:33 infer-representation [46] 100.0% ----------------------------------------------------------------------------------------------- compile15 [35] 100.0% [43] 330(0.2%) 0(0.0%) temp91_0 (unknown source) temp118_0 [48] 100.0% ----------------------------------------------------------------------------------------------- ??? [22] 0.2% loop [24] 0.5% ??? [36] 99.2% [44] 146424(84.9%) 2154(1.2%) ??? ...tract/private/arrow-higher-order.rkt:364:33 bf-complex-exp [49] 66.5% bf-complex-div [50] 27.1% bf-complex-neg [51] 2.8% ----------------------------------------------------------------------------------------------- ??? [37] 100.0% [45] 7288(4.2%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [66] 74.1% ??? [67] 25.9% ----------------------------------------------------------------------------------------------- precision->real [19] 10.9% real->precision [42] 24.2% real->precision [38] 64.9% [46] 2872(1.7%) 2198(1.3%) infer-representation .../master/src/float.rkt:15:0 return/no-unsupplied [52] 23.5% ----------------------------------------------------------------------------------------------- ??? [37] 100.0% [47] 1058(0.6%) 356(0.2%) sample-multi-bounded ...master/src/points.rkt:15:0 return/no-unsupplied [52] 34.6% random-ranges [54] 31.8% ----------------------------------------------------------------------------------------------- temp91_0 [43] 100.0% [48] 330(0.2%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [53] 100.0% ----------------------------------------------------------------------------------------------- ??? [44] 100.0% [49] 97358(56.5%) 678(0.4%) bf-complex-exp ...e/master/src/bigcomplex.rkt:37:0 ??? [60] 91.2% bf* [55] 8.1% ----------------------------------------------------------------------------------------------- ??? [44] 100.0% [50] 39724(23.0%) 2916(1.7%) bf-complex-div ...e/master/src/bigcomplex.rkt:54:0 ??? [60] 58.3% bf* [55] 32.4% ...higher-order.rkt:364:33 [56] 1.9% ----------------------------------------------------------------------------------------------- ??? [44] 100.0% [51] 4048(2.3%) 0(0.0%) bf-complex-neg ...e/master/src/bigcomplex.rkt:20:0 ??? [60] 100.0% ----------------------------------------------------------------------------------------------- sample-multi-bounded [47] 35.2% infer-representation [46] 64.8% [52] 1040(0.6%) 686(0.4%) return/no-unsupplied ...ct/private/arr-i.rkt:542:0 filter [57] 34.0% ----------------------------------------------------------------------------------------------- temp118_0 [48] 49.8% loop [58] 50.2% [53] 662(0.4%) 0(0.0%) expand-capturing-lifts (unknown source) loop [58] 50.2% lambda-clause-expander [59] 49.8% ----------------------------------------------------------------------------------------------- sample-multi-bounded [47] 100.0% [54] 336(0.2%) 336(0.2%) random-ranges ...erbie/master/src/common.rkt:183:0 ----------------------------------------------------------------------------------------------- bf-complex-exp [49] 38.1% bf-complex-div [50] 61.9% [55] 20794(12.1%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [60] 100.0% ----------------------------------------------------------------------------------------------- bf-complex-div [50] 100.0% [56] 770(0.4%) 0(0.0%) ...higher-order.rkt:364:33 (unknown source) ??? [61] 100.0% ----------------------------------------------------------------------------------------------- return/no-unsupplied [52] 100.0% [57] 354(0.2%) 354(0.2%) filter ...2/collects/racket/private/list.rkt:256:2 ----------------------------------------------------------------------------------------------- loop [58] 33.3% expand-capturing-lifts [53] 33.3% eval-prog [25] 33.3% [58] 332(0.2%) 0(0.0%) loop (unknown source) expand-capturing-lifts [53] 33.3% loop [58] 33.3% for-loop [65] 33.3% ----------------------------------------------------------------------------------------------- expand-capturing-lifts [53] 100.0% [59] 330(0.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [62] 100.0% ----------------------------------------------------------------------------------------------- bf-complex-neg [51] 2.9% bf* [55] 14.9% bf-complex-div [50] 16.6% bf-complex-exp [49] 63.8% [60] 139176(80.7%) 86168(50.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [63] 25.0% bfsin [64] 13.1% ----------------------------------------------------------------------------------------------- ??? [37] 32.1% ...higher-order.rkt:364:33 [56] 67.9% [61] 1134(0.7%) 1134(0.7%) ??? ...cts/racket/contract/private/list.rkt:209:10 ----------------------------------------------------------------------------------------------- lambda-clause-expander [59] 9.1% for-loop [65] 90.9% [62] 330(0.2%) 0(0.0%) finish-bodys (unknown source) for-loop [65] 100.0% ----------------------------------------------------------------------------------------------- ??? [60] 100.0% [63] 34798(20.2%) 1380(0.8%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [66] 74.8% ??? [67] 21.2% ----------------------------------------------------------------------------------------------- ??? [60] 100.0% [64] 18210(10.6%) 0(0.0%) bfsin ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [66] 76.5% ??? [67] 23.5% ----------------------------------------------------------------------------------------------- temp37_0 [69] 16.7% run-module-instance!125 [70] 16.7% loop [58] 16.7% finish-bodys [62] 49.8% [65] 662(0.4%) 0(0.0%) for-loop (unknown source) finish-bodys [62] 45.3% run-module-instance!125 [70] 16.7% temp37_0 [69] 16.7% namespace-module-use->module+linklet-instances144 [68] 16.7% expand-body7 [71] 4.5% ----------------------------------------------------------------------------------------------- sig+exp->bigfloat [41] 1.6% bf [45] 11.7% bfsin [64] 30.2% bfmul [63] 56.5% [66] 46074(26.7%) 46074(26.7%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ----------------------------------------------------------------------------------------------- bf [45] 13.9% bfsin [64] 31.6% bfmul [63] 54.5% [67] 13560(7.9%) 13560(7.9%) ??? /opt/racket-7.2/collects/ffi/unsafe.rkt:905:4 ----------------------------------------------------------------------------------------------- for-loop [65] 100.0% [68] 332(0.2%) 0(0.0%) namespace-module-use->module+linklet-instances144 ... module-path-index-shift [72] 100.0% ----------------------------------------------------------------------------------------------- for-loop [65] 100.0% [69] 332(0.2%) 0(0.0%) temp37_0 (unknown source) for-loop [65] 100.0% ----------------------------------------------------------------------------------------------- for-loop [65] 100.0% [70] 332(0.2%) 0(0.0%) run-module-instance!125 (unknown source) for-loop [65] 100.0% ----------------------------------------------------------------------------------------------- for-loop [65] 100.0% [71] 330(0.2%) 330(0.2%) expand-body7 (unknown source) ----------------------------------------------------------------------------------------------- namespace-module-use->module+linklet-instances144 [68]100.0% [72] 332(0.2%) 332(0.2%) module-path-index-shift (unknown source) -----------------------------------------------------------------------------------------------