Profiling results ----------------- Total cpu time observed: 6626ms (out of 6800ms) Number of samples taken: 33 (once every 201ms) ============================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ============================================================================= [1] 6626(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [6] 100.0% ----------------------------------------------------------------------------- hash-ref! [79] 100.0% [2] 192(2.9%) 0(0.0%) ??? ...rds-no-duplicates/src/core/taylor.rkt:67:15 hash-ref! [79] 50.0% ??? [66] 50.0% ----------------------------------------------------------------------------- ??? [66] 100.0% [3] 192(2.9%) 0(0.0%) approximate9 ...uplicates/src/core/taylor.rkt:11:0 loop [7] 100.0% ----------------------------------------------------------------------------- hash-ref! [79] 100.0% [4] 192(2.9%) 0(0.0%) f61 (unknown source) eval-const-expr [8] 100.0% ----------------------------------------------------------------------------- for-loop [40] 100.0% [5] 192(2.9%) 0(0.0%) expand-implicit (unknown source) resolve+shift28 [9] 100.0% ----------------------------------------------------------------------------- ??? [1] 100.0% [6] 6626(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [10] 100.0% ----------------------------------------------------------------------------- approximate9 [3] 100.0% [7] 192(2.9%) 0(0.0%) loop ...rds-no-duplicates/src/core/taylor.rkt:86:4 hash-ref! [79] 100.0% ----------------------------------------------------------------------------- f61 [4] 100.0% [8] 192(2.9%) 0(0.0%) eval-const-expr ...plicates/src/programs.rkt:120:0 temp85_0 [11] 100.0% ----------------------------------------------------------------------------- expand-implicit [5] 100.0% [9] 192(2.9%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [12] 100.0% ----------------------------------------------------------------------------- profile-thunk16 [6] 100.0% [10] 6626(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [13] 100.0% ----------------------------------------------------------------------------- eval-const-expr [8] 100.0% [11] 192(2.9%) 0(0.0%) temp85_0 (unknown source) compile15 [14] 100.0% ----------------------------------------------------------------------------- resolve+shift28 [9] 100.0% [12] 192(2.9%) 0(0.0%) fallback-loop (unknown source) for-loop [40] 100.0% ----------------------------------------------------------------------------- for-loop [22] 3.0% run [10] 97.0% [13] 6626(100.0%) 396(6.0%) .../more-scheme.rkt:261:28 (unknown source) run-improve47 [15] 60.6% prepare-points-intervals [16] 30.4% oracle-error [18] 3.0% errors [17] 3.0% ----------------------------------------------------------------------------- temp85_0 [11] 100.0% [14] 192(2.9%) 0(0.0%) compile15 (unknown source) temp91_0 [19] 100.0% ----------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 100.0% [15] 4014(60.6%) 0(0.0%) run-improve47 ...duplicates/src/mainloop.rkt:346:0 for-loop [20] 100.0% ----------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 100.0% [16] 2016(30.4%) 0(0.0%) prepare-points-intervals ...s/src/points.rkt:120:0 loop [21] 100.0% ----------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 100.0% [17] 396(6.0%) 0(0.0%) errors ...wards-no-duplicates/src/points.rkt:190:0 for-loop [22] 100.0% ----------------------------------------------------------------------------- .../more-scheme.rkt:261:28 [13] 100.0% [18] 200(3.0%) 0(0.0%) oracle-error ...no-duplicates/src/points.rkt:177:0 for-loop [23] 100.0% ----------------------------------------------------------------------------- compile15 [14] 100.0% [19] 192(2.9%) 0(0.0%) temp91_0 (unknown source) temp118_0 [24] 100.0% ----------------------------------------------------------------------------- run-improve47 [15] 100.0% [20] 4014(60.6%) 0(0.0%) for-loop ...s-no-duplicates/src/mainloop.rkt:365:4 run-iter! [25] 100.0% ----------------------------------------------------------------------------- prepare-points-intervals [16] 100.0% [21] 2016(30.4%) 0(0.0%) loop ...upwards-no-duplicates/src/points.rkt:132:4 loop [26] 70.0% ??? [27] 19.9% andmap [28] 10.0% ----------------------------------------------------------------------------- errors [17] 100.0% [22] 396(6.0%) 0(0.0%) for-loop ...rds-no-duplicates/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [13] 100.0% ----------------------------------------------------------------------------- oracle-error [18] 100.0% [23] 200(3.0%) 0(0.0%) for-loop ...rds-no-duplicates/src/points.rkt:178:2 loop [61] 100.0% ----------------------------------------------------------------------------- temp91_0 [19] 100.0% [24] 192(2.9%) 0(0.0%) temp118_0 (unknown source) expand-capturing-lifts [29] 100.0% ----------------------------------------------------------------------------- for-loop [20] 100.0% [25] 4014(60.6%) 0(0.0%) run-iter! ...-no-duplicates/src/mainloop.rkt:327:0 simplify! [30] 95.2% gen-series! [34] 4.8% ----------------------------------------------------------------------------- loop [21] 100.0% [26] 1412(21.3%) 206(3.1%) loop ...-upwards-no-duplicates/src/points.rkt:79:2 ??? [31] 28.8% real->precision [32] 28.5% ??? [66] 28.2% ----------------------------------------------------------------------------- loop [21] 100.0% [27] 402(6.1%) 0(0.0%) ??? ...-upwards-no-duplicates/src/points.rkt:113:6 sample-multi-bounded [68] 50.2% loop [61] 49.8% ----------------------------------------------------------------------------- loop [21] 100.0% [28] 202(3.0%) 202(3.0%) andmap ...5/collects/racket/private/map.rkt:102:13 ----------------------------------------------------------------------------- temp118_0 [24] 100.0% [29] 192(2.9%) 0(0.0%) expand-capturing-lifts (unknown source) lambda-clause-expander [33] 100.0% ----------------------------------------------------------------------------- run-iter! [25] 100.0% [30] 3822(57.7%) 0(0.0%) simplify! ...-no-duplicates/src/mainloop.rkt:224:0 ??? [35] 100.0% ----------------------------------------------------------------------------- loop [26] 100.0% [31] 406(6.1%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-add [36] 100.0% ----------------------------------------------------------------------------- loop [26] 100.0% [32] 402(6.1%) 0(0.0%) real->precision ...plicates/src/programs.rkt:94:11 ??? [66] 100.0% ----------------------------------------------------------------------------- expand-capturing-lifts [29] 100.0% [33] 192(2.9%) 0(0.0%) lambda-clause-expander (unknown source) finish-bodys [37] 100.0% ----------------------------------------------------------------------------- run-iter! [25] 100.0% [34] 192(2.9%) 0(0.0%) gen-series! ...o-duplicates/src/mainloop.rkt:160:0 for-loop [38] 100.0% ----------------------------------------------------------------------------- simplify! [30] 100.0% [35] 3822(57.7%) 0(0.0%) ??? ...ds-no-duplicates/src/core/simplify.rkt:38:0 ??? [39] 100.0% ----------------------------------------------------------------------------- ??? [31] 100.0% [36] 406(6.1%) 206(3.1%) ival-add ...o-duplicates/src/biginterval.rkt:102:0 bfmul [80] 49.3% ----------------------------------------------------------------------------- lambda-clause-expander [33] 12.5% for-loop [40] 87.5% [37] 192(2.9%) 0(0.0%) finish-bodys (unknown source) for-loop [40] 100.0% ----------------------------------------------------------------------------- gen-series! [34] 100.0% [38] 192(2.9%) 0(0.0%) for-loop ...s-no-duplicates/src/mainloop.rkt:167:7 taylor-alt [41] 100.0% ----------------------------------------------------------------------------- ??? [35] 100.0% [39] 3822(57.7%) 0(0.0%) ??? ...ds-no-duplicates/src/core/simplify.rkt:56:0 for-loop [42] 100.0% ----------------------------------------------------------------------------- fallback-loop [12] 9.1% for-loop [40] 18.2% finish-bodys [37] 72.7% [40] 192(2.9%) 192(2.9%) for-loop (unknown source) finish-bodys [37] 63.6% for-loop [40] 18.2% expand-implicit [5] 9.1% ----------------------------------------------------------------------------- for-loop [38] 100.0% [41] 192(2.9%) 0(0.0%) taylor-alt ...no-duplicates/src/mainloop.rkt:146:0 for-loop [43] 100.0% ----------------------------------------------------------------------------- ??? [39] 100.0% [42] 3822(57.7%) 0(0.0%) for-loop ...-duplicates/src/core/simplify.rkt:76:2 for-loop [44] 100.0% ----------------------------------------------------------------------------- taylor-alt [41] 100.0% [43] 192(2.9%) 0(0.0%) for-loop ...s-no-duplicates/src/mainloop.rkt:152:6 ??? [66] 100.0% ----------------------------------------------------------------------------- for-loop [42] 100.0% [44] 3822(57.7%) 0(0.0%) for-loop ...-duplicates/src/core/simplify.rkt:80:4 ??? [45] 94.8% loop [46] 5.2% ----------------------------------------------------------------------------- for-loop [44] 100.0% [45] 3624(54.7%) 0(0.0%) ??? ...upwards-no-duplicates/regraph/main.rkt:44:0 find-matches [47] 61.0% for-loop [48] 39.0% ----------------------------------------------------------------------------- for-loop [44] 100.0% [46] 198(3.0%) 0(0.0%) loop ...-no-duplicates/regraph/extraction.rkt:25:2 for-loop [49] 100.0% ----------------------------------------------------------------------------- ??? [45] 100.0% [47] 2212(33.4%) 0(0.0%) find-matches ...o-duplicates/regraph/main.rkt:36:0 for-loop [50] 100.0% ----------------------------------------------------------------------------- ??? [45] 100.0% [48] 1412(21.3%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:47:2 for-loop [51] 100.0% ----------------------------------------------------------------------------- loop [46] 100.0% [49] 198(3.0%) 198(3.0%) for-loop ...duplicates/regraph/extraction.rkt:28:4 ----------------------------------------------------------------------------- for-loop [50] 45.5% find-matches [47] 54.5% [50] 2212(33.4%) 200(3.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:38:2 for-loop [50] 45.5% match-e [52] 45.5% ----------------------------------------------------------------------------- for-loop [48] 100.0% [51] 1412(21.3%) 0(0.0%) for-loop ...ds-no-duplicates/regraph/main.rkt:50:4 merge-egraph-nodes! [53] 42.6% mk-enode-rec! [67] 28.8% substitute-e [54] 28.6% ----------------------------------------------------------------------------- for-loop [60] 30.0% for-loop [50] 70.0% [52] 2012(30.4%) 200(3.0%) match-e ...s-no-duplicates/regraph/ematch.rkt:35:0 for-loop [55] 80.1% custom-in-set [57] 9.9% ----------------------------------------------------------------------------- for-loop [51] 100.0% [53] 602(9.1%) 0(0.0%) merge-egraph-nodes! ...es/regraph/egraph.rkt:144:0 enode-merge! [56] 33.6% update-leader! [59] 33.2% loop! [58] 33.2% ----------------------------------------------------------------------------- substitute-e [54] 25.0% for-loop [51] 75.0% [54] 404(6.1%) 202(3.0%) substitute-e ...duplicates/regraph/ematch.rkt:55:0 do-curry [62] 50.0% substitute-e [54] 25.0% ----------------------------------------------------------------------------- match-e [52] 100.0% [55] 1612(24.3%) 800(12.1%) for-loop ...no-duplicates/regraph/ematch.rkt:41:11 for-loop [60] 37.4% loop [61] 25.2% procedure-reduce-keyword-arity-mask [64] 6.4% do-curry [62] 6.2% ----------------------------------------------------------------------------- merge-egraph-nodes! [53] 100.0% [56] 202(3.0%) 0(0.0%) enode-merge! ...-duplicates/regraph/enode.rkt:95:0 custom-set-union [63] 100.0% ----------------------------------------------------------------------------- match-e [52] 100.0% [57] 200(3.0%) 200(3.0%) custom-in-set ...acket/private/set-types.rkt:578:0 ----------------------------------------------------------------------------- merge-egraph-nodes! [53] 100.0% [58] 200(3.0%) 0(0.0%) loop! ...rds-no-duplicates/regraph/enode.rkt:158:2 custom-set-union [63] 100.0% ----------------------------------------------------------------------------- merge-egraph-nodes! [53] 100.0% [59] 200(3.0%) 0(0.0%) update-leader! ...licates/regraph/egraph.rkt:213:0 for-loop [65] 100.0% ----------------------------------------------------------------------------- for-loop [55] 100.0% [60] 1206(18.2%) 0(0.0%) for-loop ...no-duplicates/regraph/ematch.rkt:47:37 match-e [52] 100.0% ----------------------------------------------------------------------------- for-loop [55] 0.4% ??? [27] 19.8% for-loop [23] 19.8% mk-enode-rec! [67] 20.4% loop [61] 39.7% [61] 1012(15.3%) 206(3.1%) loop (unknown source) loop [61] 39.7% mk-enode-rec! [67] 20.4% ??? [66] 19.8% sample-multi-bounded [68] 19.8% foldl [69] 0.1% ----------------------------------------------------------------------------- for-loop [55] 49.8% substitute-e [54] 50.2% [62] 402(6.1%) 402(6.1%) do-curry ...-7.5/collects/racket/function.rkt:71:2 ----------------------------------------------------------------------------- loop! [58] 49.8% enode-merge! [56] 50.2% [63] 402(6.1%) 402(6.1%) custom-set-union ...et/private/set-types.rkt:168:0 ----------------------------------------------------------------------------- for-loop [55] 100.0% [64] 206(3.1%) 206(3.1%) procedure-reduce-keyword-arity-mask ....rkt:1597:4 ----------------------------------------------------------------------------- update-leader! [59] 100.0% [65] 200(3.0%) 0(0.0%) for-loop ...no-duplicates/regraph/egraph.rkt:218:6 hash-update! [70] 100.0% ----------------------------------------------------------------------------- ??? [2] 5.4% location-do [78] 5.4% for-loop [43] 5.4% loop [61] 16.8% loop [26] 33.4% real->precision [32] 33.7% [66] 1192(18.0%) 402(6.1%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-mult [72] 33.4% bf [76] 16.8% location-do [78] 5.4% approximate9 [3] 5.4% hash-ref! [79] 5.4% ----------------------------------------------------------------------------- loop [61] 25.4% for-loop [51] 74.6% [67] 406(6.1%) 0(0.0%) mk-enode-rec! ...plicates/regraph/egraph.rkt:116:0 for-loop [74] 49.3% loop [61] 25.4% hash-has-key? [73] 25.4% ----------------------------------------------------------------------------- loop [61] 49.8% ??? [27] 50.2% [68] 402(6.1%) 0(0.0%) sample-multi-bounded ...icates/src/points.rkt:14:0 random-ranges [71] 100.0% ----------------------------------------------------------------------------- loop [61] 100.0% [69] 200(3.0%) 0(0.0%) foldl ....5/collects/racket/private/list.rkt:229:4 merge2 [75] 100.0% ----------------------------------------------------------------------------- for-loop [65] 100.0% [70] 200(3.0%) 0(0.0%) hash-update! ...cket/private/more-scheme.rkt:365:4 ??? [77] 100.0% ----------------------------------------------------------------------------- sample-multi-bounded [68] 100.0% [71] 402(6.1%) 200(3.0%) random-ranges ...o-duplicates/src/common.rkt:164:0 cons/c [81] 50.2% ----------------------------------------------------------------------------- ??? [66] 100.0% [72] 398(6.0%) 200(3.0%) ival-mult ...-duplicates/src/biginterval.rkt:120:0 bfmul [80] 49.7% ----------------------------------------------------------------------------- mk-enode-rec! [67] 100.0% [73] 206(3.1%) 206(3.1%) hash-has-key? ...ket/private/more-scheme.rkt:371:2 ----------------------------------------------------------------------------- mk-enode-rec! [67] 100.0% [74] 200(3.0%) 200(3.0%) for-loop ...o-duplicates/regraph/egraph.rkt:108:10 ----------------------------------------------------------------------------- foldl [69] 100.0% [75] 200(3.0%) 200(3.0%) merge2 ...ds-no-duplicates/regraph/ematch.rkt:20:0 ----------------------------------------------------------------------------- ??? [66] 100.0% [76] 200(3.0%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 ??? [82] 100.0% ----------------------------------------------------------------------------- hash-update! [70] 100.0% [77] 200(3.0%) 0(0.0%) ??? ...rds-no-duplicates/regraph/egraph.rkt:221:24 for-loop [83] 100.0% ----------------------------------------------------------------------------- ??? [66] 100.0% [78] 192(2.9%) 0(0.0%) location-do ...no-duplicates/src/programs.rkt:63:0 ??? [66] 100.0% ----------------------------------------------------------------------------- ??? [84] 25.0% ??? [66] 25.0% ??? [2] 25.0% loop [7] 25.0% [79] 192(2.9%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 50.0% ??? [84] 25.0% f61 [4] 25.0% ----------------------------------------------------------------------------- ival-mult [72] 49.7% ival-add [36] 50.3% [80] 398(6.0%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [85] 100.0% ----------------------------------------------------------------------------- random-ranges [71] 100.0% [81] 202(3.0%) 0(0.0%) cons/c .../racket/contract/private/guts.rkt:500:15 coerce-contract [86] 100.0% ----------------------------------------------------------------------------- bf [76] 100.0% [82] 200(3.0%) 200(3.0%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 ----------------------------------------------------------------------------- ??? [77] 100.0% [83] 200(3.0%) 200(3.0%) for-loop ...o-duplicates/regraph/egraph.rkt:222:26 ----------------------------------------------------------------------------- hash-ref! [79] 100.0% [84] 192(2.9%) 0(0.0%) ??? ...rds-no-duplicates/src/core/taylor.rkt:44:15 hash-ref! [79] 100.0% ----------------------------------------------------------------------------- bfmul [80] 100.0% [85] 398(6.0%) 398(6.0%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 ----------------------------------------------------------------------------- cons/c [81] 100.0% [86] 202(3.0%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [87] 100.0% ----------------------------------------------------------------------------- coerce-contract [86] 100.0% [87] 202(3.0%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [88] 100.0% ----------------------------------------------------------------------------- coerce-contract/f [87] 100.0% [88] 202(3.0%) 202(3.0%) coerce-simple-value ...ract/private/guts.rkt:385:0 -----------------------------------------------------------------------------