Profiling results ----------------- Total cpu time observed: 34534ms (out of 35448ms) Number of samples taken: 84 (once every 411ms) (Hiding functions with self<1.0% and local<2.0%: 1 of 71 hidden) ======================================================================= Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ======================================================================= run [7] 49.6% [1] 34238(99.1%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [4] 49.6% loop [8] 47.1% run-improve50 [6] 3.4% ----------------------------------------------------------------------- map [23] 1.1% loop [30] 98.9% [2] 27568(79.8%) 746(2.2%) ??? ...tlies/herbie/develop/src/programs.rkt:154:4 ??? [5] 62.6% ??? [34] 34.7% ----------------------------------------------------------------------- loop [30] 100.0% [3] 328(0.9%) 0(0.0%) ??? ...ket/collects/racket/private/list.rkt:323:18 hash-ref! [25] 100.0% ----------------------------------------------------------------------- ??? [1] 100.0% [4] 33938(98.3%) 0(0.0%) profile-thunk16 ...t/pkgs/profile-lib/main.rkt:9:0 run [7] 100.0% ----------------------------------------------------------------------- ??? [2] 100.0% [5] 17258(50.0%) 3718(10.8%) ??? ...acket/collects/racket/private/kw.rkt:444:14 ??? [32] 53.4% bf* [9] 15.0% ...higher-order.rkt:346:33 [10] 5.9% ??? [12] 2.1% parse-loop12 [27] 2.0% ----------------------------------------------------------------------- ??? [1] 100.0% [6] 2308(6.7%) 0(0.0%) run-improve50 ...ie/develop/src/mainloop.rkt:234:0 loop [8] 43.1% setup-alt-simplified [11] 42.7% for-loop [13] 14.2% ----------------------------------------------------------------------- profile-thunk16 [4] 100.0% [7] 33938(98.3%) 0(0.0%) run ...share/racket/pkgs/profile-lib/main.rkt:39:2 ??? [1] 100.0% ----------------------------------------------------------------------- run-improve50 [6] 3.0% ??? [1] 97.0% [8] 32924(95.3%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:193:2 make-exacts* [19] 43.7% loop [14] 35.4% loop [20] 18.7% for-loop [16] 2.2% ----------------------------------------------------------------------- ??? [5] 100.0% [9] 2590(7.5%) 352(1.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [32] 86.4% ----------------------------------------------------------------------- ??? [5] 100.0% [10] 1024(3.0%) 648(1.9%) ...higher-order.rkt:346:33 (unknown source) ??? [64] 36.7% ----------------------------------------------------------------------- run-improve50 [6] 100.0% [11] 986(2.9%) 0(0.0%) setup-alt-simplified .../develop/src/glue.rkt:49:0 simplify-alt [15] 100.0% ----------------------------------------------------------------------- ??? [5] 100.0% [12] 360(1.0%) 0(0.0%) ??? ...ects/racket/contract/private/prop.rkt:493:4 ??? [17] 100.0% ----------------------------------------------------------------------- run-improve50 [6] 100.0% [13] 328(0.9%) 0(0.0%) for-loop ...herbie/develop/src/mainloop.rkt:249:10 run-iter! [18] 100.0% ----------------------------------------------------------------------- loop [8] 100.0% [14] 11644(33.7%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:151:2 loop [20] 60.9% make-exacts* [19] 33.6% eval-prog [24] 5.5% ----------------------------------------------------------------------- setup-alt-simplified [11] 100.0% [15] 986(2.9%) 0(0.0%) simplify-alt ...s/herbie/develop/src/glue.rkt:76:0 ??? [36] 100.0% ----------------------------------------------------------------------- loop [8] 100.0% [16] 732(2.1%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:200:24 for-loop [21] 100.0% ----------------------------------------------------------------------- ??? [12] 100.0% [17] 360(1.0%) 360(1.0%) ??? ...lects/racket/contract/private/orc.rkt:83:14 ----------------------------------------------------------------------- for-loop [13] 100.0% [18] 328(0.9%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:215:0 localize-error [22] 100.0% ----------------------------------------------------------------------- loop [14] 21.4% loop [8] 78.6% [19] 18298(53.0%) 0(0.0%) make-exacts* ...erbie/develop/src/points.rkt:138:0 map [23] 51.3% loop [30] 46.3% eval-prog [24] 2.4% ----------------------------------------------------------------------- loop [8] 46.5% loop [14] 53.5% [20] 13254(38.4%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:141:4 map [23] 100.0% ----------------------------------------------------------------------- for-loop [16] 100.0% [21] 732(2.1%) 0(0.0%) for-loop ...s/herbie/develop/src/points.rkt:201:26 ??? [33] 100.0% ----------------------------------------------------------------------- run-iter! [18] 100.0% [22] 328(0.9%) 0(0.0%) localize-error ...velop/src/core/localize.rkt:47:0 hash-ref! [25] 100.0% ----------------------------------------------------------------------- f6 [26] 1.4% make-exacts* [19] 40.9% loop [20] 57.7% [23] 22966(66.5%) 0(0.0%) map ...acket/collects/racket/private/map.rkt:20:13 loop [30] 98.6% ??? [2] 1.4% ----------------------------------------------------------------------- make-exacts* [19] 40.7% loop [14] 59.3% [24] 1080(3.1%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:148:0 f6 [26] 68.5% hash-ref! [25] 31.5% ----------------------------------------------------------------------- localize-error [22] 16.4% eval-prog [24] 17.0% ??? [3] 32.7% loop [30] 33.9% [25] 668(1.9%) 0(0.0%) hash-ref! ...racket/private/more-scheme.rkt:373:13 ??? [29] 33.9% parse-loop12 [27] 32.7% bigfloat-hash [28] 17.0% f6 [26] 16.4% ----------------------------------------------------------------------- hash-ref! [25] 30.7% f6 [26] 34.6% eval-prog [24] 34.6% [26] 1068(3.1%) 0(0.0%) f6 ...et/collects/racket/match/compiler.rkt:507:40 f6 [26] 34.6% ??? [33] 34.6% map [23] 30.7% ----------------------------------------------------------------------- hash-ref! [25] 48.5% ??? [5] 51.5% [27] 676(2.0%) 348(1.0%) parse-loop12 ...s/racket/match/compiler.rkt:418:15 loop [30] 48.5% ----------------------------------------------------------------------- hash-ref! [25] 100.0% [28] 340(1.0%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:165:0 sig+exp->bigfloat [31] 100.0% ----------------------------------------------------------------------- hash-ref! [25] 100.0% [29] 340(1.0%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:183:5 loop [30] 100.0% ----------------------------------------------------------------------- parse-loop12 [27] 0.1% make-exacts* [19] 0.1% ??? [29] 1.1% map [23] 6.5% loop [30] 92.2% [30] 31464(91.1%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:25:19 loop [30] 92.2% ??? [2] 6.5% hash-ref! [25] 1.1% ??? [33] 0.1% ??? [3] 0.1% ??? [32] 0.0% ----------------------------------------------------------------------- bigfloat-hash [28] 100.0% [31] 340(1.0%) 340(1.0%) sig+exp->bigfloat ...ivate/bigfloat/mpfr.rkt:385:0 ----------------------------------------------------------------------- loop [30] 2.8% bf* [9] 19.0% ??? [5] 78.2% [32] 11784(34.1%) 3832(11.1%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfcos [35] 45.1% bfmul [37] 22.4% ----------------------------------------------------------------------- for-loop [21] 15.7% f6 [26] 15.8% loop [30] 68.5% [33] 4674(13.5%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:342:33 ??? [36] 84.2% ??? [34] 9.4% ??? [65] 6.4% ----------------------------------------------------------------------- ??? [33] 4.4% ??? [2] 95.6% [34] 10004(29.0%) 312(0.9%) ??? ...contract/private/../../private/kw.rkt:761:9 real->bigfloat [38] 96.9% ----------------------------------------------------------------------- ??? [32] 100.0% [35] 5318(15.4%) 2840(8.2%) bfcos ...-lib/math/private/bigfloat/mpfr.rkt:616:4 ??? [45] 46.6% ----------------------------------------------------------------------- simplify-alt [15] 9.5% ??? [36] 12.3% ??? [33] 75.4% [36] 5216(15.1%) 358(1.0%) ??? ...llects/racket/private/norm-define.rkt:53:83 return/no-unsupplied [39] 34.4% ??? [41] 13.3% ??? [36] 12.3% iterate-egraph!13 [40] 12.3% for-loop [42] 7.2% loop [43] 6.8% ??? [44] 6.8% ----------------------------------------------------------------------- ??? [32] 100.0% [37] 2634(7.6%) 1510(4.4%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:819:4 ??? [45] 42.7% ----------------------------------------------------------------------- ??? [34] 100.0% [38] 9692(28.1%) 8248(23.9%) real->bigfloat .../private/bigfloat/mpfr.rkt:451:0 ??? [45] 14.9% ----------------------------------------------------------------------- ??? [36] 100.0% [39] 1794(5.2%) 360(1.0%) return/no-unsupplied ...ct/private/arr-i.rkt:533:0 filter [46] 79.9% ----------------------------------------------------------------------- ??? [36] 100.0% [40] 1282(3.7%) 0(0.0%) iterate-egraph!13 ...p/src/core/simplify.rkt:102:0 one-iter [47] 100.0% ----------------------------------------------------------------------- ??? [36] 100.0% [41] 696(2.0%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:60:15 ??? [45] 100.0% ----------------------------------------------------------------------- ??? [36] 100.0% [42] 378(1.1%) 378(1.1%) for-loop ...ies/herbie/develop/src/points.rkt:47:4 ----------------------------------------------------------------------- ??? [36] 100.0% [43] 354(1.0%) 0(0.0%) loop ...ghtlies/herbie/develop/src/points.rkt:66:6 random-exp [48] 100.0% ----------------------------------------------------------------------- ??? [36] 100.0% [44] 354(1.0%) 0(0.0%) ??? ...racket/collects/racket/private/kw.rkt:761:9 ??? [49] 100.0% ----------------------------------------------------------------------- ??? [41] 12.1% bfmul [37] 19.6% real->bigfloat [38] 25.1% bfcos [35] 43.2% [45] 5742(16.6%) 5742(16.6%) ??? .../share/racket/collects/ffi/unsafe.rkt:861:4 ----------------------------------------------------------------------- return/no-unsupplied [39] 100.0% [46] 1434(4.2%) 1434(4.2%) filter ...t/collects/racket/private/list.rkt:256:2 ----------------------------------------------------------------------- iterate-egraph!13 [40] 100.0% [47] 1282(3.7%) 0(0.0%) one-iter ...ie/develop/src/core/simplify.rkt:113:0 loop [50] 77.2% apply-match [51] 22.8% ----------------------------------------------------------------------- loop [43] 100.0% [48] 354(1.0%) 354(1.0%) random-exp .../herbie/develop/src/common.rkt:251:0 ----------------------------------------------------------------------- ??? [44] 100.0% [49] 354(1.0%) 354(1.0%) ??? ...s/racket/contract/private/arr-i.rkt:1233:27 ----------------------------------------------------------------------- one-iter [47] 100.0% [50] 990(2.9%) 0(0.0%) loop ...cket/collects/racket/private/map.rkt:52:19 apply-match [51] 100.0% ----------------------------------------------------------------------- one-iter [47] 22.8% loop [50] 77.2% [51] 1282(3.7%) 0(0.0%) apply-match ...develop/src/core/simplify.rkt:130:2 for-loop [52] 77.2% update-leader! [55] 22.8% ----------------------------------------------------------------------- apply-match [51] 100.0% [52] 990(2.9%) 0(0.0%) for-loop ...e/develop/src/core/simplify.rkt:145:10 mk-enode! [53] 63.6% merge-egraph-nodes! [54] 36.4% ----------------------------------------------------------------------- for-loop [52] 100.0% [53] 630(1.8%) 0(0.0%) mk-enode! ...bie/develop/src/core/egraph.rkt:101:0 new-enode [56] 100.0% ----------------------------------------------------------------------- for-loop [52] 100.0% [54] 360(1.0%) 0(0.0%) merge-egraph-nodes! ...p/src/core/egraph.rkt:152:0 update-leader! [55] 100.0% ----------------------------------------------------------------------- apply-match [51] 44.8% merge-egraph-nodes! [54] 55.2% [55] 652(1.9%) 360(1.0%) update-leader! ...evelop/src/core/egraph.rkt:217:0 for-loop [58] 44.8% ----------------------------------------------------------------------- mk-enode! [53] 100.0% [56] 630(1.8%) 0(0.0%) new-enode ...erbie/develop/src/core/enode.rkt:97:0 type-of-enode-expr [57] 100.0% ----------------------------------------------------------------------- new-enode [56] 100.0% [57] 630(1.8%) 0(0.0%) type-of-enode-expr ...elop/src/core/enode.rkt:68:0 get-sigs [59] 100.0% ----------------------------------------------------------------------- update-leader! [55] 100.0% [58] 292(0.8%) 292(0.8%) for-loop ...rbie/develop/src/core/egraph.rkt:222:6 ----------------------------------------------------------------------- type-of-enode-expr [57] 100.0% [59] 630(1.8%) 0(0.0%) get-sigs .../herbie/develop/src/type-check.rkt:5:0 ??? [60] 53.0% ...velop/src/common.rkt:47:2 [61] 47.0% ----------------------------------------------------------------------- get-sigs [59] 100.0% [60] 334(1.0%) 0(0.0%) ??? ...ts/racket/contract/private/arr-i.rkt:804:10 for-loop [62] 100.0% ----------------------------------------------------------------------- get-sigs [59] 100.0% [61] 296(0.9%) 0(0.0%) ...velop/src/common.rkt:47:2 ...e/arr-i.rkt:906:19 ??? [63] 100.0% ----------------------------------------------------------------------- ??? [60] 100.0% [62] 334(1.0%) 0(0.0%) for-loop ...racket/contract/private/hash.rkt:239:6 ??? [64] 100.0% ----------------------------------------------------------------------- ...velop/src/common.rkt:47:2 [61]100.0% [63] 296(0.9%) 296(0.9%) ??? ...s/racket/contract/private/arr-i.rkt:1268:39 ----------------------------------------------------------------------- for-loop [62] 47.0% ...higher-order.rkt:346:33 [10] 53.0% [64] 710(2.1%) 0(0.0%) ??? ...cts/racket/contract/private/list.rkt:187:10 ??? [65] 53.0% ??? [66] 47.0% ----------------------------------------------------------------------- ??? [33] 44.4% ??? [64] 55.6% [65] 676(2.0%) 376(1.1%) ??? ...ects/racket/contract/private/guts.rkt:644:8 ??? [67] 44.4% ----------------------------------------------------------------------- ??? [64] 100.0% [66] 334(1.0%) 334(1.0%) ??? ...ects/racket/contract/private/list.rkt:686:7 ----------------------------------------------------------------------- ??? [65] 100.0% [67] 300(0.9%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:357:18 hash-has-key? [68] 100.0% ----------------------------------------------------------------------- ??? [67] 100.0% [68] 300(0.9%) 0(0.0%) hash-has-key? ...et/private/more-scheme.rkt:368:13 ??? [69] 100.0% ----------------------------------------------------------------------- hash-has-key? [68] 100.0% [69] 300(0.9%) 0(0.0%) ??? ...ects/racket/contract/private/list.rkt:737:4 for-loop [70] 100.0% ----------------------------------------------------------------------- ??? [69] 100.0% [70] 300(0.9%) 300(0.9%) for-loop ...acket/contract/private/list.rkt:743:12 -----------------------------------------------------------------------