Profiling results ----------------- Total cpu time observed: 157582ms (out of 159852ms) Number of samples taken: 418 (once every 377ms) (Hiding functions with self<1.0% and local<2.0%: 2 of 99 hidden) ======================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================== run [9] 50.0% [1] 157582(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [4] 50.0% loop [15] 47.3% run-improve39 [5] 2.1% eval-errors [44] 0.4% oracle-error [6] 0.2% ------------------------------------------------------------------------ for-loop [89] 100.0% [2] 360(0.2%) 0(0.0%) expand-identifier (unknown source) resolve+shift28 [7] 100.0% ------------------------------------------------------------------------ ??? [54] 100.0% [3] 328(0.2%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:31:0 iterate-egraph!7 [8] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [4] 157582(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [9] 100.0% ------------------------------------------------------------------------ ??? [1] 100.0% [5] 6610(4.2%) 0(0.0%) run-improve39 ...ie/develop/src/mainloop.rkt:340:0 setup-prog!32 [10] 64.6% for-loop [11] 35.4% ------------------------------------------------------------------------ ??? [1] 100.0% [6] 682(0.4%) 0(0.0%) oracle-error ...erbie/develop/src/points.rkt:311:0 for-loop [12] 100.0% ------------------------------------------------------------------------ expand-identifier [2] 100.0% [7] 360(0.2%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [13] 100.0% ------------------------------------------------------------------------ ??? [3] 100.0% [8] 328(0.2%) 0(0.0%) iterate-egraph!7 ...lop/src/core/simplify.rkt:61:0 one-iter [14] 100.0% ------------------------------------------------------------------------ profile-thunk16 [4] 100.0% [9] 157582(100.0%) 0(0.0%) run ...racket/share/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ------------------------------------------------------------------------ run-improve39 [5] 100.0% [10] 4272(2.7%) 0(0.0%) setup-prog!32 ...bie/develop/src/mainloop.rkt:63:0 loop [15] 100.0% ------------------------------------------------------------------------ run-improve39 [5] 100.0% [11] 2338(1.5%) 0(0.0%) for-loop ...herbie/develop/src/mainloop.rkt:361:10 run-iter! [16] 100.0% ------------------------------------------------------------------------ oracle-error [6] 100.0% [12] 682(0.4%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:312:2 map [17] 50.7% loop [18] 49.3% ------------------------------------------------------------------------ resolve+shift28 [7] 100.0% [13] 360(0.2%) 0(0.0%) fallback-loop (unknown source) for-loop [89] 100.0% ------------------------------------------------------------------------ iterate-egraph!7 [8] 100.0% [14] 328(0.2%) 0(0.0%) one-iter ...bie/develop/src/core/simplify.rkt:72:0 for-loop [19] 100.0% ------------------------------------------------------------------------ setup-prog!32 [10] 2.8% ??? [1] 97.2% [15] 153318(97.3%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:242:2 make-exacts-intervals [20] 99.0% for-loop [22] 1.0% ------------------------------------------------------------------------ for-loop [11] 100.0% [16] 2338(1.5%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:321:0 finalize-iter! [21] 72.2% simplify! [25] 14.0% gen-series! [26] 13.8% ------------------------------------------------------------------------ for-loop [12] 100.0% [17] 346(0.2%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:35:13 ??? [23] 100.0% ------------------------------------------------------------------------ for-loop [12] 100.0% [18] 336(0.2%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:40:19 ??? [49] 100.0% ------------------------------------------------------------------------ for-loop [19] 50.0% one-iter [14] 50.0% [19] 328(0.2%) 0(0.0%) for-loop ...ie/develop/src/core/simplify.rkt:83:12 for-loop [19] 50.0% match-e [24] 50.0% ------------------------------------------------------------------------ loop [15] 100.0% [20] 151714(96.3%) 0(0.0%) make-exacts-intervals ...elop/src/points.rkt:183:0 for-loop [27] 99.3% loop [33] 0.7% ------------------------------------------------------------------------ run-iter! [16] 100.0% [21] 1688(1.1%) 0(0.0%) finalize-iter! ...e/develop/src/mainloop.rkt:272:0 ??? [28] 100.0% ------------------------------------------------------------------------ loop [15] 100.0% [22] 1604(1.0%) 348(0.2%) for-loop ...s/herbie/develop/src/points.rkt:257:19 for-loop [29] 78.3% ------------------------------------------------------------------------ map [17] 100.0% [23] 346(0.2%) 0(0.0%) ??? ...htlies/herbie/develop/src/points.rkt:313:26 ??? [49] 100.0% ------------------------------------------------------------------------ for-loop [35] 50.0% for-loop [19] 50.0% [24] 328(0.2%) 0(0.0%) match-e ...herbie/develop/src/core/ematch.rkt:39:0 for-loop [30] 100.0% ------------------------------------------------------------------------ run-iter! [16] 100.0% [25] 328(0.2%) 0(0.0%) simplify! ...herbie/develop/src/mainloop.rkt:221:0 for-loop [31] 100.0% ------------------------------------------------------------------------ run-iter! [16] 100.0% [26] 322(0.2%) 0(0.0%) gen-series! ...rbie/develop/src/mainloop.rkt:155:0 for-loop [32] 100.0% ------------------------------------------------------------------------ make-exacts-intervals [20] 100.0% [27] 150696(95.6%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:186:2 loop [33] 99.5% ??? [54] 0.5% ------------------------------------------------------------------------ finalize-iter! [21] 100.0% [28] 1688(1.1%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [34] 100.0% ------------------------------------------------------------------------ for-loop [22] 100.0% [29] 1256(0.8%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:234:4 ??? [54] 100.0% ------------------------------------------------------------------------ match-e [24] 100.0% [30] 328(0.2%) 328(0.2%) for-loop ...rbie/develop/src/core/ematch.rkt:52:11 for-loop [35] 50.0% ------------------------------------------------------------------------ simplify! [25] 100.0% [31] 328(0.2%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:228:6 for-loop [36] 100.0% ------------------------------------------------------------------------ gen-series! [26] 100.0% [32] 322(0.2%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:163:7 taylor-alt [37] 100.0% ------------------------------------------------------------------------ make-exacts-intervals [20] 0.7% for-loop [27] 99.3% [33] 150996(95.8%) 1602(1.0%) loop ...htlies/herbie/develop/src/points.rkt:168:2 ??? [49] 96.8% ??? [54] 2.1% ------------------------------------------------------------------------ ??? [28] 100.0% [34] 1688(1.1%) 0(0.0%) for-loop ...ie/develop/src/core/alt-table.rkt:52:2 atab-add-altn [38] 81.5% loop [40] 18.5% ------------------------------------------------------------------------ for-loop [30] 100.0% [35] 328(0.2%) 0(0.0%) for-loop ...rbie/develop/src/core/ematch.rkt:58:37 match-e [24] 100.0% ------------------------------------------------------------------------ for-loop [31] 100.0% [36] 328(0.2%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:252:8 ??? [54] 100.0% ------------------------------------------------------------------------ for-loop [32] 100.0% [37] 322(0.2%) 0(0.0%) taylor-alt ...erbie/develop/src/mainloop.rkt:141:0 for-loop [39] 100.0% ------------------------------------------------------------------------ for-loop [34] 100.0% [38] 1376(0.9%) 0(0.0%) atab-add-altn ...elop/src/core/alt-table.rkt:211:0 override-at-pnts [41] 50.6% best-and-tied-at-points [42] 49.4% ------------------------------------------------------------------------ taylor-alt [37] 100.0% [39] 322(0.2%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:147:6 ??? [54] 100.0% ------------------------------------------------------------------------ for-loop [34] 100.0% [40] 312(0.2%) 0(0.0%) loop ...erbie/develop/src/core/alt-table.rkt:185:2 loop [43] 100.0% ------------------------------------------------------------------------ atab-add-altn [38] 100.0% [41] 696(0.4%) 0(0.0%) override-at-pnts ...p/src/core/alt-table.rkt:146:0 eval-errors [44] 52.0% for-loop [46] 48.0% ------------------------------------------------------------------------ atab-add-altn [38] 100.0% [42] 680(0.4%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:123:0 eval-prog [45] 52.9% eval-errors [44] 47.1% ------------------------------------------------------------------------ loop [40] 100.0% [43] 312(0.2%) 312(0.2%) loop ...cket/collects/racket/private/hash.rkt:20:4 ------------------------------------------------------------------------ best-and-tied-at-points [42] 16.6% override-at-pnts [41] 18.8% ??? [1] 64.6% [44] 1926(1.2%) 0(0.0%) eval-errors ...herbie/develop/src/points.rkt:292:0 for-loop [47] 100.0% ------------------------------------------------------------------------ best-and-tied-at-points [42] 100.0% [45] 360(0.2%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:108:0 temp68_2 [48] 100.0% ------------------------------------------------------------------------ override-at-pnts [41] 100.0% [46] 334(0.2%) 334(0.2%) for-loop .../develop/src/core/alt-table.rkt:147:43 ------------------------------------------------------------------------ eval-errors [44] 100.0% [47] 1926(1.2%) 302(0.2%) for-loop ...es/herbie/develop/src/points.rkt:294:2 ??? [49] 84.3% ------------------------------------------------------------------------ eval-prog [45] 100.0% [48] 360(0.2%) 0(0.0%) temp68_2 (unknown source) compile16 [50] 100.0% ------------------------------------------------------------------------ loop [18] 0.2% ??? [23] 0.2% for-loop [47] 1.1% loop [33] 98.4% [49] 148516(94.2%) 314(0.2%) ??? ...tlies/herbie/develop/src/programs.rkt:124:2 ??? [51] 95.3% ??? [53] 4.5% ------------------------------------------------------------------------ temp68_2 [48] 100.0% [50] 360(0.2%) 0(0.0%) compile16 (unknown source) temp74_0 [52] 100.0% ------------------------------------------------------------------------ ??? [49] 100.0% [51] 141592(89.9%) 2014(1.3%) ??? ...acket/collects/racket/private/kw.rkt:592:14 ??? [53] 75.9% ??? [54] 21.8% ??? [55] 0.9% ------------------------------------------------------------------------ compile16 [50] 100.0% [52] 360(0.2%) 0(0.0%) temp74_0 (unknown source) expand-single [56] 100.0% ------------------------------------------------------------------------ fold-binary-pred [80] 1.9% ??? [49] 5.7% ??? [51] 92.3% [53] 115088(73.0%) 3982(2.5%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-fmod [57] 50.5% ival-mult [66] 25.3% ival-asin [59] 10.3% mk-ival [60] 5.7% ival-atan [61] 5.6% ------------------------------------------------------------------------ for-loop [39] 0.4% for-loop [36] 0.4% for-loop [27] 2.0% for-loop [29] 3.4% loop [33] 8.7% ??? [51] 84.2% [54] 36658(23.3%) 1702(1.1%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ival-pow [58] 83.1% ->flonum [62] 7.9% sample-multi-bounded [63] 2.6% ??? [3] 0.4% approximate9 [65] 0.4% ------------------------------------------------------------------------ ??? [51] 100.0% [55] 1298(0.8%) 962(0.6%) ??? ...herbie/develop/src/syntax/syntax.rkt:198:17 return/no-unsupplied [73] 25.9% ------------------------------------------------------------------------ temp74_0 [52] 100.0% [56] 360(0.2%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [64] 100.0% ------------------------------------------------------------------------ ??? [53] 100.0% [57] 59002(37.4%) 2000(1.3%) ival-fmod ...bie/develop/src/biginterval.rkt:299:0 ival-div [67] 59.8% ival-mult [66] 15.9% ??? [90] 10.0% ival-fabs [69] 7.6% fold-binary-pred [80] 1.7% ...higher-order.rkt:357:33 [81] 1.1% ------------------------------------------------------------------------ ??? [54] 100.0% [58] 30470(19.3%) 2572(1.6%) ival-pow ...rbie/develop/src/biginterval.rkt:146:0 ??? [90] 77.0% foldl [87] 5.7% fold-binary-pred [80] 4.7% bfodd? [71] 3.2% ...higher-order.rkt:357:33 [81] 1.1% ------------------------------------------------------------------------ ??? [53] 100.0% [59] 12168(7.7%) 2972(1.9%) ival-asin ...bie/develop/src/biginterval.rkt:271:0 ??? [90] 62.5% ...higher-order.rkt:357:33 [81] 8.0% fold-binary-pred [80] 5.1% ------------------------------------------------------------------------ ??? [53] 100.0% [60] 6610(4.2%) 614(0.4%) mk-ival ...herbie/develop/src/biginterval.rkt:52:0 bf [68] 90.7% ------------------------------------------------------------------------ ??? [53] 100.0% [61] 6496(4.1%) 628(0.4%) ival-atan ...bie/develop/src/biginterval.rkt:239:0 ??? [90] 90.3% ------------------------------------------------------------------------ ??? [54] 100.0% [62] 2880(1.8%) 1004(0.6%) ->flonum ...s/herbie/develop/src/programs.rkt:36:0 ??? [70] 42.7% return/no-unsupplied [73] 12.0% list-member? [76] 10.4% ------------------------------------------------------------------------ ??? [54] 100.0% [63] 956(0.6%) 0(0.0%) sample-multi-bounded ...evelop/src/points.rkt:44:0 loop [72] 100.0% ------------------------------------------------------------------------ expand-single [56] 100.0% [64] 360(0.2%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [74] 100.0% ------------------------------------------------------------------------ ??? [54] 100.0% [65] 322(0.2%) 0(0.0%) approximate9 ...e/develop/src/core/taylor.rkt:12:0 for-loop [75] 100.0% ------------------------------------------------------------------------ ival-fmod [57] 24.3% ??? [53] 75.7% [66] 38542(24.5%) 1376(0.9%) ival-mult ...rbie/develop/src/biginterval.rkt:94:0 bf* [77] 62.5% foldl [87] 12.5% bfmin* [78] 12.1% bfmax* [79] 6.1% ...higher-order.rkt:361:33 [88] 3.3% ------------------------------------------------------------------------ ival-fmod [57] 100.0% [67] 35300(22.4%) 2276(1.4%) ival-div ...rbie/develop/src/biginterval.rkt:105:0 ??? [90] 59.8% foldl [87] 13.2% bfmax* [79] 8.5% bfmin* [78] 8.3% fold-binary-pred [80] 2.0% ...higher-order.rkt:361:33 [88] 1.7% ------------------------------------------------------------------------ mk-ival [60] 100.0% [68] 5996(3.8%) 612(0.4%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 ??? [97] 46.6% new-mpfr [96] 43.2% ------------------------------------------------------------------------ ival-fmod [57] 100.0% [69] 4506(2.9%) 308(0.2%) ival-fabs ...bie/develop/src/biginterval.rkt:281:0 ??? [90] 64.4% foldl [87] 21.7% ...higher-order.rkt:357:33 [81] 7.1% ------------------------------------------------------------------------ ->flonum [62] 100.0% [70] 1230(0.8%) 1230(0.8%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ------------------------------------------------------------------------ ival-pow [58] 100.0% [71] 962(0.6%) 320(0.2%) bfodd? ...lib/math/private/bigfloat/mpfr.rkt:803:0 size+limbs->integer [84] 34.5% mpz->integer [86] 32.2% ------------------------------------------------------------------------ sample-multi-bounded [63] 100.0% [72] 956(0.6%) 0(0.0%) loop ...ghtlies/herbie/develop/src/points.rkt:66:6 random-exp [82] 100.0% ------------------------------------------------------------------------ ??? [55] 49.3% ->flonum [62] 50.7% [73] 682(0.4%) 682(0.4%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 ------------------------------------------------------------------------ expand-capturing-lifts [64] 100.0% [74] 360(0.2%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [83] 100.0% ------------------------------------------------------------------------ approximate9 [65] 100.0% [75] 322(0.2%) 0(0.0%) for-loop ...rbie/develop/src/core/taylor.rkt:30:18 taylor [85] 100.0% ------------------------------------------------------------------------ ->flonum [62] 100.0% [76] 300(0.2%) 300(0.2%) list-member? ...llects/racket/private/set.rkt:24:0 ------------------------------------------------------------------------ ival-mult [66] 100.0% [77] 24096(15.3%) 1352(0.9%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [90] 94.4% ------------------------------------------------------------------------ ival-div [67] 38.7% ival-mult [66] 61.3% [78] 7594(4.8%) 1012(0.6%) bfmin* .../herbie/develop/src/biginterval.rkt:88:0 foldl [87] 81.5% ...higher-order.rkt:361:33 [88] 5.1% ------------------------------------------------------------------------ ival-mult [66] 43.9% ival-div [67] 56.1% [79] 5366(3.4%) 304(0.2%) bfmax* .../herbie/develop/src/biginterval.rkt:91:0 foldl [87] 81.3% ...higher-order.rkt:361:33 [88] 13.0% ------------------------------------------------------------------------ ival-asin [59] 16.4% ival-div [67] 19.2% ival-fmod [57] 26.5% ival-pow [58] 37.9% [80] 3746(2.4%) 370(0.2%) fold-binary-pred ...gfloat/bigfloat-mpfr.rkt:117:0 ??? [53] 90.1% ------------------------------------------------------------------------ ival-fabs [69] 14.1% ival-pow [58] 14.8% ival-fmod [57] 27.8% ival-asin [59] 43.3% [81] 2248(1.4%) 922(0.6%) ...higher-order.rkt:357:33 (unknown source) ??? [95] 59.0% ------------------------------------------------------------------------ loop [72] 100.0% [82] 956(0.6%) 956(0.6%) random-exp .../herbie/develop/src/common.rkt:230:0 ------------------------------------------------------------------------ lambda-clause-expander [74] 33.3% for-loop [89] 66.7% [83] 360(0.2%) 0(0.0%) finish-bodys (unknown source) for-loop [89] 100.0% ------------------------------------------------------------------------ bfodd? [71] 100.0% [84] 332(0.2%) 332(0.2%) size+limbs->integer ...vate/bigfloat/gmp.rkt:103:0 ------------------------------------------------------------------------ for-loop [75] 25.0% taylor [85] 75.0% [85] 322(0.2%) 322(0.2%) taylor ...herbie/develop/src/core/taylor.rkt:169:0 taylor [85] 75.0% ------------------------------------------------------------------------ bfodd? [71] 100.0% [86] 310(0.2%) 310(0.2%) mpz->integer ...ath/private/bigfloat/gmp.rkt:115:0 ------------------------------------------------------------------------ ival-fabs [69] 4.3% ival-pow [58] 7.6% bfmax* [79] 19.2% ival-div [67] 20.5% ival-mult [66] 21.1% bfmin* [78] 27.3% [87] 22720(14.4%) 0(0.0%) foldl ...et/collects/racket/private/list.rkt:229:4 ??? [90] 100.0% ------------------------------------------------------------------------ bfmin* [78] 13.2% ival-div [67] 20.5% bfmax* [79] 23.7% ival-mult [66] 42.6% [88] 2956(1.9%) 916(0.6%) ...higher-order.rkt:361:33 (unknown source) ??? [91] 69.0% ------------------------------------------------------------------------ fallback-loop [13] 16.7% for-loop [89] 33.3% finish-bodys [83] 50.0% [89] 360(0.2%) 360(0.2%) for-loop (unknown source) finish-bodys [83] 33.3% for-loop [89] 33.3% expand-identifier [2] 16.7% ------------------------------------------------------------------------ ival-fabs [69] 2.6% ival-atan [61] 5.2% ival-fmod [57] 5.2% ival-asin [59] 6.8% ival-div [67] 18.8% foldl [87] 20.2% bf* [77] 20.3% ival-pow [58] 20.9% [90] 112280(71.3%) 31756(20.2%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [92] 60.2% bfneg [93] 7.5% bfceiling [94] 4.1% ------------------------------------------------------------------------ ...higher-order.rkt:361:33 [88]100.0% [91] 2040(1.3%) 688(0.4%) ??? ...cts/racket/contract/private/list.rkt:209:10 ??? [95] 66.3% ------------------------------------------------------------------------ ??? [90] 100.0% [92] 67548(42.9%) 1564(1.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [96] 67.6% ??? [97] 30.1% ------------------------------------------------------------------------ ??? [90] 100.0% [93] 8412(5.3%) 702(0.4%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [96] 80.4% ??? [97] 11.3% ------------------------------------------------------------------------ ??? [90] 100.0% [94] 4564(2.9%) 0(0.0%) bfceiling .../math/private/bigfloat/mpfr.rkt:716:4 new-mpfr [96] 93.2% ??? [97] 6.8% ------------------------------------------------------------------------ ...higher-order.rkt:357:33 [81] 49.5% ??? [91] 50.5% [95] 2678(1.7%) 2678(1.7%) ??? ...ects/racket/contract/private/guts.rkt:746:8 ------------------------------------------------------------------------ bf [68] 4.4% bfceiling [94] 7.2% bfneg [93] 11.4% bfmul [92] 77.1% [96] 59280(37.6%) 59280(37.6%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------------ bfceiling [94] 1.3% bfneg [93] 3.9% bf [68] 11.5% bfmul [92] 83.4% [97] 24362(15.5%) 24362(15.5%) ??? /home/p92/racket/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------------