Profiling results ----------------- Total cpu time observed: 16232ms (out of 16732ms) Number of samples taken: 47 (once every 345ms) (Hiding functions with self<1.0% and local<2.0%: 1 of 76 hidden) =================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee =================================================================== ??? [5] 100.0% [1] 16232(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ------------------------------------------------------------------- ??? [5] 100.0% [2] 844(5.2%) 0(0.0%) oracle-error ...erbie/develop/src/points.rkt:218:0 for-loop [4] 100.0% ------------------------------------------------------------------- profile-thunk16 [1] 100.0% [3] 16232(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [5] 100.0% ------------------------------------------------------------------- oracle-error [2] 100.0% [4] 844(5.2%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:219:2 loop [34] 100.0% ------------------------------------------------------------------- run [3] 50.0% [5] 16232(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% loop [12] 35.6% run-improve43 [6] 5.9% oracle-error [2] 2.6% errors [37] 2.2% eval-errors [7] 1.9% loop [34] 0.9% ------------------------------------------------------------------- ??? [5] 100.0% [6] 1906(11.7%) 0(0.0%) run-improve43 ...ie/develop/src/mainloop.rkt:362:0 for-loop [8] 66.2% setup-prog!34 [10] 17.2% simplify! [11] 16.6% ------------------------------------------------------------------- ??? [5] 100.0% [7] 604(3.7%) 0(0.0%) eval-errors ...herbie/develop/src/points.rkt:209:0 for-loop [9] 100.0% ------------------------------------------------------------------- run-improve43 [6] 100.0% [8] 1262(7.8%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:377:4 run-iter! [13] 100.0% ------------------------------------------------------------------- eval-errors [7] 100.0% [9] 604(3.7%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:211:2 ??? [43] 100.0% ------------------------------------------------------------------- run-improve43 [6] 100.0% [10] 328(2.0%) 0(0.0%) setup-prog!34 ...bie/develop/src/mainloop.rkt:76:0 loop [12] 100.0% ------------------------------------------------------------------- run-improve43 [6] 100.0% [11] 316(1.9%) 0(0.0%) simplify! ...herbie/develop/src/mainloop.rkt:239:0 ??? [14] 100.0% ------------------------------------------------------------------- setup-prog!34 [10] 2.8% ??? [5] 97.2% [12] 11892(73.3%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:315:2 loop [21] 64.1% loop [15] 27.6% filter-p&e [17] 3.0% make-exacts-walkup [22] 2.8% for-loop [20] 2.5% ------------------------------------------------------------------- for-loop [8] 100.0% [13] 1262(7.8%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:343:0 localize! [16] 75.4% finalize-iter! [19] 24.6% ------------------------------------------------------------------- simplify! [11] 100.0% [14] 316(1.9%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:29:0 loop [18] 100.0% ------------------------------------------------------------------- loop [12] 100.0% [15] 3284(20.2%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:270:2 loop [21] 58.5% make-exacts-walkup [22] 41.5% ------------------------------------------------------------------- run-iter! [13] 100.0% [16] 952(5.9%) 0(0.0%) localize! ...herbie/develop/src/mainloop.rkt:138:0 localize-error [23] 100.0% ------------------------------------------------------------------- loop [12] 100.0% [17] 354(2.2%) 0(0.0%) filter-p&e .../herbie/develop/src/points.rkt:283:0 for-loop [24] 100.0% ------------------------------------------------------------------- ??? [14] 100.0% [18] 316(1.9%) 0(0.0%) loop .../herbie/develop/src/core/simplify.rkt:43:2 loop [25] 100.0% ------------------------------------------------------------------- run-iter! [13] 100.0% [19] 310(1.9%) 0(0.0%) finalize-iter! ...e/develop/src/mainloop.rkt:294:0 ??? [26] 100.0% ------------------------------------------------------------------- loop [12] 100.0% [20] 300(1.8%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:334:31 for-loop [27] 100.0% ------------------------------------------------------------------- loop [15] 20.1% loop [12] 79.9% [21] 9546(58.8%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:253:4 loop [34] 100.0% ------------------------------------------------------------------- loop [12] 19.4% loop [15] 80.6% [22] 1692(10.4%) 0(0.0%) make-exacts-walkup ...develop/src/points.rkt:250:0 loop [34] 100.0% ------------------------------------------------------------------- localize! [16] 100.0% [23] 952(5.9%) 0(0.0%) localize-error ...velop/src/core/localize.rkt:52:0 hash-ref! [28] 100.0% ------------------------------------------------------------------- filter-p&e [17] 100.0% [24] 354(2.2%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:285:2 ordinary-value? [29] 100.0% ------------------------------------------------------------------- loop [18] 100.0% [25] 316(1.9%) 316(1.9%) loop ...-7.0/collects/racket/private/map.rkt:74:19 ------------------------------------------------------------------- finalize-iter! [19] 100.0% [26] 310(1.9%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 for-loop [30] 100.0% ------------------------------------------------------------------- for-loop [20] 100.0% [27] 300(1.8%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:335:32 ??? [63] 100.0% ------------------------------------------------------------------- loop [34] 10.7% map [38] 27.6% localize-error [23] 61.7% [28] 952(5.9%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 f9 [31] 61.7% parse-loop15 [32] 38.3% ------------------------------------------------------------------- for-loop [24] 100.0% [29] 354(2.2%) 354(2.2%) ordinary-value? ...rbie/develop/src/float.rkt:54:0 ------------------------------------------------------------------- ??? [26] 100.0% [30] 310(1.9%) 0(0.0%) for-loop ...ie/develop/src/core/alt-table.rkt:51:2 atab-add-altn [33] 100.0% ------------------------------------------------------------------- hash-ref! [28] 100.0% [31] 952(5.9%) 0(0.0%) f9 ....0/collects/racket/match/compiler.rkt:507:40 map [38] 100.0% ------------------------------------------------------------------- hash-ref! [28] 100.0% [32] 628(3.9%) 0(0.0%) parse-loop15 ...s/racket/match/compiler.rkt:418:15 loop [34] 75.6% loop [41] 24.4% ------------------------------------------------------------------- for-loop [30] 100.0% [33] 310(1.9%) 0(0.0%) atab-add-altn ...elop/src/core/alt-table.rkt:200:0 best-and-tied-at-points [35]100.0% ------------------------------------------------------------------- make-exacts-walkup [22] 0.1% loop [21] 0.8% ??? [5] 2.2% parse-loop15 [32] 2.3% for-loop [4] 6.3% loop [34] 88.3% [34] 13322(82.1%) 324(2.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 loop [34] 88.3% ??? [43] 6.8% hash-ref! [28] 2.3% eval-prog [39] 2.2% ??? [47] 0.2% composed [36] 0.2% map [38] 0.0% ------------------------------------------------------------------- atab-add-altn [33] 100.0% [35] 310(1.9%) 0(0.0%) best-and-tied-at-points ...ore/alt-table.rkt:112:0 errors [37] 100.0% ------------------------------------------------------------------- loop [34] 100.0% [36] 6502(40.1%) 0(0.0%) composed ...ollects/racket/private/list.rkt:321:16 ??? [43] 100.0% ------------------------------------------------------------------- best-and-tied-at-points [35] 30.6% ??? [5] 69.4% [37] 1012(6.2%) 0(0.0%) errors ...lies/herbie/develop/src/points.rkt:234:0 for-loop [40] 100.0% ------------------------------------------------------------------- loop [34] 16.9% f9 [31] 83.1% [38] 952(5.9%) 0(0.0%) map ...t-7.0/collects/racket/private/map.rkt:35:13 hash-ref! [28] 49.1% loop [41] 34.0% ??? [49] 16.9% ------------------------------------------------------------------- loop [34] 100.0% [39] 288(1.8%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:129:0 temp68_2 [42] 100.0% ------------------------------------------------------------------- errors [37] 100.0% [40] 1012(6.2%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:236:2 ??? [43] 69.4% ??? [47] 30.6% ------------------------------------------------------------------- parse-loop15 [32] 0.8% map [38] 0.9% loop [41] 98.2% [41] 630(3.9%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:54:19 loop [41] 98.2% ??? [44] 0.9% ??? [49] 0.8% ------------------------------------------------------------------- eval-prog [39] 100.0% [42] 288(1.8%) 0(0.0%) temp68_2 (unknown source) compile16 [45] 100.0% ------------------------------------------------------------------- for-loop [9] 5.9% for-loop [40] 6.9% loop [34] 23.7% composed [36] 63.5% [43] 10238(63.1%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:145:2 ??? [46] 52.4% ->bf [48] 35.4% ??? [49] 9.5% ??? [47] 2.7% ------------------------------------------------------------------- loop [41] 100.0% [44] 324(2.0%) 0(0.0%) ??? .../herbie/develop/src/core/localize.rkt:43:32 ??? [47] 100.0% ------------------------------------------------------------------- temp68_2 [42] 100.0% [45] 288(1.8%) 0(0.0%) compile16 (unknown source) temp74_0 [50] 100.0% ------------------------------------------------------------------- ??? [43] 100.0% [46] 5362(33.0%) 870(5.4%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 big-posit16-sqrt [53] 40.7% big-posit16-mul [56] 19.4% big-posit16-add [57] 17.5% keyword-apply [58] 6.2% ------------------------------------------------------------------- ??? [43] 6.8% for-loop [40] 7.6% ??? [44] 8.0% loop [34] 77.5% [47] 4062(25.0%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [52] 61.5% double->posit16 [55] 38.5% ------------------------------------------------------------------- ??? [43] 100.0% [48] 3626(22.3%) 610(3.8%) ->bf ...tlies/herbie/develop/src/programs.rkt:61:0 bf [51] 83.2% ------------------------------------------------------------------- loop [41] 19.1% map [38] 20.1% ??? [43] 60.8% [49] 1600(9.9%) 0(0.0%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ??? [54] 100.0% ------------------------------------------------------------------- compile16 [45] 100.0% [50] 288(1.8%) 0(0.0%) temp74_0 (unknown source) expand-single [59] 100.0% ------------------------------------------------------------------- ->bf [48] 100.0% [51] 3016(18.6%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [73] 100.0% ------------------------------------------------------------------- ??? [47] 100.0% [52] 2498(15.4%) 1916(11.8%) ->flonum ...s/herbie/develop/src/programs.rkt:37:0 ??? [63] 23.3% ------------------------------------------------------------------- ??? [46] 100.0% [53] 2180(13.4%) 0(0.0%) big-posit16-sqrt ...src/syntax/softposit.rkt:112:0 ??? [65] 100.0% ------------------------------------------------------------------- ??? [49] 100.0% [54] 1600(9.9%) 0(0.0%) ??? ...lects/racket/contract/private/orc.rkt:83:14 either-flonum? [60] 100.0% ------------------------------------------------------------------- ??? [47] 100.0% [55] 1564(9.6%) 332(2.0%) double->posit16 ...ftposit-rkt/softposit.rkt:248:0 get-ffi-obj* [61] 78.8% ------------------------------------------------------------------- ??? [46] 100.0% [56] 1042(6.4%) 0(0.0%) big-posit16-mul .../src/syntax/softposit.rkt:110:0 bf* [62] 100.0% ------------------------------------------------------------------- ??? [46] 100.0% [57] 936(5.8%) 0(0.0%) big-posit16-add .../src/syntax/softposit.rkt:108:0 ??? [65] 100.0% ------------------------------------------------------------------- ??? [46] 100.0% [58] 334(2.1%) 334(2.1%) keyword-apply ...lects/racket/private/kw.rkt:421:2 ------------------------------------------------------------------- temp74_0 [50] 100.0% [59] 288(1.8%) 0(0.0%) expand-single (unknown source) expand-capturing-lifts [64] 100.0% ------------------------------------------------------------------- ??? [54] 100.0% [60] 1600(9.9%) 594(3.7%) either-flonum? ...evelop/src/syntax/types.rkt:11:0 ??? [67] 39.9% return/no-unsupplied [68] 23.0% ------------------------------------------------------------------- double->posit16 [55] 100.0% [61] 1232(7.6%) 0(0.0%) get-ffi-obj* ...-7.0/collects/ffi/unsafe.rkt:209:2 get-ffi-lib9 [66] 100.0% ------------------------------------------------------------------- big-posit16-mul [56] 100.0% [62] 1042(6.4%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [65] 100.0% ------------------------------------------------------------------- for-loop [27] 34.0% ->flonum [52] 66.0% [63] 882(5.4%) 882(5.4%) ??? ...-7.0/collects/racket/lazy-require.rkt:106:6 ------------------------------------------------------------------- expand-single [59] 100.0% [64] 288(1.8%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [69] 100.0% ------------------------------------------------------------------- big-posit16-add [57] 22.5% bf* [62] 25.1% big-posit16-sqrt [53] 52.4% [65] 4158(25.6%) 418(2.6%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfsqrt [70] 52.4% bfadd [71] 37.5% ------------------------------------------------------------------- get-ffi-obj* [61] 100.0% [66] 1232(7.6%) 1232(7.6%) get-ffi-lib9 ...-7.0/collects/ffi/unsafe.rkt:121:0 ------------------------------------------------------------------- either-flonum? [60] 100.0% [67] 638(3.9%) 638(3.9%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ------------------------------------------------------------------- either-flonum? [60] 100.0% [68] 368(2.3%) 368(2.3%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 ------------------------------------------------------------------- expand-capturing-lifts [64] 100.0% [69] 288(1.8%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [72] 100.0% ------------------------------------------------------------------- ??? [65] 100.0% [70] 2180(13.4%) 0(0.0%) bfsqrt ...lib/math/private/bigfloat/mpfr.rkt:618:4 ??? [74] 56.4% new-mpfr [73] 43.6% ------------------------------------------------------------------- ??? [65] 100.0% [71] 1560(9.6%) 0(0.0%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [73] 82.4% ??? [74] 17.6% ------------------------------------------------------------------- lambda-clause-expander [69] 100.0% [72] 288(1.8%) 0(0.0%) finish-bodys (unknown source) for-loop [75] 100.0% ------------------------------------------------------------------- bfsqrt [70] 18.1% bfadd [71] 24.5% bf [51] 57.4% [73] 5252(32.4%) 5252(32.4%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ------------------------------------------------------------------- bfadd [71] 18.2% bfsqrt [70] 81.8% [74] 1504(9.3%) 1504(9.3%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ------------------------------------------------------------------- finish-bodys [72] 100.0% [75] 288(1.8%) 288(1.8%) for-loop (unknown source) -------------------------------------------------------------------