Profiling results ----------------- Total cpu time observed: 4236ms (out of 4408ms) Number of samples taken: 25 (once every 169ms) ====================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ====================================================================== ??? [5] 100.0% [1] 4236(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [3] 100.0% ---------------------------------------------------------------------- ??? [5] 100.0% [2] 372(8.8%) 0(0.0%) errors ...lies/herbie/develop/src/points.rkt:223:0 for-loop [4] 100.0% ---------------------------------------------------------------------- profile-thunk16 [1] 100.0% [3] 4236(100.0%) 0(0.0%) run ...et-7.2/share/pkgs/profile-lib/main.rkt:39:2 ??? [5] 100.0% ---------------------------------------------------------------------- errors [2] 100.0% [4] 372(8.8%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:225:2 ??? [5] 100.0% ---------------------------------------------------------------------- for-loop [4] 2.9% run [3] 48.5% [5] 4236(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 48.5% prepare-points [15] 29.7% run-improve43 [6] 6.8% oracle-error [7] 3.8% eval-errors [8] 3.6% errors [2] 2.9% loop [9] 1.8% ordinary-value? [25] 1.7% ulp-difference [27] 1.2% ---------------------------------------------------------------------- ??? [5] 100.0% [6] 572(13.5%) 0(0.0%) run-improve43 ...ie/develop/src/mainloop.rkt:339:0 simplify! [12] 35.7% finalize-iter! [13] 33.6% setup-prog!34 [14] 30.8% ---------------------------------------------------------------------- ??? [5] 100.0% [7] 324(7.6%) 0(0.0%) oracle-error ...erbie/develop/src/points.rkt:207:0 for-loop [10] 100.0% ---------------------------------------------------------------------- ??? [5] 100.0% [8] 304(7.2%) 0(0.0%) eval-errors ...herbie/develop/src/points.rkt:198:0 for-loop [11] 100.0% ---------------------------------------------------------------------- ??? [5] 100.0% [9] 150(3.5%) 0(0.0%) loop ...-7.2/collects/racket/private/map.rkt:40:19 eval-prog [20] 100.0% ---------------------------------------------------------------------- oracle-error [7] 100.0% [10] 324(7.6%) 168(4.0%) for-loop ...es/herbie/develop/src/points.rkt:208:2 map [18] 48.1% ---------------------------------------------------------------------- eval-errors [8] 100.0% [11] 304(7.2%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:200:2 ??? [32] 100.0% ---------------------------------------------------------------------- run-improve43 [6] 100.0% [12] 204(4.8%) 0(0.0%) simplify! ...herbie/develop/src/mainloop.rkt:217:0 ??? [16] 100.0% ---------------------------------------------------------------------- run-improve43 [6] 100.0% [13] 192(4.5%) 0(0.0%) finalize-iter! ...e/develop/src/mainloop.rkt:271:0 ??? [17] 100.0% ---------------------------------------------------------------------- run-improve43 [6] 100.0% [14] 176(4.2%) 0(0.0%) setup-prog!34 ...bie/develop/src/mainloop.rkt:67:0 prepare-points [15] 100.0% ---------------------------------------------------------------------- setup-prog!34 [14] 6.5% ??? [5] 93.5% [15] 2690(63.5%) 0(0.0%) prepare-points ...bie/develop/src/points.rkt:166:0 loop [19] 93.5% eval-prog [20] 6.5% ---------------------------------------------------------------------- simplify! [12] 100.0% [16] 204(4.8%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:26:0 one-iter [21] 100.0% ---------------------------------------------------------------------- finalize-iter! [13] 100.0% [17] 192(4.5%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:390:18 atab-add-altns [22] 100.0% ---------------------------------------------------------------------- for-loop [10] 100.0% [18] 156(3.7%) 0(0.0%) map ...t-7.2/collects/racket/private/map.rkt:35:13 ??? [23] 100.0% ---------------------------------------------------------------------- prepare-points [15] 100.0% [19] 2514(59.3%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:143:4 loop [24] 74.9% ??? [26] 13.1% ordinary-value? [25] 12.0% ---------------------------------------------------------------------- loop [9] 46.0% prepare-points [15] 54.0% [20] 326(7.7%) 0(0.0%) eval-prog .../herbie/develop/src/programs.rkt:83:0 loop [30] 54.0% eval [31] 46.0% ---------------------------------------------------------------------- ??? [16] 100.0% [21] 204(4.8%) 0(0.0%) one-iter ...bie/develop/src/core/simplify.rkt:85:0 find-matches [28] 100.0% ---------------------------------------------------------------------- ??? [17] 100.0% [22] 192(4.5%) 0(0.0%) atab-add-altns ...elop/src/core/alt-table.rkt:50:0 loop [29] 100.0% ---------------------------------------------------------------------- map [18] 100.0% [23] 156(3.7%) 0(0.0%) ??? ...htlies/herbie/develop/src/points.rkt:209:26 ulp-difference [27] 100.0% ---------------------------------------------------------------------- loop [19] 100.0% [24] 1882(44.4%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:102:2 ??? [32] 92.1% ??? [39] 7.9% ---------------------------------------------------------------------- ??? [5] 42.1% loop [19] 57.9% [25] 522(12.3%) 0(0.0%) ordinary-value? ...rbie/develop/src/float.rkt:80:0 special-value? [33] 100.0% ---------------------------------------------------------------------- loop [19] 100.0% [26] 330(7.8%) 0(0.0%) ??? ...ghtlies/herbie/develop/src/points.rkt:127:2 ??? [41] 52.7% ??? [44] 47.3% ---------------------------------------------------------------------- ??? [5] 49.4% ??? [23] 50.6% [27] 308(7.3%) 0(0.0%) ulp-difference ...erbie/develop/src/float.rkt:46:0 infer-representation [34] 100.0% ---------------------------------------------------------------------- one-iter [21] 100.0% [28] 204(4.8%) 0(0.0%) find-matches ...develop/src/core/simplify.rkt:55:0 for-loop [35] 100.0% ---------------------------------------------------------------------- atab-add-altns [22] 100.0% [29] 192(4.5%) 0(0.0%) loop ...erbie/develop/src/core/alt-table.rkt:176:2 hash-remove* [36] 100.0% ---------------------------------------------------------------------- loop [30] 33.3% expand-capturing-lifts [37] 33.3% eval-prog [20] 33.3% [30] 176(4.2%) 0(0.0%) loop (unknown source) expand-capturing-lifts [37] 33.3% loop [30] 33.3% for-loop [58] 33.3% ---------------------------------------------------------------------- eval-prog [20] 100.0% [31] 150(3.5%) 0(0.0%) eval (unknown source) namespace-syntax-introduce3 [38]100.0% ---------------------------------------------------------------------- for-loop [11] 14.9% loop [24] 85.1% [32] 2038(48.1%) 150(3.5%) ??? ...htlies/herbie/develop/src/programs.rkt:99:2 ??? [40] 51.4% ??? [41] 41.2% ---------------------------------------------------------------------- ordinary-value? [25] 100.0% [33] 522(12.3%) 0(0.0%) special-value? ...erbie/develop/src/float.rkt:76:0 for-loop [42] 100.0% ---------------------------------------------------------------------- ulp-difference [27] 100.0% [34] 308(7.3%) 152(3.6%) infer-representation ...develop/src/float.rkt:15:0 return/no-unsupplied [46] 50.6% ---------------------------------------------------------------------- for-loop [35] 50.0% find-matches [28] 50.0% [35] 204(4.8%) 204(4.8%) for-loop ...bie/develop/src/core/simplify.rkt:57:8 for-loop [35] 50.0% ---------------------------------------------------------------------- loop [29] 100.0% [36] 192(4.5%) 192(4.5%) hash-remove* ...velop/src/core/alt-table.rkt:109:0 ---------------------------------------------------------------------- loop [30] 100.0% [37] 176(4.2%) 0(0.0%) expand-capturing-lifts (unknown source) loop [30] 100.0% ---------------------------------------------------------------------- eval [31] 100.0% [38] 150(3.5%) 0(0.0%) namespace-syntax-introduce3 (unknown source) free-identifier=? [43] 100.0% ---------------------------------------------------------------------- loop [24] 100.0% [39] 148(3.5%) 148(3.5%) ??? /opt/racket-7.2/collects/ffi/unsafe.rkt:905:4 ---------------------------------------------------------------------- ??? [32] 100.0% [40] 1048(24.7%) 0(0.0%) ??? ...t-7.2/collects/racket/private/kw.rkt:594:14 ??? [44] 100.0% ---------------------------------------------------------------------- ??? [26] 17.2% ??? [32] 82.8% [41] 1014(23.9%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:360:33 mk-ival [45] 67.7% sample-multi-bounded [47] 17.2% ->flonum [48] 15.2% ---------------------------------------------------------------------- special-value? [33] 100.0% [42] 522(12.3%) 302(7.1%) for-loop ...lies/herbie/develop/src/float.rkt:17:3 return/no-unsupplied [46] 42.1% ---------------------------------------------------------------------- namespace-syntax-introduce3 [38]100.0% [43] 150(3.5%) 0(0.0%) free-identifier=? (unknown source) resolve+shift28 [49] 100.0% ---------------------------------------------------------------------- ??? [26] 13.0% ??? [40] 87.0% [44] 1204(28.4%) 222(5.2%) ??? ...tract/private/arrow-higher-order.rkt:364:33 ival-sub [51] 56.1% ??? [53] 13.0% ival-add [55] 12.5% ---------------------------------------------------------------------- ??? [41] 100.0% [45] 686(16.2%) 0(0.0%) mk-ival ...herbie/develop/src/biginterval.rkt:57:0 bf [50] 100.0% ---------------------------------------------------------------------- infer-representation [34] 41.5% for-loop [42] 58.5% [46] 376(8.9%) 376(8.9%) return/no-unsupplied ...ct/private/arr-i.rkt:542:0 ---------------------------------------------------------------------- ??? [41] 100.0% [47] 174(4.1%) 0(0.0%) sample-multi-bounded ...evelop/src/points.rkt:15:0 list-member? [52] 100.0% ---------------------------------------------------------------------- ??? [41] 100.0% [48] 154(3.6%) 0(0.0%) ->flonum ...ies/herbie/develop/src/float.rkt:149:0 ??? [54] 100.0% ---------------------------------------------------------------------- free-identifier=? [43] 100.0% [49] 150(3.5%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [56] 100.0% ---------------------------------------------------------------------- mk-ival [45] 100.0% [50] 686(16.2%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [61] 100.0% ---------------------------------------------------------------------- ??? [44] 100.0% [51] 676(16.0%) 152(3.6%) ival-sub ...rbie/develop/src/biginterval.rkt:100:0 bfsub [57] 77.5% ---------------------------------------------------------------------- sample-multi-bounded [47] 100.0% [52] 174(4.1%) 174(4.1%) list-member? ...llects/racket/private/set.rkt:24:0 ---------------------------------------------------------------------- ??? [44] 100.0% [53] 156(3.7%) 0(0.0%) ??? ...ects/racket/contract/private/prop.rkt:541:4 ??? [59] 100.0% ---------------------------------------------------------------------- ->flonum [48] 100.0% [54] 154(3.6%) 0(0.0%) ??? ...nightlies/herbie/develop/src/float.rkt:23:2 for-loop [60] 100.0% ---------------------------------------------------------------------- ??? [44] 100.0% [55] 150(3.5%) 150(3.5%) ival-add ...erbie/develop/src/biginterval.rkt:94:0 ---------------------------------------------------------------------- resolve+shift28 [49] 100.0% [56] 150(3.5%) 0(0.0%) fallback-loop (unknown source) for-loop [58] 100.0% ---------------------------------------------------------------------- ival-sub [51] 100.0% [57] 524(12.4%) 186(4.4%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [61] 64.5% ---------------------------------------------------------------------- loop [30] 3.2% for-loop [58] 25.4% run-module-instance!125 [62] 25.4% fallback-loop [56] 46.0% [58] 326(7.7%) 150(3.5%) for-loop (unknown source) run-module-instance!125 [62] 28.6% for-loop [58] 25.4% ---------------------------------------------------------------------- ??? [53] 100.0% [59] 156(3.7%) 0(0.0%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ??? [63] 100.0% ---------------------------------------------------------------------- ??? [54] 100.0% [60] 154(3.6%) 154(3.6%) for-loop ...lies/herbie/develop/src/float.rkt:24:5 ---------------------------------------------------------------------- bfsub [57] 33.0% bf [50] 67.0% [61] 1024(24.2%) 1024(24.2%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 ---------------------------------------------------------------------- for-loop [58] 100.0% [62] 176(4.2%) 176(4.2%) run-module-instance!125 (unknown source) for-loop [58] 88.9% ---------------------------------------------------------------------- ??? [59] 100.0% [63] 156(3.7%) 156(3.7%) ??? ...ects/racket/contract/private/list.rkt:163:5 ----------------------------------------------------------------------