Profiling results ----------------- Total cpu time observed: 15858ms (out of 16016ms) Number of samples taken: 71 (once every 223ms) ======================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================= [1] 15858(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 100.0% ----------------------------------------------------------------------- hash-ref! [35] 100.0% [2] 3278(20.7%) 0(0.0%) ??? ...htlies/herbie/master/src/programs.rkt:178:5 loop [27] 100.0% ----------------------------------------------------------------------- matcher [58] 100.0% [3] 320(2.0%) 0(0.0%) ??? ...s/herbie/master/src/core/matcher.rkt:127:11 for-loop [9] 66.7% foldr [8] 33.3% ----------------------------------------------------------------------- for-loop [75] 100.0% [4] 222(1.4%) 0(0.0%) syntax-e (unknown source) syntax-e/no-taint [7] 100.0% ----------------------------------------------------------------------- loop [27] 100.0% [5] 200(1.3%) 0(0.0%) expand-id-application-form17 (unknown source) syntax-e/no-taint [7] 100.0% ----------------------------------------------------------------------- ??? [1] 100.0% [6] 15858(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [10] 100.0% ----------------------------------------------------------------------- expand-id-application-form17 [5] 47.4% syntax-e [4] 52.6% [7] 422(2.7%) 0(0.0%) syntax-e/no-taint (unknown source) loop [27] 100.0% ----------------------------------------------------------------------- ??? [3] 100.0% [8] 320(2.0%) 320(2.0%) foldr ....5/collects/racket/private/list.rkt:242:4 ----------------------------------------------------------------------- ??? [3] 100.0% [9] 320(2.0%) 0(0.0%) for-loop ...bie/master/src/core/matcher.rkt:129:15 matcher [58] 100.0% ----------------------------------------------------------------------- profile-thunk16 [6] 100.0% [10] 15858(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [11] 100.0% ----------------------------------------------------------------------- for-loop [56] 1.4% run [10] 98.6% [11] 15858(100.0%) 448(2.8%) .../more-scheme.rkt:261:28 (unknown source) loop [14] 79.3% run-improve47 [12] 16.4% oracle-error [13] 1.4% errors [50] 1.4% ----------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11] 100.0% [12] 2608(16.4%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:346:0 loop [14] 59.4% for-loop [15] 40.6% ----------------------------------------------------------------------- .../more-scheme.rkt:261:28 [11] 100.0% [13] 224(1.4%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:177:0 for-loop [16] 100.0% ----------------------------------------------------------------------- run-improve47 [12] 11.0% .../more-scheme.rkt:261:28 [11] 89.0% [14] 14128(89.1%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:266:2 loop [17] 46.9% make-exacts-walkup [20] 27.6% loop [21] 25.5% ----------------------------------------------------------------------- run-improve47 [12] 100.0% [15] 1058(6.7%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:365:4 run-iter! [18] 100.0% ----------------------------------------------------------------------- oracle-error [13] 100.0% [16] 224(1.4%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:178:2 map [19] 100.0% ----------------------------------------------------------------------- loop [14] 100.0% [17] 6628(41.8%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:230:2 make-exacts-walkup [20] 71.7% loop [21] 28.3% ----------------------------------------------------------------------- for-loop [15] 100.0% [18] 1058(6.7%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:327:0 gen-rewrites! [22] 30.2% simplify! [23] 29.9% localize! [25] 21.0% finalize-iter! [26] 18.9% ----------------------------------------------------------------------- parse-loop15 [45] 49.8% for-loop [16] 50.2% [19] 446(2.8%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 ??? [24] 50.2% hash-ref! [35] 49.8% ----------------------------------------------------------------------- loop [14] 45.1% loop [17] 54.9% [20] 8654(54.6%) 0(0.0%) make-exacts-walkup .../master/src/points.rkt:209:0 loop [27] 59.6% eval-prog [28] 37.9% temp85_0 [57] 2.6% ----------------------------------------------------------------------- loop [17] 34.3% loop [14] 65.7% [21] 5474(34.5%) 0(0.0%) loop ...ghtlies/herbie/master/src/points.rkt:213:4 loop [27] 100.0% ----------------------------------------------------------------------- run-iter! [18] 100.0% [22] 320(2.0%) 0(0.0%) gen-rewrites! ...bie/master/src/mainloop.rkt:183:0 for-loop [29] 100.0% ----------------------------------------------------------------------- run-iter! [18] 100.0% [23] 316(2.0%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:224:0 ??? [30] 100.0% ----------------------------------------------------------------------- map [19] 100.0% [24] 224(1.4%) 0(0.0%) ??? ...ghtlies/herbie/master/src/points.rkt:179:26 ulp-difference [31] 100.0% ----------------------------------------------------------------------- run-iter! [18] 100.0% [25] 222(1.4%) 0(0.0%) localize! .../herbie/master/src/mainloop.rkt:127:0 localize-error [32] 100.0% ----------------------------------------------------------------------- run-iter! [18] 100.0% [26] 200(1.3%) 0(0.0%) finalize-iter! ...ie/master/src/mainloop.rkt:278:0 ??? [33] 100.0% ----------------------------------------------------------------------- loop [21] 0.3% make-exacts-walkup [20] 0.4% for-loop [75] 0.7% syntax-e/no-taint [7] 2.2% ??? [2] 22.9% loop [27] 73.4% [27] 14328(90.4%) 202(1.3%) loop (unknown source) loop [27] 73.4% hash-ref! [35] 22.9% gf [36] 2.2% composed [34] 0.8% expand-id-application-form17 [5] 0.7% ----------------------------------------------------------------------- make-exacts-walkup [20] 100.0% [28] 3278(20.7%) 0(0.0%) eval-prog ...s/herbie/master/src/programs.rkt:82:0 hash-ref! [35] 100.0% ----------------------------------------------------------------------- gen-rewrites! [22] 100.0% [29] 320(2.0%) 0(0.0%) for-loop .../herbie/master/src/mainloop.rkt:191:11 rewrite-expression-head24 [37] 100.0% ----------------------------------------------------------------------- simplify! [23] 100.0% [30] 316(2.0%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:42:0 egraph-run [38] 100.0% ----------------------------------------------------------------------- ??? [24] 100.0% [31] 224(1.4%) 224(1.4%) ulp-difference ...herbie/master/src/float.rkt:19:0 ----------------------------------------------------------------------- localize! [25] 100.0% [32] 222(1.4%) 0(0.0%) localize-error ...aster/src/core/localize.rkt:58:0 hash-ref! [35] 100.0% ----------------------------------------------------------------------- finalize-iter! [26] 100.0% [33] 200(1.3%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [39] 100.0% ----------------------------------------------------------------------- loop [27] 100.0% [34] 10426(65.7%) 242(1.5%) composed ...ollects/racket/private/list.rkt:321:16 ??? [40] 91.0% ??? [62] 6.6% ----------------------------------------------------------------------- localize-error [32] 1.1% map [19] 5.3% eval-prog [28] 17.2% loop [27] 76.5% [35] 3500(22.1%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 76.5% bigfloat-hash [41] 17.2% parse-loop15 [45] 6.3% ----------------------------------------------------------------------- loop [27] 100.0% [36] 422(2.7%) 0(0.0%) gf (unknown source) propagation-apply [42] 100.0% ----------------------------------------------------------------------- for-loop [29] 100.0% [37] 320(2.0%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [43] 100.0% ----------------------------------------------------------------------- ??? [30] 100.0% [38] 316(2.0%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [44] 100.0% ----------------------------------------------------------------------- ??? [33] 100.0% [39] 200(1.3%) 0(0.0%) for-loop ...bie/master/src/core/alt-table.rkt:46:2 atab-add-altn [46] 100.0% ----------------------------------------------------------------------- composed [34] 100.0% [40] 9492(59.9%) 232(1.5%) ??? ...tract/private/arrow-higher-order.rkt:379:33 bf-complex-mult [47] 83.6% bf-complex-add [49] 13.9% ----------------------------------------------------------------------- hash-ref! [35] 100.0% [41] 3278(20.7%) 224(1.4%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:168:0 bfcanonicalize [48] 86.5% sig+exp->bigfloat [54] 6.7% ----------------------------------------------------------------------- gf [36] 100.0% [42] 422(2.7%) 422(2.7%) propagation-apply (unknown source) ----------------------------------------------------------------------- matcher [58] 50.0% rewrite-expression-head24 [37] 50.0% [43] 320(2.0%) 0(0.0%) rewriter ...erbie/master/src/core/matcher.rkt:87:2 for-loop [51] 100.0% ----------------------------------------------------------------------- egraph-run [38] 100.0% [44] 316(2.0%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [52] 100.0% ----------------------------------------------------------------------- hash-ref! [35] 100.0% [45] 222(1.4%) 0(0.0%) parse-loop15 (unknown source) map [19] 83.3% for-loop [53] 16.7% ----------------------------------------------------------------------- for-loop [39] 100.0% [46] 200(1.3%) 0(0.0%) atab-add-altn ...ster/src/core/alt-table.rkt:194:0 errors [50] 100.0% ----------------------------------------------------------------------- ??? [40] 100.0% [47] 7938(50.1%) 900(5.7%) bf-complex-mult .../master/src/bigcomplex.rkt:30:0 bf* [55] 68.6% ??? [62] 20.1% ----------------------------------------------------------------------- bigfloat-hash [41] 100.0% [48] 2836(17.9%) 2636(16.6%) bfcanonicalize .../private/bigfloat/mpfr.rkt:158:0 bigfloat->sig+exp [61] 7.1% ----------------------------------------------------------------------- ??? [40] 100.0% [49] 1322(8.3%) 0(0.0%) bf-complex-add ...e/master/src/bigcomplex.rkt:23:0 ??? [62] 100.0% ----------------------------------------------------------------------- atab-add-altn [46] 30.9% .../more-scheme.rkt:261:28 [11] 69.1% [50] 648(4.1%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:190:0 for-loop [56] 69.1% temp85_0 [57] 30.9% ----------------------------------------------------------------------- rewriter [43] 100.0% [51] 320(2.0%) 0(0.0%) for-loop ...erbie/master/src/core/matcher.rkt:89:4 matcher [58] 100.0% ----------------------------------------------------------------------- egraph-add-exprs [44] 100.0% [52] 316(2.0%) 0(0.0%) ??? ...s/herbie/master/src/core/simplify.rkt:102:6 for-loop [59] 100.0% ----------------------------------------------------------------------- parse-loop15 [45] 100.0% [53] 222(1.4%) 0(0.0%) for-loop ...bie/master/src/core/localize.rkt:45:21 for-loop [60] 100.0% ----------------------------------------------------------------------- bigfloat-hash [41] 100.0% [54] 218(1.4%) 0(0.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:401:0 new-mpfr [69] 100.0% ----------------------------------------------------------------------- bf-complex-mult [47] 100.0% [55] 5446(34.3%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [62] 100.0% ----------------------------------------------------------------------- errors [50] 100.0% [56] 448(2.8%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [11] 100.0% ----------------------------------------------------------------------- errors [50] 47.4% make-exacts-walkup [20] 52.6% [57] 422(2.7%) 0(0.0%) temp85_0 (unknown source) compile15 [63] 100.0% ----------------------------------------------------------------------- for-loop [9] 50.0% for-loop [51] 50.0% [58] 320(2.0%) 0(0.0%) matcher ...erbie/master/src/core/matcher.rkt:115:2 ??? [3] 75.0% rewriter [43] 25.0% ----------------------------------------------------------------------- ??? [52] 100.0% [59] 316(2.0%) 316(2.0%) for-loop ...bie/master/src/core/simplify.rkt:121:2 ----------------------------------------------------------------------- for-loop [53] 100.0% [60] 222(1.4%) 0(0.0%) for-loop ...bie/master/src/core/localize.rkt:46:23 ??? [64] 100.0% ----------------------------------------------------------------------- bfcanonicalize [48] 100.0% [61] 200(1.3%) 0(0.0%) bigfloat->sig+exp ...ivate/bigfloat/mpfr.rkt:386:0 size+limbs->integer [65] 100.0% ----------------------------------------------------------------------- composed [34] 7.6% bf-complex-add [49] 14.6% bf-complex-mult [47] 17.6% bf* [55] 60.2% [62] 9052(57.1%) 2772(17.5%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfadd [66] 66.7% bfneg [68] 2.7% ----------------------------------------------------------------------- temp85_0 [57] 100.0% [63] 422(2.7%) 0(0.0%) compile15 (unknown source) temp91_0 [67] 100.0% ----------------------------------------------------------------------- for-loop [60] 100.0% [64] 222(1.4%) 222(1.4%) ??? ...htlies/herbie/master/src/interface.rkt:82:2 ----------------------------------------------------------------------- bigfloat->sig+exp [61] 100.0% [65] 200(1.3%) 200(1.3%) size+limbs->integer ...vate/bigfloat/gmp.rkt:103:0 ----------------------------------------------------------------------- ??? [62] 100.0% [66] 6034(38.1%) 240(1.5%) bfadd ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [69] 55.3% ??? [70] 40.8% ----------------------------------------------------------------------- compile15 [63] 100.0% [67] 422(2.7%) 0(0.0%) temp91_0 (unknown source) temp118_0 [71] 100.0% ----------------------------------------------------------------------- ??? [62] 100.0% [68] 246(1.6%) 0(0.0%) bfneg ...-lib/math/private/bigfloat/mpfr.rkt:632:4 new-mpfr [69] 100.0% ----------------------------------------------------------------------- sig+exp->bigfloat [54] 5.7% bfneg [68] 6.5% bfadd [66] 87.8% [69] 3798(24.0%) 3798(24.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ----------------------------------------------------------------------- bfadd [66] 100.0% [70] 2460(15.5%) 2460(15.5%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ----------------------------------------------------------------------- temp91_0 [67] 100.0% [71] 422(2.7%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [72] 100.0% ----------------------------------------------------------------------- temp118_0 [71] 100.0% [72] 422(2.7%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [73] 100.0% ----------------------------------------------------------------------- expand-capturing-lifts [72] 100.0% [73] 422(2.7%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [74] 100.0% ----------------------------------------------------------------------- lambda-clause-expander [73] 3.6% for-loop [75] 96.4% [74] 422(2.7%) 0(0.0%) finish-bodys (unknown source) for-loop [75] 100.0% ----------------------------------------------------------------------- for-loop [75] 5.1% finish-bodys [74] 94.9% [75] 422(2.7%) 0(0.0%) for-loop (unknown source) finish-bodys [74] 91.4% for-loop [75] 5.1% loop [27] 1.8% syntax-e [4] 1.6% -----------------------------------------------------------------------