Profiling results ----------------- Total cpu time observed: 18584ms (out of 18924ms) Number of samples taken: 60 (once every 310ms) ================================================================ Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ================================================================ ??? [9] 100.0% [1] 18584(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ---------------------------------------------------------------- ??? [9] 100.0% [2] 582(3.1%) 0(0.0%) run-improve43 ...bie/master/src/mainloop.rkt:339:0 setup-prog!34 [4] 100.0% ---------------------------------------------------------------- profile-thunk16 [1] 100.0% [3] 18584(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [9] 100.0% ---------------------------------------------------------------- run-improve43 [2] 100.0% [4] 582(3.1%) 0(0.0%) setup-prog!34 ...rbie/master/src/mainloop.rkt:67:0 prepare-points [10] 50.2% ??? [5] 49.8% ---------------------------------------------------------------- setup-prog!34 [4] 100.0% [5] 290(1.6%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 make-alt-table [6] 100.0% ---------------------------------------------------------------- ??? [5] 100.0% [6] 290(1.6%) 0(0.0%) make-alt-table ...ster/src/core/alt-table.rkt:33:0 errors [7] 100.0% ---------------------------------------------------------------- make-alt-table [6] 28.2% ??? [9] 71.8% [7] 1028(5.5%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:223:0 for-loop [8] 100.0% ---------------------------------------------------------------- errors [7] 100.0% [8] 1028(5.5%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:225:2 ??? [9] 100.0% ---------------------------------------------------------------- for-loop [8] 1.8% run [3] 49.1% [9] 18584(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 49.1% prepare-points [10] 43.8% oracle-error [11] 1.3% errors [7] 1.3% run-improve43 [2] 1.3% ??? [23] 0.9% eval-errors [12] 0.7% debug-print [13] 0.7% ulp-difference [26] 0.5% ordinary-value? [24] 0.4% ---------------------------------------------------------------- setup-prog!34 [4] 1.8% ??? [9] 98.2% [10] 16570(89.2%) 0(0.0%) prepare-points ...rbie/master/src/points.rkt:166:0 loop [14] 100.0% ---------------------------------------------------------------- ??? [9] 100.0% [11] 496(2.7%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:207:0 for-loop [15] 100.0% ---------------------------------------------------------------- ??? [9] 100.0% [12] 246(1.3%) 0(0.0%) eval-errors .../herbie/master/src/points.rkt:198:0 for-loop [16] 100.0% ---------------------------------------------------------------- ??? [9] 100.0% [13] 244(1.3%) 0(0.0%) debug-print ...s/herbie/master/src/debug.rkt:110:0 ??? [17] 100.0% ---------------------------------------------------------------- prepare-points [10] 100.0% [14] 16570(89.2%) 346(1.9%) loop ...ghtlies/herbie/master/src/points.rkt:143:4 loop [18] 54.5% ??? [19] 32.9% ordinary-value? [24] 5.3% andmap [20] 5.2% ---------------------------------------------------------------- oracle-error [11] 100.0% [15] 496(2.7%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:208:2 loop [21] 100.0% ---------------------------------------------------------------- eval-errors [12] 100.0% [16] 246(1.3%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:200:2 ??? [23] 100.0% ---------------------------------------------------------------- debug-print [13] 100.0% [17] 244(1.3%) 0(0.0%) ??? .../contract/private/arrow-val-first.rkt:428:3 mk-call [22] 100.0% ---------------------------------------------------------------- loop [14] 100.0% [18] 9038(48.6%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:102:2 ??? [23] 93.8% hash-update! [25] 6.2% ---------------------------------------------------------------- loop [14] 100.0% [19] 5444(29.3%) 850(4.6%) ??? ...ightlies/herbie/master/src/points.rkt:127:2 ??? [28] 79.1% ??? [33] 5.3% ---------------------------------------------------------------- loop [14] 100.0% [20] 858(4.6%) 278(1.5%) andmap ...0/collects/racket/private/map.rkt:102:13 ordinary-value? [24] 67.6% ---------------------------------------------------------------- for-loop [15] 100.0% [21] 496(2.7%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 ??? [23] 50.4% ulp-difference [26] 49.6% ---------------------------------------------------------------- ??? [17] 100.0% [22] 244(1.3%) 0(0.0%) mk-call ...tract/private/arrow-val-first.rkt:431:5 loop [27] 100.0% ---------------------------------------------------------------- for-loop [16] 2.6% loop [21] 2.6% ??? [9] 5.2% loop [18] 89.6% [23] 9464(50.9%) 276(1.5%) ??? ...ghtlies/herbie/master/src/programs.rkt:99:2 ??? [29] 65.1% ??? [28] 32.0% ---------------------------------------------------------------- ??? [9] 14.5% andmap [20] 33.9% loop [14] 51.6% [24] 1712(9.2%) 288(1.5%) ordinary-value? ...erbie/master/src/float.rkt:80:0 special-value? [30] 83.2% ---------------------------------------------------------------- loop [18] 100.0% [25] 560(3.0%) 560(3.0%) hash-update! ...cket/private/more-scheme.rkt:365:4 ---------------------------------------------------------------- loop [21] 45.9% ??? [9] 54.1% [26] 536(2.9%) 0(0.0%) ulp-difference ...herbie/master/src/float.rkt:46:0 infer-representation [31]100.0% ---------------------------------------------------------------- mk-call [22] 100.0% [27] 244(1.3%) 0(0.0%) loop ...contract/private/arrow-val-first.rkt:435:8 ??? [32] 100.0% ---------------------------------------------------------------- ??? [23] 41.3% ??? [19] 58.7% [28] 7334(39.5%) 1512(8.1%) ??? ...tract/private/arrow-higher-order.rkt:357:33 sample-multi-bounded [34] 34.5% mk-ival [35] 27.9% ->flonum [37] 13.4% ??? [38] 3.5% ---------------------------------------------------------------- ??? [23] 100.0% [29] 6158(33.1%) 0(0.0%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 ??? [33] 100.0% ---------------------------------------------------------------- ordinary-value? [24] 100.0% [30] 1424(7.7%) 0(0.0%) special-value? ...herbie/master/src/float.rkt:76:0 for-loop [36] 100.0% ---------------------------------------------------------------- ulp-difference [26] 100.0% [31] 536(2.9%) 290(1.6%) infer-representation .../master/src/float.rkt:15:0 ??? [39] 45.9% ---------------------------------------------------------------- loop [27] 100.0% [32] 244(1.3%) 0(0.0%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ??? [40] 100.0% ---------------------------------------------------------------- ??? [19] 4.5% ??? [29] 95.5% [33] 6448(34.7%) 1898(10.2%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-log [41] 41.2% ival-add [43] 20.8% ival-exp [46] 8.6% ---------------------------------------------------------------- ??? [28] 100.0% [34] 2532(13.6%) 1142(6.1%) sample-multi-bounded ...master/src/points.rkt:15:0 for-loop [45] 34.1% loop [47] 20.8% ---------------------------------------------------------------- ??? [28] 100.0% [35] 2044(11.0%) 0(0.0%) mk-ival .../herbie/master/src/biginterval.rkt:57:0 bf [42] 100.0% ---------------------------------------------------------------- special-value? [30] 100.0% [36] 1424(7.7%) 860(4.6%) for-loop ...tlies/herbie/master/src/float.rkt:17:3 return/no-unsupplied [56] 39.6% ---------------------------------------------------------------- ??? [28] 100.0% [37] 986(5.3%) 0(0.0%) ->flonum ...lies/herbie/master/src/float.rkt:149:0 ??? [44] 100.0% ---------------------------------------------------------------- ??? [28] 100.0% [38] 260(1.4%) 260(1.4%) ??? ...cts/racket/contract/private/list.rkt:209:10 ---------------------------------------------------------------- infer-representation [31]100.0% [39] 246(1.3%) 246(1.3%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ---------------------------------------------------------------- ??? [32] 100.0% [40] 244(1.3%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:681:0 contract-first-order [48]100.0% ---------------------------------------------------------------- ??? [33] 100.0% [41] 2656(14.3%) 558(3.0%) ival-log ...erbie/master/src/biginterval.rkt:186:0 bflog [49] 79.0% ---------------------------------------------------------------- mk-ival [35] 100.0% [42] 2044(11.0%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [54] 83.2% ??? [55] 16.8% ---------------------------------------------------------------- ??? [33] 100.0% [43] 1342(7.2%) 248(1.3%) ival-add ...herbie/master/src/biginterval.rkt:94:0 bfadd [50] 81.5% ---------------------------------------------------------------- ->flonum [37] 100.0% [44] 986(5.3%) 0(0.0%) ??? .../nightlies/herbie/master/src/float.rkt:23:2 for-loop [51] 100.0% ---------------------------------------------------------------- sample-multi-bounded [34]100.0% [45] 864(4.6%) 864(4.6%) for-loop ...lies/herbie/master/src/points.rkt:23:4 ---------------------------------------------------------------- ??? [33] 100.0% [46] 552(3.0%) 0(0.0%) ival-exp ...erbie/master/src/biginterval.rkt:180:0 bflog [49] 100.0% ---------------------------------------------------------------- sample-multi-bounded [34]100.0% [47] 526(2.8%) 0(0.0%) loop ...ightlies/herbie/master/src/points.rkt:42:6 random-exp [52] 100.0% ---------------------------------------------------------------- ??? [40] 100.0% [48] 244(1.3%) 0(0.0%) contract-first-order ...act/private/guts.rkt:216:0 coerce-contract/f [53] 100.0% ---------------------------------------------------------------- ival-exp [46] 20.8% ival-log [41] 79.2% [49] 2650(14.3%) 0(0.0%) bflog ...-lib/math/private/bigfloat/mpfr.rkt:618:4 new-mpfr [54] 70.1% ??? [55] 29.9% ---------------------------------------------------------------- ival-add [43] 100.0% [50] 1094(5.9%) 0(0.0%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:821:4 ??? [55] 73.3% new-mpfr [54] 26.7% ---------------------------------------------------------------- ??? [44] 100.0% [51] 986(5.3%) 494(2.7%) for-loop ...tlies/herbie/master/src/float.rkt:24:5 return/no-unsupplied [56] 49.9% ---------------------------------------------------------------- loop [47] 100.0% [52] 526(2.8%) 526(2.8%) random-exp ...s/herbie/master/src/common.rkt:172:0 ---------------------------------------------------------------- contract-first-order [48]100.0% [53] 244(1.3%) 244(1.3%) coerce-contract/f ...ntract/private/guts.rkt:350:0 ---------------------------------------------------------------- bfadd [50] 7.6% bf [42] 44.2% bflog [49] 48.3% [54] 3850(20.7%) 3850(20.7%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ---------------------------------------------------------------- bf [42] 17.8% bflog [49] 40.9% bfadd [50] 41.4% [55] 1938(10.4%) 1938(10.4%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ---------------------------------------------------------------- for-loop [51] 46.6% for-loop [36] 53.4% [56] 1056(5.7%) 248(1.3%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 filter [57] 76.5% ---------------------------------------------------------------- return/no-unsupplied [56]100.0% [57] 808(4.3%) 808(4.3%) filter ...0/collects/racket/private/list.rkt:256:2 ----------------------------------------------------------------