Profiling results ----------------- Total cpu time observed: 18662ms (out of 18964ms) Number of samples taken: 54 (once every 346ms) ======================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================= ??? [5] 100.0% [1] 18662(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ----------------------------------------------------------------------- ??? [5] 100.0% [2] 2150(11.5%) 0(0.0%) errors ...bie/optional-posits/src/points.rkt:222:0 for-loop [4] 100.0% ----------------------------------------------------------------------- profile-thunk16 [1] 100.0% [3] 18662(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [5] 100.0% ----------------------------------------------------------------------- errors [2] 100.0% [4] 2150(11.5%) 0(0.0%) for-loop ...e/optional-posits/src/points.rkt:224:2 ??? [5] 100.0% ----------------------------------------------------------------------- for-loop [4] 3.8% run [3] 48.1% [5] 18662(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 48.1% prepare-points-intervals [10] 26.2% oracle-error [7] 5.7% eval-errors [6] 5.7% run-improve40 [8] 4.3% errors [2] 3.8% errors-score [9] 2.4% ??? [26] 2.2% ulp-difference [22] 1.1% ??? [56] 0.5% ----------------------------------------------------------------------- ??? [5] 100.0% [6] 2112(11.3%) 0(0.0%) eval-errors ...ptional-posits/src/points.rkt:197:0 for-loop [11] 100.0% ----------------------------------------------------------------------- ??? [5] 100.0% [7] 2112(11.3%) 0(0.0%) oracle-error ...tional-posits/src/points.rkt:206:0 for-loop [12] 100.0% ----------------------------------------------------------------------- ??? [5] 100.0% [8] 1600(8.6%) 0(0.0%) run-improve40 ...nal-posits/src/mainloop.rkt:336:0 simplify! [13] 60.0% prepare-points-intervals [10] 20.5% for-loop [15] 19.5% ----------------------------------------------------------------------- ??? [5] 100.0% [9] 908(4.9%) 0(0.0%) errors-score ...tional-posits/src/points.rkt:214:0 loop [14] 100.0% ----------------------------------------------------------------------- run-improve40 [8] 3.2% ??? [5] 96.8% [10] 10108(54.2%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:130:0 loop [16] 100.0% ----------------------------------------------------------------------- eval-errors [6] 100.0% [11] 2112(11.3%) 0(0.0%) for-loop ...e/optional-posits/src/points.rkt:199:2 ??? [26] 56.8% ulp-difference [22] 28.5% ??? [39] 14.7% ----------------------------------------------------------------------- oracle-error [7] 100.0% [12] 2112(11.3%) 300(1.6%) for-loop ...e/optional-posits/src/points.rkt:207:2 loop [17] 85.8% ----------------------------------------------------------------------- run-improve40 [8] 100.0% [13] 960(5.1%) 0(0.0%) simplify! ...ptional-posits/src/mainloop.rkt:213:0 ??? [18] 100.0% ----------------------------------------------------------------------- errors-score [9] 100.0% [14] 908(4.9%) 0(0.0%) loop .../racket-7.0/collects/racket/list.rkt:559:2 ordinary-value? [27] 100.0% ----------------------------------------------------------------------- run-improve40 [8] 100.0% [15] 312(1.7%) 0(0.0%) for-loop ...optional-posits/src/mainloop.rkt:351:4 run-iter! [19] 100.0% ----------------------------------------------------------------------- prepare-points-intervals [10] 100.0% [16] 10108(54.2%) 0(0.0%) loop ...erbie/optional-posits/src/points.rkt:142:4 loop [20] 54.6% ??? [21] 26.6% loop [23] 15.8% ordinary-value? [27] 2.9% ----------------------------------------------------------------------- for-loop [12] 100.0% [17] 1812(9.7%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 ulp-difference [22] 50.3% ??? [26] 49.7% ----------------------------------------------------------------------- simplify! [13] 100.0% [18] 960(5.1%) 0(0.0%) ??? .../optional-posits/src/core/simplify.rkt:26:0 one-iter [24] 100.0% ----------------------------------------------------------------------- for-loop [15] 100.0% [19] 312(1.7%) 0(0.0%) run-iter! ...ptional-posits/src/mainloop.rkt:317:0 localize! [25] 100.0% ----------------------------------------------------------------------- loop [16] 100.0% [20] 5520(29.6%) 0(0.0%) loop ...erbie/optional-posits/src/points.rkt:101:2 ??? [26] 57.8% ??? [39] 29.8% ??? [56] 6.5% ??? [31] 5.9% ----------------------------------------------------------------------- loop [16] 100.0% [21] 2692(14.4%) 624(3.3%) ??? ...herbie/optional-posits/src/points.rkt:126:2 ??? [39] 66.1% curried [33] 10.7% ----------------------------------------------------------------------- for-loop [11] 28.2% ??? [5] 29.1% loop [17] 42.7% [22] 2136(11.4%) 310(1.7%) ulp-difference ...tional-posits/src/float.rkt:39:0 infer-double-representation [28] 85.5% ----------------------------------------------------------------------- loop [16] 100.0% [23] 1598(8.6%) 0(0.0%) loop ...7.0/collects/racket/private/map.rkt:110:23 ordinary-value? [27] 100.0% ----------------------------------------------------------------------- ??? [18] 100.0% [24] 960(5.1%) 0(0.0%) one-iter ...onal-posits/src/core/simplify.rkt:86:0 find-matches [29] 58.5% for-loop [30] 41.5% ----------------------------------------------------------------------- run-iter! [19] 100.0% [25] 312(1.7%) 0(0.0%) localize! ...ptional-posits/src/mainloop.rkt:116:0 localize-error [32] 100.0% ----------------------------------------------------------------------- loop [17] 13.8% for-loop [11] 18.4% ??? [5] 18.8% loop [20] 49.0% [26] 6520(34.9%) 602(3.2%) ??? ...erbie/optional-posits/src/programs.rkt:99:2 ??? [39] 43.6% ??? [35] 28.8% ??? [56] 18.4% ----------------------------------------------------------------------- loop [16] 10.6% loop [14] 32.4% loop [23] 57.0% [27] 2804(15.0%) 0(0.0%) ordinary-value? ...ional-posits/src/float.rkt:73:0 special-value? [34] 100.0% ----------------------------------------------------------------------- ulp-difference [22] 100.0% [28] 1826(9.8%) 0(0.0%) infer-double-representation .../src/float.rkt:33:0 for-loop [40] 100.0% ----------------------------------------------------------------------- one-iter [24] 100.0% [29] 562(3.0%) 0(0.0%) find-matches ...-posits/src/core/simplify.rkt:56:0 for-loop [36] 100.0% ----------------------------------------------------------------------- one-iter [24] 100.0% [30] 398(2.1%) 0(0.0%) for-loop ...onal-posits/src/core/simplify.rkt:95:2 loop [37] 100.0% ----------------------------------------------------------------------- loop [20] 100.0% [31] 324(1.7%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:388:18 ??? [56] 100.0% ----------------------------------------------------------------------- localize! [25] 100.0% [32] 312(1.7%) 0(0.0%) localize-error ...osits/src/core/localize.rkt:52:0 hash-ref! [38] 100.0% ----------------------------------------------------------------------- ??? [21] 100.0% [33] 288(1.5%) 288(1.5%) curried ...-7.0/collects/racket/function.rkt:71:18 ----------------------------------------------------------------------- ordinary-value? [27] 100.0% [34] 2804(15.0%) 288(1.5%) special-value? ...tional-posits/src/float.rkt:69:0 for-loop [40] 89.7% ----------------------------------------------------------------------- ??? [26] 100.0% [35] 1876(10.1%) 0(0.0%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 ??? [39] 66.7% ??? [41] 33.3% ----------------------------------------------------------------------- for-loop [36] 50.0% find-matches [29] 50.0% [36] 562(3.0%) 0(0.0%) for-loop ...onal-posits/src/core/simplify.rkt:58:8 for-loop [36] 50.0% match-e [42] 50.0% ----------------------------------------------------------------------- for-loop [30] 100.0% [37] 398(2.1%) 0(0.0%) loop ...ptional-posits/src/core/simplify.rkt:100:4 apply-match [43] 100.0% ----------------------------------------------------------------------- localize-error [32] 100.0% [38] 312(1.7%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 parse-loop15 [44] 100.0% ----------------------------------------------------------------------- for-loop [11] 4.0% ??? [35] 16.0% loop [20] 21.0% ??? [21] 22.7% ??? [26] 36.3% [39] 7828(41.9%) 926(5.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ->flonum [45] 36.5% sample-multi-bounded [46] 18.9% mk-ival [47] 16.8% ival-mult [48] 16.0% ----------------------------------------------------------------------- infer-double-representation [28] 42.1% special-value? [34] 57.9% [40] 4342(23.3%) 2430(13.0%) for-loop ...bie/optional-posits/src/float.rkt:16:3 ??? [68] 30.2% ??? [53] 7.0% list-member? [54] 6.9% ----------------------------------------------------------------------- ??? [35] 100.0% [41] 624(3.3%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-add [49] 100.0% ----------------------------------------------------------------------- for-loop [36] 100.0% [42] 562(3.0%) 248(1.3%) match-e ...ptional-posits/src/core/ematch.rkt:39:0 constant? [51] 55.9% ----------------------------------------------------------------------- loop [37] 100.0% [43] 398(2.1%) 0(0.0%) apply-match ...l-posits/src/core/simplify.rkt:65:0 for-loop [50] 100.0% ----------------------------------------------------------------------- hash-ref! [38] 100.0% [44] 312(1.7%) 0(0.0%) parse-loop15 ...s/racket/match/compiler.rkt:418:15 loop [52] 100.0% ----------------------------------------------------------------------- ??? [39] 100.0% [45] 2854(15.3%) 0(0.0%) ->flonum ...ie/optional-posits/src/float.rkt:142:0 ??? [55] 100.0% ----------------------------------------------------------------------- ??? [39] 100.0% [46] 1480(7.9%) 1188(6.4%) sample-multi-bounded ...posits/src/points.rkt:15:0 loop [61] 19.7% ----------------------------------------------------------------------- ??? [39] 100.0% [47] 1316(7.1%) 0(0.0%) mk-ival ...ptional-posits/src/biginterval.rkt:57:0 bf [57] 100.0% ----------------------------------------------------------------------- ??? [39] 100.0% [48] 1252(6.7%) 294(1.6%) ival-mult ...onal-posits/src/biginterval.rkt:112:0 bfmul [58] 76.5% ----------------------------------------------------------------------- ??? [41] 100.0% [49] 624(3.3%) 324(1.7%) ival-add ...tional-posits/src/biginterval.rkt:94:0 bfmul [58] 48.1% ----------------------------------------------------------------------- apply-match [43] 100.0% [50] 398(2.1%) 0(0.0%) for-loop ...onal-posits/src/core/simplify.rkt:78:2 merge-egraph-nodes! [59] 100.0% ----------------------------------------------------------------------- match-e [42] 100.0% [51] 314(1.7%) 0(0.0%) constant? ...al-posits/src/syntax/syntax.rkt:721:0 value? [60] 100.0% ----------------------------------------------------------------------- parse-loop15 [44] 1.2% loop [52] 98.8% [52] 312(1.7%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:54:19 loop [52] 98.8% ??? [56] 1.2% ----------------------------------------------------------------------- for-loop [40] 100.0% [53] 302(1.6%) 302(1.6%) ??? ...s/racket/contract/private/arr-i.rkt:1252:29 ----------------------------------------------------------------------- for-loop [40] 100.0% [54] 300(1.6%) 300(1.6%) list-member? ...llects/racket/private/set.rkt:24:0 ----------------------------------------------------------------------- ->flonum [45] 100.0% [55] 2854(15.3%) 0(0.0%) ??? ...s/herbie/optional-posits/src/float.rkt:22:2 for-loop [62] 100.0% ----------------------------------------------------------------------- ??? [5] 12.0% loop [52] 12.5% ??? [31] 13.0% loop [20] 14.4% ??? [26] 48.1% [56] 2496(13.4%) 1284(6.9%) ??? ...ects/racket/contract/private/guts.rkt:746:8 for-loop [64] 48.6% ----------------------------------------------------------------------- mk-ival [47] 100.0% [57] 1316(7.1%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 ??? [63] 72.9% new-mpfr [66] 27.1% ----------------------------------------------------------------------- ival-add [49] 23.8% ival-mult [48] 76.2% [58] 1258(6.7%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 ??? [63] 100.0% ----------------------------------------------------------------------- for-loop [50] 100.0% [59] 398(2.1%) 0(0.0%) merge-egraph-nodes! ...s/src/core/egraph.rkt:143:0 for-loop [65] 100.0% ----------------------------------------------------------------------- constant? [51] 100.0% [60] 314(1.7%) 314(1.7%) value? ...ptional-posits/src/syntax/types.rkt:18:0 ----------------------------------------------------------------------- sample-multi-bounded [46] 100.0% [61] 292(1.6%) 0(0.0%) loop ...herbie/optional-posits/src/points.rkt:42:6 random-exp [67] 100.0% ----------------------------------------------------------------------- ??? [55] 100.0% [62] 2854(15.3%) 2554(13.7%) for-loop ...bie/optional-posits/src/float.rkt:23:5 return/no-unsupplied [69] 10.5% ----------------------------------------------------------------------- bf [57] 43.3% bfmul [58] 56.7% [63] 2218(11.9%) 2218(11.9%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 ----------------------------------------------------------------------- ??? [56] 100.0% [64] 1212(6.5%) 912(4.9%) for-loop ...onal-posits/src/syntax/types.rkt:18:19 ??? [68] 24.8% ----------------------------------------------------------------------- merge-egraph-nodes! [59] 100.0% [65] 398(2.1%) 398(2.1%) for-loop ...ie/optional-posits/src/common.rkt:70:9 ----------------------------------------------------------------------- bf [57] 100.0% [66] 356(1.9%) 356(1.9%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ----------------------------------------------------------------------- loop [61] 100.0% [67] 292(1.6%) 292(1.6%) random-exp ...optional-posits/src/common.rkt:172:0 ----------------------------------------------------------------------- for-loop [64] 18.6% for-loop [40] 81.4% [68] 1610(8.6%) 1610(8.6%) ??? ...-7.0/collects/racket/lazy-require.rkt:106:6 ----------------------------------------------------------------------- for-loop [62] 100.0% [69] 300(1.6%) 300(1.6%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 -----------------------------------------------------------------------