Profiling results ----------------- Total cpu time observed: 8914ms (out of 8448ms) Number of samples taken: 20 (once every 446ms) ===================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ===================================================================== ??? [9] 100.0% [1] 8914(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% --------------------------------------------------------------------- ??? [9] 100.0% [2] 5072(56.9%) 0(0.0%) prepare-points-intervals ...k/src/points.rkt:133:0 loop [6] 93.3% eval-prog [8] 6.7% --------------------------------------------------------------------- ??? [9] 100.0% [3] 2004(22.5%) 0(0.0%) oracle-error ...implify-tweak/src/points.rkt:212:0 for-loop [7] 100.0% --------------------------------------------------------------------- hash-ref! [16] 100.0% [4] 338(3.8%) 0(0.0%) ??? ...erbie/simplify-tweak/src/programs.rkt:189:5 loop [11] 100.0% --------------------------------------------------------------------- profile-thunk16 [1] 100.0% [5] 8914(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [9] 100.0% --------------------------------------------------------------------- prepare-points-intervals [2] 100.0% [6] 4734(53.1%) 0(0.0%) loop ...herbie/simplify-tweak/src/points.rkt:145:4 loop [10] 100.0% --------------------------------------------------------------------- oracle-error [3] 100.0% [7] 2004(22.5%) 0(0.0%) for-loop ...ie/simplify-tweak/src/points.rkt:213:2 loop [11] 100.0% --------------------------------------------------------------------- prepare-points-intervals [2] 100.0% [8] 338(3.8%) 0(0.0%) eval-prog ...simplify-tweak/src/programs.rkt:130:0 hash-ref! [16] 100.0% --------------------------------------------------------------------- run [5] 50.0% [9] 8914(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 50.0% prepare-points-intervals [2] 28.4% oracle-error [3] 11.2% eval-errors [14] 6.4% run-improve40 [15] 2.0% errors [17] 1.9% --------------------------------------------------------------------- loop [6] 100.0% [10] 4734(53.1%) 314(3.5%) loop ...herbie/simplify-tweak/src/points.rkt:104:2 ??? [12] 87.2% ??? [24] 6.1% --------------------------------------------------------------------- ??? [4] 14.4% for-loop [7] 85.6% [11] 2342(26.3%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 point-error [13] 85.6% hash-ref! [16] 14.4% --------------------------------------------------------------------- loop [10] 100.0% [12] 4130(46.3%) 0(0.0%) ??? ...erbie/simplify-tweak/src/programs.rkt:146:2 ??? [18] 100.0% --------------------------------------------------------------------- loop [11] 100.0% [13] 2004(22.5%) 0(0.0%) point-error ...simplify-tweak/src/points.rkt:195:0 ulp-difference [23] 100.0% --------------------------------------------------------------------- ??? [9] 100.0% [14] 1148(12.9%) 0(0.0%) eval-errors ...simplify-tweak/src/points.rkt:203:0 for-loop [19] 100.0% --------------------------------------------------------------------- ??? [9] 100.0% [15] 360(4.0%) 0(0.0%) run-improve40 ...lify-tweak/src/mainloop.rkt:340:0 simplify! [20] 100.0% --------------------------------------------------------------------- loop [11] 50.0% eval-prog [8] 50.0% [16] 338(3.8%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [4] 50.0% bigfloat-hash [21] 50.0% --------------------------------------------------------------------- ??? [9] 100.0% [17] 330(3.7%) 0(0.0%) errors ...rbie/simplify-tweak/src/points.rkt:228:0 for-loop [22] 100.0% --------------------------------------------------------------------- ??? [12] 100.0% [18] 4130(46.3%) 0(0.0%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 ??? [24] 56.4% ??? [25] 43.6% --------------------------------------------------------------------- eval-errors [14] 100.0% [19] 1148(12.9%) 0(0.0%) for-loop ...ie/simplify-tweak/src/points.rkt:205:2 ulp-difference [23] 100.0% --------------------------------------------------------------------- run-improve40 [15] 100.0% [20] 360(4.0%) 0(0.0%) simplify! ...simplify-tweak/src/mainloop.rkt:217:0 ??? [26] 100.0% --------------------------------------------------------------------- hash-ref! [16] 100.0% [21] 338(3.8%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bfcanonicalize [27] 100.0% --------------------------------------------------------------------- errors [17] 100.0% [22] 330(3.7%) 330(3.7%) for-loop ...ie/simplify-tweak/src/points.rkt:230:2 --------------------------------------------------------------------- for-loop [19] 36.4% point-error [13] 63.6% [23] 3152(35.4%) 1148(12.9%) ulp-difference ...implify-tweak/src/float.rkt:14:0 return/no-unsupplied [29] 63.6% --------------------------------------------------------------------- loop [10] 11.1% ??? [18] 88.9% [24] 2618(29.4%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:357:33 ival-mult [28] 88.9% ->flonum [33] 11.1% --------------------------------------------------------------------- fold-binary-pred [38] 8.5% ??? [18] 91.5% [25] 1802(20.2%) 306(3.4%) ??? ...tract/private/arrow-higher-order.rkt:361:33 ival-add [31] 49.4% ival-div [30] 42.1% --------------------------------------------------------------------- simplify! [20] 100.0% [26] 360(4.0%) 0(0.0%) ??? ...e/simplify-tweak/src/core/simplify.rkt:26:0 one-iter [32] 100.0% --------------------------------------------------------------------- bigfloat-hash [21] 100.0% [27] 338(3.8%) 338(3.8%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 --------------------------------------------------------------------- ??? [24] 100.0% [28] 2328(26.1%) 0(0.0%) ival-mult ...plify-tweak/src/biginterval.rkt:105:0 classify-ival [34] 44.8% bf* [35] 41.2% ...higher-order.rkt:361:33 [37] 14.0% --------------------------------------------------------------------- ulp-difference [23] 100.0% [29] 2004(22.5%) 2004(22.5%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 --------------------------------------------------------------------- ??? [25] 100.0% [30] 912(10.2%) 0(0.0%) ival-div ...mplify-tweak/src/biginterval.rkt:141:0 ??? [39] 66.4% fold-binary-pred [38] 33.6% --------------------------------------------------------------------- ??? [25] 100.0% [31] 890(10.0%) 0(0.0%) ival-add ...implify-tweak/src/biginterval.rkt:87:0 ??? [39] 100.0% --------------------------------------------------------------------- ??? [26] 100.0% [32] 360(4.0%) 0(0.0%) one-iter ...plify-tweak/src/core/simplify.rkt:86:0 for-loop [36] 100.0% --------------------------------------------------------------------- ??? [24] 100.0% [33] 290(3.3%) 290(3.3%) ->flonum ...e/simplify-tweak/src/programs.rkt:38:0 --------------------------------------------------------------------- ival-mult [28] 100.0% [34] 1042(11.7%) 1042(11.7%) classify-ival ...y-tweak/src/biginterval.rkt:310:0 --------------------------------------------------------------------- ival-mult [28] 100.0% [35] 960(10.8%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [39] 100.0% --------------------------------------------------------------------- one-iter [32] 100.0% [36] 360(4.0%) 0(0.0%) for-loop ...plify-tweak/src/core/simplify.rkt:95:2 apply-match [40] 100.0% --------------------------------------------------------------------- ival-mult [28] 100.0% [37] 326(3.7%) 326(3.7%) ...higher-order.rkt:361:33 (unknown source) --------------------------------------------------------------------- ival-div [30] 100.0% [38] 306(3.4%) 0(0.0%) fold-binary-pred ...gfloat/bigfloat-mpfr.rkt:117:0 ??? [25] 100.0% --------------------------------------------------------------------- ival-div [30] 24.7% ival-add [31] 36.2% bf* [35] 39.1% [39] 2456(27.6%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [41] 100.0% --------------------------------------------------------------------- for-loop [36] 100.0% [40] 360(4.0%) 0(0.0%) apply-match ...fy-tweak/src/core/simplify.rkt:65:0 for-loop [42] 100.0% --------------------------------------------------------------------- ??? [39] 100.0% [41] 2456(27.6%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 ??? [43] 62.6% new-mpfr [44] 37.4% --------------------------------------------------------------------- apply-match [40] 100.0% [42] 360(4.0%) 0(0.0%) for-loop ...plify-tweak/src/core/simplify.rkt:78:2 merge-egraph-nodes! [45] 100.0% --------------------------------------------------------------------- bfmul [41] 100.0% [43] 1538(17.3%) 1538(17.3%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 --------------------------------------------------------------------- bfmul [41] 100.0% [44] 918(10.3%) 918(10.3%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 --------------------------------------------------------------------- for-loop [42] 100.0% [45] 360(4.0%) 0(0.0%) merge-egraph-nodes! ...k/src/core/egraph.rkt:145:0 update-leader! [46] 100.0% --------------------------------------------------------------------- merge-egraph-nodes! [45] 100.0% [46] 360(4.0%) 0(0.0%) update-leader! ...-tweak/src/core/egraph.rkt:213:0 for-loop [47] 100.0% --------------------------------------------------------------------- update-leader! [46] 100.0% [47] 360(4.0%) 0(0.0%) for-loop ...mplify-tweak/src/core/egraph.rkt:218:6 for-loop [48] 100.0% --------------------------------------------------------------------- for-loop [47] 100.0% [48] 360(4.0%) 0(0.0%) for-loop ...mplify-tweak/src/core/egraph.rkt:219:8 hash-update! [49] 100.0% --------------------------------------------------------------------- for-loop [48] 100.0% [49] 360(4.0%) 0(0.0%) hash-update! ...cket/private/more-scheme.rkt:365:4 ??? [50] 100.0% --------------------------------------------------------------------- hash-update! [49] 100.0% [50] 360(4.0%) 0(0.0%) ??? ...e/simplify-tweak/src/core/egraph.rkt:221:24 update-en-expr [51] 100.0% --------------------------------------------------------------------- ??? [50] 100.0% [51] 360(4.0%) 360(4.0%) update-en-expr ...-tweak/src/core/egraph.rkt:207:0 ---------------------------------------------------------------------